builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1465215614.73 results: success (0) buildid: 20160606023017 builduid: 50c16143107247e9b93adb79d5a30ca1 revision: a48604c3b4956734c5cae80d350f7890eb9d4aa2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.731097) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.731588) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.731926) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.758306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.758592) ========= 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=af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 05:20:15-- 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% 50.4M=0s 2016-06-06 05:20:15 (50.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135644 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.911745) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.912397) ========= 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=af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016777 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.963533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 05:20:14.963897) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a48604c3b4956734c5cae80d350f7890eb9d4aa2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a48604c3b4956734c5cae80d350f7890eb9d4aa2 --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=af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 05:20:15,854 truncating revision to first 12 chars 2016-06-06 05:20:15,854 Setting DEBUG logging. 2016-06-06 05:20:15,854 attempt 1/10 2016-06-06 05:20:15,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a48604c3b495?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 05:20:17,234 unpacking tar archive at: fx-team-a48604c3b495/testing/mozharness/ program finished with exit code 0 elapsedTime=1.698999 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 05:20:16.677132) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:16.677499) ========= script_repo_revision: a48604c3b4956734c5cae80d350f7890eb9d4aa2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:16.677982) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:16.678287) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:16.689611) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-06 05:20:16.690006) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:20:17 INFO - MultiFileLogger online at 20160606 05:20:17 in /builds/slave/test 05:20:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:20:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:20:17 INFO - {'append_to_log': False, 05:20:17 INFO - 'base_work_dir': '/builds/slave/test', 05:20:17 INFO - 'blob_upload_branch': 'Fx-Team', 05:20:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:20:17 INFO - 'branch': 'Fx-Team', 05:20:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:20:17 INFO - 'config_files': ('talos/linux_config.py',), 05:20:17 INFO - 'default_actions': ('clobber', 05:20:17 INFO - 'read-buildbot-config', 05:20:17 INFO - 'download-and-extract', 05:20:17 INFO - 'populate-webroot', 05:20:17 INFO - 'create-virtualenv', 05:20:17 INFO - 'install', 05:20:17 INFO - 'run-tests'), 05:20:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:20:17 INFO - 'download_minidump_stackwalk': True, 05:20:17 INFO - 'download_symbols': 'ondemand', 05:20:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:20:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:20:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:20:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:20:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:20:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:20:17 INFO - 'installer_path': 'installer.exe', 05:20:17 INFO - 'log_level': 'info', 05:20:17 INFO - 'log_name': 'talos', 05:20:17 INFO - 'log_to_console': True, 05:20:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:20:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:20:17 INFO - 'opt_config_files': (), 05:20:17 INFO - 'pip_index': False, 05:20:17 INFO - 'sps_profile': False, 05:20:17 INFO - 'sps_profile_interval': 0, 05:20:17 INFO - 'suite': 'dromaeojs-e10s', 05:20:17 INFO - 'system_bits': '32', 05:20:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:20:17 INFO - 'title': 'talos-linux64-ix-020', 05:20:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:20:17 INFO - 'use_talos_json': True, 05:20:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:20:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:20:17 INFO - 'work_dir': 'build'} 05:20:17 INFO - ##### 05:20:17 INFO - ##### Running clobber step. 05:20:17 INFO - ##### 05:20:17 INFO - Running pre-action listener: _resource_record_pre_action 05:20:17 INFO - Running main action method: clobber 05:20:17 INFO - rmtree: /builds/slave/test/build 05:20:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:20:18 INFO - Running post-action listener: _resource_record_post_action 05:20:18 INFO - ##### 05:20:18 INFO - ##### Finished clobber step (success) 05:20:18 INFO - ##### 05:20:18 INFO - ##### 05:20:18 INFO - ##### Running read-buildbot-config step. 05:20:18 INFO - ##### 05:20:18 INFO - Running pre-action listener: _resource_record_pre_action 05:20:18 INFO - Running main action method: read_buildbot_config 05:20:18 INFO - Using buildbot properties: 05:20:18 INFO - { 05:20:18 INFO - "project": "", 05:20:18 INFO - "product": "firefox", 05:20:18 INFO - "script_repo_revision": "production", 05:20:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:20:18 INFO - "repository": "", 05:20:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:20:18 INFO - "buildid": "20160606023017", 05:20:18 INFO - "pgo_build": "True", 05:20:18 INFO - "basedir": "/builds/slave/test", 05:20:18 INFO - "buildnumber": 812, 05:20:18 INFO - "slavename": "talos-linux64-ix-020", 05:20:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:20:18 INFO - "platform": "ubuntu64_hw", 05:20:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:20:18 INFO - "branch": "fx-team", 05:20:18 INFO - "repo_path": "integration/fx-team", 05:20:18 INFO - "revision": "a48604c3b4956734c5cae80d350f7890eb9d4aa2", 05:20:18 INFO - "stage_platform": "linux64-pgo", 05:20:18 INFO - "builduid": "50c16143107247e9b93adb79d5a30ca1", 05:20:18 INFO - "slavebuilddir": "test" 05:20:18 INFO - } 05:20:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:20:18 INFO - Running post-action listener: _resource_record_post_action 05:20:18 INFO - ##### 05:20:18 INFO - ##### Finished read-buildbot-config step (success) 05:20:18 INFO - ##### 05:20:18 INFO - ##### 05:20:18 INFO - ##### Running download-and-extract step. 05:20:18 INFO - ##### 05:20:18 INFO - Running pre-action listener: _resource_record_pre_action 05:20:18 INFO - Running main action method: download_and_extract 05:20:18 INFO - mkdir: /builds/slave/test/build/tests 05:20:18 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')]} 05:20:18 INFO - https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:20:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:20:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:20:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:20:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:20:19 INFO - Downloaded 1361 bytes. 05:20:19 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:20:19 INFO - Using the following test package requirements: 05:20:19 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:19 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:20:19 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:20:19 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:19 INFO - u'jsshell-linux-x86_64.zip'], 05:20:19 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:20:19 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:19 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:20:19 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:20:19 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:20:19 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:20:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:20: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')]} 05:20:19 INFO - https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:20:21 INFO - Downloaded 24440907 bytes. 05:20:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:20:22 INFO - Return code: 0 05:20:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:22 INFO - https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:20:25 INFO - Downloaded 24440907 bytes. 05:20:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:20:26 INFO - Return code: 0 05:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:26 INFO - https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:20:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:20:27 INFO - Downloaded 10833369 bytes. 05:20:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:20:28 INFO - Return code: 0 05:20: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')]} 05:20:28 INFO - https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:20:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:20:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:20:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:20:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:20:29 INFO - Downloaded 59189488 bytes. 05:20:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:20:29 INFO - mkdir: /builds/slave/test/properties 05:20:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:20:29 INFO - Writing to file /builds/slave/test/properties/build_url 05:20:29 INFO - Contents: 05:20:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:20:30 INFO - Running post-action listener: _resource_record_post_action 05:20:30 INFO - Running post-action listener: set_extra_try_arguments 05:20:30 INFO - ##### 05:20:30 INFO - ##### Finished download-and-extract step (success) 05:20:30 INFO - ##### 05:20:30 INFO - ##### 05:20:30 INFO - ##### Running populate-webroot step. 05:20:30 INFO - ##### 05:20:30 INFO - Running pre-action listener: _resource_record_pre_action 05:20:30 INFO - Running main action method: populate_webroot 05:20:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:20:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:20:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:20:30 INFO - '--tppagecycles', 05:20:30 INFO - '7'], 05:20:30 INFO - 'tests': ['tsvgm']}}, 05:20:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:20:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:20:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:20:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:20:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:20:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:20:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:30 INFO - 'talos_options': ['--disable-e10s'], 05:20:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:30 INFO - 'talos_options': ['--disable-e10s'], 05:20:30 INFO - 'tests': ['damp', 'tps']}, 05:20:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:30 INFO - 'tests': ['damp', 'tps']}, 05:20:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:20:30 INFO - 'tests': ['dromaeo_dom']}, 05:20:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:20:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:20:30 INFO - 'tests': ['a11yr', 05:20:30 INFO - 'ts_paint', 05:20:30 INFO - 'tpaint', 05:20:30 INFO - 'sessionrestore', 05:20:30 INFO - 'sessionrestore_no_auto_restore', 05:20:30 INFO - 'tabpaint']}, 05:20:30 INFO - 'other-e10s': {'tests': ['a11yr', 05:20:30 INFO - 'ts_paint', 05:20:30 INFO - 'tpaint', 05:20:30 INFO - 'sessionrestore', 05:20:30 INFO - 'sessionrestore_no_auto_restore', 05:20:30 INFO - 'tabpaint']}, 05:20:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:20:30 INFO - 'ts_paint', 05:20:30 INFO - 'tpaint', 05:20:30 INFO - 'sessionrestore', 05:20:30 INFO - 'sessionrestore_no_auto_restore', 05:20:30 INFO - 'tabpaint']}, 05:20:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:20:30 INFO - 'ts_paint', 05:20:30 INFO - 'tpaint', 05:20:30 INFO - 'sessionrestore', 05:20:30 INFO - 'sessionrestore_no_auto_restore', 05:20:30 INFO - 'tabpaint']}, 05:20:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:20:30 INFO - 'tests': ['a11yr', 05:20:30 INFO - 'ts_paint', 05:20:30 INFO - 'tpaint', 05:20:30 INFO - 'sessionrestore', 05:20:30 INFO - 'sessionrestore_no_auto_restore', 05:20:30 INFO - 'tabpaint']}, 05:20:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:20:30 INFO - 'tests': ['a11yr', 05:20:30 INFO - 'ts_paint', 05:20:30 INFO - 'tpaint', 05:20:30 INFO - 'sessionrestore', 05:20:30 INFO - 'sessionrestore_no_auto_restore', 05:20:30 INFO - 'tabpaint']}, 05:20:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:20:30 INFO - 'tests': ['tsvgx', 05:20:30 INFO - 'tsvgr_opacity', 05:20:30 INFO - 'tart', 05:20:30 INFO - 'tscrollx', 05:20:30 INFO - 'cart']}, 05:20:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:20:30 INFO - 'tsvgr_opacity', 05:20:30 INFO - 'tart', 05:20:30 INFO - 'tscrollx', 05:20:30 INFO - 'cart']}, 05:20:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:30 INFO - 'talos_options': ['--disable-e10s'], 05:20:30 INFO - 'tests': ['tp5o']}, 05:20:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:30 INFO - 'tests': ['tp5o']}, 05:20:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:30 INFO - 'talos_options': ['--disable-e10s', 05:20:30 INFO - '--xperf_path', 05:20:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:30 INFO - 'tests': ['tp5n']}, 05:20:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:30 INFO - 'talos_options': ['--xperf_path', 05:20:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:30 INFO - 'tests': ['tp5n']}}, 05:20:30 INFO - 'talos.zip': {'path': '', 05:20:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:20:30 INFO - Running post-action listener: _resource_record_post_action 05:20:30 INFO - ##### 05:20:30 INFO - ##### Finished populate-webroot step (success) 05:20:30 INFO - ##### 05:20:30 INFO - ##### 05:20:30 INFO - ##### Running create-virtualenv step. 05:20:30 INFO - ##### 05:20:30 INFO - Running pre-action listener: _resource_record_pre_action 05:20:30 INFO - Running main action method: create_virtualenv 05:20:30 INFO - Creating virtualenv /builds/slave/test/build/venv 05:20:30 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 05:20:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:20:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:20:30 INFO - Using real prefix '/usr' 05:20:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:20:31 INFO - Installing distribute.............................................................................................................................................................................................done. 05:20:33 INFO - Installing pip.................done. 05:20:33 INFO - Return code: 0 05:20:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1cd34d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae1c0>, '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 0x10af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', '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 05:20: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', 'pip>=1.5'] in /builds/slave/test/build 05:20: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 pip>=1.5 05:20:33 INFO - Using env: {'DISPLAY': ':0', 05:20:33 INFO - 'HOME': '/home/cltbld', 05:20:33 INFO - 'LANG': 'en_US.UTF-8', 05:20:33 INFO - 'LANGUAGE': 'en_US:en', 05:20:33 INFO - 'LOGNAME': 'cltbld', 05:20:33 INFO - 'MAIL': '/var/mail/cltbld', 05:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:33 INFO - 'MOZ_NO_REMOTE': '1', 05:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:33 INFO - 'NO_EM_RESTART': '1', 05:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:33 INFO - 'PWD': '/builds/slave/test', 05:20:33 INFO - 'SHELL': '/bin/bash', 05:20:33 INFO - 'SHLVL': '1', 05:20:33 INFO - 'TERM': 'linux', 05:20:33 INFO - 'TMOUT': '86400', 05:20:33 INFO - 'USER': 'cltbld', 05:20:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', 05:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:33 INFO - '_': '/tools/buildbot/bin/python'} 05:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:33 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 05:20:33 INFO - Cleaning up... 05:20:33 INFO - Return code: 0 05:20:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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', '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 0x7f1cd34d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae1c0>, '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 0x10af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', '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 05:20: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:20: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 psutil>=3.1.1 05:20:33 INFO - Using env: {'DISPLAY': ':0', 05:20:33 INFO - 'HOME': '/home/cltbld', 05:20:33 INFO - 'LANG': 'en_US.UTF-8', 05:20:33 INFO - 'LANGUAGE': 'en_US:en', 05:20:33 INFO - 'LOGNAME': 'cltbld', 05:20:33 INFO - 'MAIL': '/var/mail/cltbld', 05:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:33 INFO - 'MOZ_NO_REMOTE': '1', 05:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:33 INFO - 'NO_EM_RESTART': '1', 05:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:33 INFO - 'PWD': '/builds/slave/test', 05:20:33 INFO - 'SHELL': '/bin/bash', 05:20:33 INFO - 'SHLVL': '1', 05:20:33 INFO - 'TERM': 'linux', 05:20:33 INFO - 'TMOUT': '86400', 05:20:33 INFO - 'USER': 'cltbld', 05:20:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', 05:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:33 INFO - '_': '/tools/buildbot/bin/python'} 05:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:33 INFO - Downloading/unpacking psutil>=3.1.1 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:20:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:35 INFO - Installing collected packages: psutil 05:20:35 INFO - Running setup.py install for psutil 05:20:35 INFO - building 'psutil._psutil_linux' extension 05:20:35 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 05:20:36 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 05:20:36 INFO - building 'psutil._psutil_posix' extension 05:20:36 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 05:20:36 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 05:20:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:36 INFO - Successfully installed psutil 05:20:36 INFO - Cleaning up... 05:20:36 INFO - Return code: 0 05:20:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:36 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 0x7f1cd34d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae1c0>, '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 0x10af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', '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 05:20:36 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 05:20:36 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 05:20:36 INFO - Using env: {'DISPLAY': ':0', 05:20:36 INFO - 'HOME': '/home/cltbld', 05:20:36 INFO - 'LANG': 'en_US.UTF-8', 05:20:36 INFO - 'LANGUAGE': 'en_US:en', 05:20:36 INFO - 'LOGNAME': 'cltbld', 05:20:36 INFO - 'MAIL': '/var/mail/cltbld', 05:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:36 INFO - 'MOZ_NO_REMOTE': '1', 05:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:36 INFO - 'NO_EM_RESTART': '1', 05:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:36 INFO - 'PWD': '/builds/slave/test', 05:20:36 INFO - 'SHELL': '/bin/bash', 05:20:36 INFO - 'SHLVL': '1', 05:20:36 INFO - 'TERM': 'linux', 05:20:36 INFO - 'TMOUT': '86400', 05:20:36 INFO - 'USER': 'cltbld', 05:20:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', 05:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:36 INFO - '_': '/tools/buildbot/bin/python'} 05:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:20:38 INFO - Installing collected packages: mozsystemmonitor 05:20:38 INFO - Running setup.py install for mozsystemmonitor 05:20:38 INFO - Successfully installed mozsystemmonitor 05:20:38 INFO - Cleaning up... 05:20:38 INFO - Return code: 0 05:20:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:38 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 0x7f1cd34d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae1c0>, '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 0x10af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', '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 05:20:38 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 05:20:38 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 05:20:38 INFO - Using env: {'DISPLAY': ':0', 05:20:38 INFO - 'HOME': '/home/cltbld', 05:20:38 INFO - 'LANG': 'en_US.UTF-8', 05:20:38 INFO - 'LANGUAGE': 'en_US:en', 05:20:38 INFO - 'LOGNAME': 'cltbld', 05:20:38 INFO - 'MAIL': '/var/mail/cltbld', 05:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:38 INFO - 'MOZ_NO_REMOTE': '1', 05:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:38 INFO - 'NO_EM_RESTART': '1', 05:20:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:38 INFO - 'PWD': '/builds/slave/test', 05:20:38 INFO - 'SHELL': '/bin/bash', 05:20:38 INFO - 'SHLVL': '1', 05:20:38 INFO - 'TERM': 'linux', 05:20:38 INFO - 'TMOUT': '86400', 05:20:38 INFO - 'USER': 'cltbld', 05:20:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', 05:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:38 INFO - '_': '/tools/buildbot/bin/python'} 05:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:38 INFO - Downloading/unpacking jsonschema==2.5.1 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:20:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:20:40 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 05:20:40 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 05:20:40 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 05:20:40 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 05:20:40 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 05:20:40 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 05:20:40 INFO - Downloading functools32-3.2.3-2.tar.gz 05:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:20:40 INFO - warning: no files found matching '*.txt' 05:20:40 INFO - no previously-included directories found matching 'build' 05:20:40 INFO - no previously-included directories found matching 'dist' 05:20:40 INFO - no previously-included directories found matching '.git*' 05:20:40 INFO - Installing collected packages: jsonschema, functools32 05:20:41 INFO - Running setup.py install for functools32 05:20:41 INFO - warning: no files found matching '*.txt' 05:20:41 INFO - no previously-included directories found matching 'build' 05:20:41 INFO - no previously-included directories found matching 'dist' 05:20:41 INFO - no previously-included directories found matching '.git*' 05:20:41 INFO - Successfully installed jsonschema functools32 05:20:41 INFO - Cleaning up... 05:20:41 INFO - Return code: 0 05:20:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1cd34d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae1c0>, '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 0x10af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', '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 05:20:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:20:41 INFO - Using env: {'DISPLAY': ':0', 05:20:41 INFO - 'HOME': '/home/cltbld', 05:20:41 INFO - 'LANG': 'en_US.UTF-8', 05:20:41 INFO - 'LANGUAGE': 'en_US:en', 05:20:41 INFO - 'LOGNAME': 'cltbld', 05:20:41 INFO - 'MAIL': '/var/mail/cltbld', 05:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:41 INFO - 'MOZ_NO_REMOTE': '1', 05:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:41 INFO - 'NO_EM_RESTART': '1', 05:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:41 INFO - 'PWD': '/builds/slave/test', 05:20:41 INFO - 'SHELL': '/bin/bash', 05:20:41 INFO - 'SHLVL': '1', 05:20:41 INFO - 'TERM': 'linux', 05:20:41 INFO - 'TMOUT': '86400', 05:20:41 INFO - 'USER': 'cltbld', 05:20:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', 05:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:41 INFO - '_': '/tools/buildbot/bin/python'} 05:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:41 INFO - Downloading/unpacking blobuploader==1.2.4 05:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:20:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:20:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:44 INFO - Downloading docopt-0.6.1.tar.gz 05:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:20:45 INFO - Installing collected packages: blobuploader, requests, docopt 05:20:45 INFO - Running setup.py install for blobuploader 05:20:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:20:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:20:45 INFO - Running setup.py install for requests 05:20:45 INFO - Running setup.py install for docopt 05:20:45 INFO - Successfully installed blobuploader requests docopt 05:20:45 INFO - Cleaning up... 05:20:45 INFO - Return code: 0 05:20:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:45 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 0x7f1cd34d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae1c0>, '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 0x10af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', '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 05:20:45 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 05:20:45 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 05:20:45 INFO - Using env: {'DISPLAY': ':0', 05:20:45 INFO - 'HOME': '/home/cltbld', 05:20:45 INFO - 'LANG': 'en_US.UTF-8', 05:20:45 INFO - 'LANGUAGE': 'en_US:en', 05:20:45 INFO - 'LOGNAME': 'cltbld', 05:20:45 INFO - 'MAIL': '/var/mail/cltbld', 05:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:45 INFO - 'MOZ_NO_REMOTE': '1', 05:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:45 INFO - 'NO_EM_RESTART': '1', 05:20:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:45 INFO - 'PWD': '/builds/slave/test', 05:20:45 INFO - 'SHELL': '/bin/bash', 05:20:45 INFO - 'SHLVL': '1', 05:20:45 INFO - 'TERM': 'linux', 05:20:45 INFO - 'TMOUT': '86400', 05:20:45 INFO - 'USER': 'cltbld', 05:20:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', 05:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:45 INFO - '_': '/tools/buildbot/bin/python'} 05:20:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:45 INFO - Running setup.py (path:/tmp/pip-Wu26pX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:45 INFO - Running setup.py (path:/tmp/pip-hLyl1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:46 INFO - Running setup.py (path:/tmp/pip-gn5Tj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:46 INFO - Running setup.py (path:/tmp/pip-jO0kt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:46 INFO - Running setup.py (path:/tmp/pip-7gu8Vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:46 INFO - Running setup.py (path:/tmp/pip-S7uglK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:46 INFO - Running setup.py (path:/tmp/pip-R6jfQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:46 INFO - Running setup.py (path:/tmp/pip-QTrMaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:46 INFO - Running setup.py (path:/tmp/pip-TV0ukP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:46 INFO - Running setup.py (path:/tmp/pip-BC9tsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:46 INFO - Running setup.py (path:/tmp/pip-wTnq8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:46 INFO - Running setup.py (path:/tmp/pip-Gle_nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:46 INFO - Running setup.py (path:/tmp/pip-C1zrTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:46 INFO - Running setup.py (path:/tmp/pip-9RToPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:46 INFO - Running setup.py (path:/tmp/pip-0IccSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:46 INFO - Running setup.py (path:/tmp/pip-oS7tw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:47 INFO - Running setup.py (path:/tmp/pip-XZ63L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:20:47 INFO - Running setup.py install for manifestparser 05:20:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:20:47 INFO - Running setup.py install for mozcrash 05:20:47 INFO - Running setup.py install for mozdebug 05:20:47 INFO - Running setup.py install for mozdevice 05:20:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:20:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:20:47 INFO - Running setup.py install for mozfile 05:20:47 INFO - Running setup.py install for mozhttpd 05:20:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:20:47 INFO - Running setup.py install for mozinfo 05:20:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:20:47 INFO - Running setup.py install for mozInstall 05:20:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:20:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:20:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:20:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:20:47 INFO - Running setup.py install for mozleak 05:20:47 INFO - Running setup.py install for mozlog 05:20:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Running setup.py install for moznetwork 05:20:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Running setup.py install for mozprocess 05:20:48 INFO - Running setup.py install for mozprofile 05:20:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Running setup.py install for mozrunner 05:20:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Running setup.py install for mozscreenshot 05:20:48 INFO - Running setup.py install for moztest 05:20:48 INFO - Running setup.py install for mozversion 05:20:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:20:48 INFO - Cleaning up... 05:20:48 INFO - Return code: 0 05:20:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:48 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 0x7f1cd34d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae1c0>, '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 0x10af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', '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 05:20:48 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 05:20:48 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 05:20:48 INFO - Using env: {'DISPLAY': ':0', 05:20:48 INFO - 'HOME': '/home/cltbld', 05:20:48 INFO - 'LANG': 'en_US.UTF-8', 05:20:48 INFO - 'LANGUAGE': 'en_US:en', 05:20:48 INFO - 'LOGNAME': 'cltbld', 05:20:48 INFO - 'MAIL': '/var/mail/cltbld', 05:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:48 INFO - 'MOZ_NO_REMOTE': '1', 05:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:48 INFO - 'NO_EM_RESTART': '1', 05:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:48 INFO - 'PWD': '/builds/slave/test', 05:20:48 INFO - 'SHELL': '/bin/bash', 05:20:48 INFO - 'SHLVL': '1', 05:20:48 INFO - 'TERM': 'linux', 05:20:48 INFO - 'TMOUT': '86400', 05:20:48 INFO - 'USER': 'cltbld', 05:20:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', 05:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:48 INFO - '_': '/tools/buildbot/bin/python'} 05:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:49 INFO - Running setup.py (path:/tmp/pip-Enkyrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:49 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)) 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:49 INFO - Running setup.py (path:/tmp/pip-n69ka_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:49 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)) 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:49 INFO - Running setup.py (path:/tmp/pip-Gr1DxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:49 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)) 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:49 INFO - Running setup.py (path:/tmp/pip-1es5sU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:49 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)) 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:49 INFO - Running setup.py (path:/tmp/pip-_RM4jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:49 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)) 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:49 INFO - Running setup.py (path:/tmp/pip-mJfLSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:49 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)) 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:49 INFO - Running setup.py (path:/tmp/pip-aAIEvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:49 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)) 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:49 INFO - Running setup.py (path:/tmp/pip-rCKzSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:49 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)) 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:49 INFO - Running setup.py (path:/tmp/pip-gXx3_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:49 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)) 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:49 INFO - Running setup.py (path:/tmp/pip-3HjmfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:49 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)) 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:49 INFO - Running setup.py (path:/tmp/pip-1Cs4Kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:49 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)) 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:49 INFO - Running setup.py (path:/tmp/pip-D4L3Ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:49 INFO - Running setup.py (path:/tmp/pip-hTy0xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:50 INFO - Running setup.py (path:/tmp/pip-IIFmuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:50 INFO - Running setup.py (path:/tmp/pip-_gmnH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:50 INFO - Running setup.py (path:/tmp/pip-Bal4o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:50 INFO - Running setup.py (path:/tmp/pip-3ezTnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:50 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)) 05:20:50 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)) 05:20:50 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)) 05:20:50 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)) 05:20:50 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)) 05:20:50 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)) 05:20:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:53 INFO - Downloading blessings-1.6.tar.gz 05:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:20:53 INFO - Installing collected packages: blessings 05:20:53 INFO - Running setup.py install for blessings 05:20:53 INFO - Successfully installed blessings 05:20:53 INFO - Cleaning up... 05:20:53 INFO - Return code: 0 05:20:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:20:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:53 INFO - Reading from file tmpfile_stdout 05:20:53 INFO - Current package versions: 05:20:53 INFO - argparse == 1.2.1 05:20:53 INFO - blessings == 1.6 05:20:53 INFO - blobuploader == 1.2.4 05:20:53 INFO - docopt == 0.6.1 05:20:53 INFO - functools32 == 3.2.3-2 05:20:53 INFO - jsonschema == 2.5.1 05:20:53 INFO - manifestparser == 1.1 05:20:53 INFO - mozInstall == 1.12 05:20:53 INFO - mozcrash == 0.17 05:20:53 INFO - mozdebug == 0.1 05:20:53 INFO - mozdevice == 0.48 05:20:53 INFO - mozfile == 1.2 05:20:53 INFO - mozhttpd == 0.7 05:20:53 INFO - mozinfo == 0.9 05:20:53 INFO - mozleak == 0.1 05:20:53 INFO - mozlog == 3.2 05:20:53 INFO - moznetwork == 0.27 05:20:53 INFO - mozprocess == 0.22 05:20:53 INFO - mozprofile == 0.28 05:20:53 INFO - mozrunner == 6.11 05:20:53 INFO - mozscreenshot == 0.1 05:20:53 INFO - mozsystemmonitor == 0.3 05:20:53 INFO - moztest == 0.7 05:20:53 INFO - mozversion == 1.4 05:20:53 INFO - psutil == 3.1.1 05:20:53 INFO - requests == 1.2.3 05:20:53 INFO - wsgiref == 0.1.2 05:20:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:53 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 0x7f1cd34d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae1c0>, '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 0x10af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', '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 05:20:53 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 05:20:53 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 05:20:53 INFO - Using env: {'DISPLAY': ':0', 05:20:53 INFO - 'HOME': '/home/cltbld', 05:20:53 INFO - 'LANG': 'en_US.UTF-8', 05:20:53 INFO - 'LANGUAGE': 'en_US:en', 05:20:53 INFO - 'LOGNAME': 'cltbld', 05:20:53 INFO - 'MAIL': '/var/mail/cltbld', 05:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:53 INFO - 'MOZ_NO_REMOTE': '1', 05:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:53 INFO - 'NO_EM_RESTART': '1', 05:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:53 INFO - 'PWD': '/builds/slave/test', 05:20:53 INFO - 'SHELL': '/bin/bash', 05:20:53 INFO - 'SHLVL': '1', 05:20:53 INFO - 'TERM': 'linux', 05:20:53 INFO - 'TMOUT': '86400', 05:20:53 INFO - 'USER': 'cltbld', 05:20:53 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', 05:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:53 INFO - '_': '/tools/buildbot/bin/python'} 05:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 INFO - Cleaning up... 05:20:53 INFO - Return code: 0 05:20:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:53 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 0x7f1cd34d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae1c0>, '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 0x10af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', '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 05:20:53 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 05:20:53 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 05:20:53 INFO - Using env: {'DISPLAY': ':0', 05:20:53 INFO - 'HOME': '/home/cltbld', 05:20:53 INFO - 'LANG': 'en_US.UTF-8', 05:20:53 INFO - 'LANGUAGE': 'en_US:en', 05:20:53 INFO - 'LOGNAME': 'cltbld', 05:20:53 INFO - 'MAIL': '/var/mail/cltbld', 05:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:53 INFO - 'MOZ_NO_REMOTE': '1', 05:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:53 INFO - 'NO_EM_RESTART': '1', 05:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:53 INFO - 'PWD': '/builds/slave/test', 05:20:53 INFO - 'SHELL': '/bin/bash', 05:20:53 INFO - 'SHLVL': '1', 05:20:53 INFO - 'TERM': 'linux', 05:20:53 INFO - 'TMOUT': '86400', 05:20:53 INFO - 'USER': 'cltbld', 05:20:53 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', 05:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:53 INFO - '_': '/tools/buildbot/bin/python'} 05:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:20:54 INFO - Cleaning up... 05:20:54 INFO - Return code: 0 05:20:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:20:54 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')]} 05:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:54 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')]} 05:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:54 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 0x7f1cd34d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae1c0>, '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 0x10af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', '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 05:20:54 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 05:20:54 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 05:20:54 INFO - Using env: {'DISPLAY': ':0', 05:20:54 INFO - 'HOME': '/home/cltbld', 05:20:54 INFO - 'LANG': 'en_US.UTF-8', 05:20:54 INFO - 'LANGUAGE': 'en_US:en', 05:20:54 INFO - 'LOGNAME': 'cltbld', 05:20:54 INFO - 'MAIL': '/var/mail/cltbld', 05:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:54 INFO - 'MOZ_NO_REMOTE': '1', 05:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:54 INFO - 'NO_EM_RESTART': '1', 05:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:54 INFO - 'PWD': '/builds/slave/test', 05:20:54 INFO - 'SHELL': '/bin/bash', 05:20:54 INFO - 'SHLVL': '1', 05:20:54 INFO - 'TERM': 'linux', 05:20:54 INFO - 'TMOUT': '86400', 05:20:54 INFO - 'USER': 'cltbld', 05:20:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', 05:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:54 INFO - '_': '/tools/buildbot/bin/python'} 05:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:54 INFO - Downloading/unpacking flake8 05:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:20:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:20:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:20:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:20:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:20:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:20:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:20:56 INFO - no previously-included directories found matching 'docs/_build' 05:20:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:20:57 INFO - Running setup.py install for pep8 05:20:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:20:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:20:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:20:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:20:57 INFO - no previously-included directories found matching 'docs/_build' 05:20:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:20:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:20:57 INFO - Cleaning up... 05:20:57 INFO - Return code: 0 05:20:57 INFO - Running post-action listener: _resource_record_post_action 05:20:57 INFO - Running post-action listener: _start_resource_monitoring 05:20:57 INFO - Starting resource monitoring. 05:20:57 INFO - ##### 05:20:57 INFO - ##### Finished create-virtualenv step (success) 05:20:57 INFO - ##### 05:20:57 INFO - ##### 05:20:57 INFO - ##### Running install step. 05:20:57 INFO - ##### 05:20:57 INFO - Running pre-action listener: _resource_record_pre_action 05:20:57 INFO - Running main action method: install 05:20:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:57 INFO - Reading from file tmpfile_stdout 05:20:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:20:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:20:57 INFO - Reading from file tmpfile_stdout 05:20:57 INFO - Output received: 05:20:57 INFO - Usage: mozinstall [options] installer 05:20:57 INFO - Options: 05:20:57 INFO - -h, --help show this help message and exit 05:20:57 INFO - -d DEST, --destination=DEST 05:20:57 INFO - Directory to install application into. [default: 05:20:57 INFO - "/builds/slave/test"] 05:20:57 INFO - --app=APP Application being installed. [default: firefox] 05:20:57 INFO - mkdir: /builds/slave/test/build/application 05:20:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:21:14 INFO - Reading from file tmpfile_stdout 05:21:14 INFO - Output received: 05:21:14 INFO - /builds/slave/test/build/application/firefox/firefox 05:21:14 INFO - Running post-action listener: _resource_record_post_action 05:21:14 INFO - ##### 05:21:14 INFO - ##### Finished install step (success) 05:21:14 INFO - ##### 05:21:14 INFO - ##### 05:21:14 INFO - ##### Running run-tests step. 05:21:14 INFO - ##### 05:21:14 INFO - Running pre-action listener: _resource_record_pre_action 05:21:14 INFO - Running main action method: run_tests 05:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:21:14 INFO - Python 2.7.3 05:21:14 INFO - Return code: 0 05:21:14 INFO - grabbing minidump binary from tooltool 05:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:14 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 0x10ae1c0>, '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 0x10af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:21:14 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 05:21:14 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 05:21:14 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 05:21:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:21:14 INFO - Return code: 0 05:21:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:21:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:21:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:21:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:21:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:21:15 INFO - Return code: 0 05:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 05:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 05:21:15 INFO - Using env: {'DISPLAY': ':0', 05:21:15 INFO - 'HOME': '/home/cltbld', 05:21:15 INFO - 'LANG': 'en_US.UTF-8', 05:21:15 INFO - 'LANGUAGE': 'en_US:en', 05:21:15 INFO - 'LOGNAME': 'cltbld', 05:21:15 INFO - 'MAIL': '/var/mail/cltbld', 05:21:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:21:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:15 INFO - 'MOZ_NO_REMOTE': '1', 05:21:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:15 INFO - 'NO_EM_RESTART': '1', 05:21:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:15 INFO - 'PWD': '/builds/slave/test', 05:21:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:21:15 INFO - 'SHELL': '/bin/bash', 05:21:15 INFO - 'SHLVL': '1', 05:21:15 INFO - 'TERM': 'linux', 05:21:15 INFO - 'TMOUT': '86400', 05:21:15 INFO - 'USER': 'cltbld', 05:21:15 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664', 05:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:15 INFO - '_': '/tools/buildbot/bin/python'} 05:21:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 05:21:15 INFO - mozversion application_buildid: 20160606023017 05:21:15 INFO - mozversion application_changeset: a48604c3b4956734c5cae80d350f7890eb9d4aa2 05:21:15 INFO - mozversion application_display_name: Nightly 05:21:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:21:15 INFO - mozversion application_name: Firefox 05:21:15 INFO - mozversion application_remotingname: firefox 05:21:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:21:15 INFO - mozversion application_vendor: Mozilla 05:21:15 INFO - mozversion application_version: 49.0a1 05:21:15 INFO - mozversion platform_buildid: 20160606023017 05:21:15 INFO - mozversion platform_changeset: a48604c3b4956734c5cae80d350f7890eb9d4aa2 05:21:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:21:15 INFO - mozversion platform_version: 49.0a1 05:21:15 INFO - using testdate: 1465215675 05:21:15 INFO - actual date: 1465215675 05:21:15 INFO - starting webserver on 'localhost:37026' 05:21:15 INFO - SUITE-START | Running 2 tests 05:21:15 INFO - TEST-START | dromaeo_css 05:21:15 INFO - operating with platform_type : linux_ 05:21:15 INFO - Initialising browser for dromaeo_css test... 05:21:15 INFO - TEST-INFO | started process 30627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuCFTbf/profile http://localhost:37026/getInfo.html) 05:21:20 INFO - PROCESS | 30627 | __metrics Screen width/height:1600/1200 05:21:20 INFO - PROCESS | 30627 | colorDepth:24 05:21:20 INFO - PROCESS | 30627 | Browser inner width/height: 1024/697 05:21:20 INFO - PROCESS | 30627 | __metrics 05:21:20 ERROR - PROCESS | 30627 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 05:21:21 INFO - TEST-INFO | 30627: exit 0 05:21:21 INFO - Browser initialized. 05:21:21 INFO - Running cycle 1/1 for dromaeo_css test... 05:21:21 INFO - TEST-INFO | started process 30745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuCFTbf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:33 INFO - PROCESS | 30745 | RSS: Main: 167411712 05:21:33 INFO - PROCESS | 30745 | 05:22:23 INFO - PROCESS | 30745 | 1465215743066 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] 05:24:31 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:37026/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37026/tests/dromaeo/cssquery-ext.html) 05:24:32 INFO - PROCESS | 30745 | RSS: Main: 170790912 05:24:32 INFO - PROCESS | 30745 | 05:27:34 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:37026/tests/dromaeo/cssquery-ext.html (next: http://localhost:37026/tests/dromaeo/cssquery-jquery.html) 05:27:34 INFO - PROCESS | 30745 | RSS: Main: 170119168 05:27:34 INFO - PROCESS | 30745 | 05:30:36 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:37026/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37026/tests/dromaeo/cssquery-mootools.html) 05:30:37 INFO - PROCESS | 30745 | RSS: Main: 171954176 05:30:37 INFO - PROCESS | 30745 | 05:33:39 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:37026/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37026/tests/dromaeo/cssquery-prototype.html) 05:33:39 INFO - PROCESS | 30745 | RSS: Main: 169472000 05:33:39 INFO - PROCESS | 30745 | 05:36:42 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:37026/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37026/tests/dromaeo/cssquery-yui.html) 05:36:42 INFO - PROCESS | 30745 | RSS: Main: 170967040 05:36:42 INFO - PROCESS | 30745 | 05:39:45 INFO - PROCESS | 30745 | Cycle 1(1): loaded http://localhost:37026/tests/dromaeo/cssquery-yui.html (next: http://localhost:37026/tests/dromaeo/cssquery-dojo.html) 05:39:45 INFO - PROCESS | 30745 | RSS: Main: 172290048 05:39:45 INFO - PROCESS | 30745 | 05:39:45 INFO - PROCESS | 30745 | __start_tp_report 05:39:45 INFO - PROCESS | 30745 | _x_x_mozilla_page_load 05:39:45 INFO - PROCESS | 30745 | _x_x_mozilla_page_load_details 05:39:45 INFO - PROCESS | 30745 | |i|pagename|runs| 05:39:45 INFO - PROCESS | 30745 | |0;dojo.html;3164.1298642873207;3171.0803866878605;3181.5704879841214;3200.583924089868;3209.2939553298265;5438.7824487020525;5455.509004189622;5487.807926722566;5511.200875873001;5511.22842802008;5390.73046347683;5467.917981230285;5469.781208751645;5503;5504.064309067458;4997.750112494379;5011.1481048221885;5045.091883460976;5048.469910659383;5082.949170508303;4999.550040496355;5151.81968631098;5155.252488389181;5176;5192.636515443921;4877.268409738532;4925.162722337175;4994.126027945132;5034.244863270502;5049.368828896388;4907.067657145131;4976.104301225778;5003.949960500385;5004.774785134641;5006.374203224597;4987.775550100254;5040.747962601855;5041.79832806691;5049.4950504949575;5074.695518268915;5219.8434046978655;5363.517283444469;5380.946190538084;5455.318085239345;5460.972695136538;5804.2744656917885;5853.85365365865;5857.941420585782;5875.735591898332;5884.47039766423;5904.911426328608;5911.083782013795;5912.674802885883;5913.497352725023;5918.674472903988;5322.387925388591;5435.130379139318;5441.075017247077;5479.123340265538;5481.451854814487;5941.7623295067715;5959.821205363846;5999.970000149971;6003.969980150158;6004.729787159588;5548.4174161713245;5744.080947048452;5752.165935939265;5772.307323121252;5772.336181339199;5809.9832529307205;5844.1818145459665;5865.442782935615;5879.941200587939;5883.294004719461;5659.405762394971;5679.403662615448;5749.798757043483;5825.0679891217205;5839.299284085937;5751.4536119068625;5752.252207213036;5755.1367294906095;5755.453231942959;5771.538276937835;4257.74453532789;4300.440942677495;4329.740215587075;4363.781810909441;4364.956350436455;3899.0642245861354;3908.902277443087;3915.882523524299;3948.861789837342;3959.584243654375;5545.223668686387;5556.666600004012;5579.497845193952;5592.217089607459;5611.494965453129;5853.356130825606;5860.589758716934;5880.470757631833;5900.881982360329;5906.586538942319;5655.6606603603095;5690.146478028246;5690.2887139107615;5690.487856092889;5697.9430205698245;4871.585915197248;4882.023595280958;4897.902041959141;4904.656674032854;4942.406911170682;5906.911396329058;6106.3089915548935;6175.3515880832765;6181.536384771161;6249.218847644044;5930.11048342752;5986.580939334205;5988.848901112572;6021.488173505301;6064.696765161636;5949.286085669747;6165.475934545614;6182.443580077815;6189.102580125947;6226.62640241587;5628.85927851807;5658.462446067617;5669.631473954345;5743.1385292206505;5753.942460575341;5814.534837212928;5820.76716931335;5837.066069428871;5840.912386314294;5859;5626.831195064155;5645.802396916089;5698.658080515016;5722.4277572242445;5728.570357223141;5573.804916827891;5709.914351284817;5741.540676745767;5793.884122317446;5864.9706751467675;5563.471470210324;5606.383297837153;5614.6069775116985;5617.213590097308;5628.774849005994;5696.857578560569;5752.338481074563;5783.392743761844;5799.594028418139;5805.535557155333;5705.4579814917515;5713.714314284186;5734.5125664319;5740.569457290803;5818.359980402237 05:39:45 INFO - PROCESS | 30745 | |1;ext.html;578.4562511239435;635.5868685354521;639.4756299834137;656.4912193050385;662.7382184037302;38933;44177.77911110444;44259;44272;44426;43552.56447435525;44314;44358.778206108924;44366.77816610921;44486.110277794425;8700.52147131906;8853.15894989975;8885.289176865868;8931.821363572724;8934.508602026886;8784.64861405543;8822.470651760883;8898.777530561756;8904.154105360012;8919;8907.777305567348;8913.064128266536;8947.552622368856;8964.282857371394;8978.595963181673;8876.600552975131;8881.822363552757;8938.597763100675;8957.149070838292;8976.910230897673;8729.825403491957;8852.247558957497;8911.598978046004;8924.062973387765;8946.507942063185;40701.796491017354;41053.384199237036;41085.794571027254;41109;41182.58817411817;3602.189507360849;3627;3696.4085746280466;3734.290484807905;3792.393217085281;29164.562531562042;29259;29322.413551728845;32647.347053059042;34150.316993660235;4448.132614140244;4454.866354009385;4458.398116254297;4586.4266966629175;4687.859364219079;227408;229478;231571;232949;233111.9999999983;34582.481262781075;35622.28755424877;35715.464268036;60710;60982.69508652428;37394.81302593524;37442.25115497729;37442.43836342457;37537.43693844594;37617.24765504675;14726.779098313535;14788.556343309718;14837.851621483864;14847.480338188328;14886.70226595462;13483.258420786755;13491.865081349257;13498.93250533741;13520.053596248168;13607.387667554984;8279.254867061993;8361.916380836114;8376.036755773042;8446.788830279169;8518.87221691675;3209.1816586770224;3212.100611828692;3235.142687187897;3258.0714496368423;3270.5748252727467;1047.5439139595967;1080.3247970018738;1153.9307641541534;1187.2935603316014;1205.15036898986;32911.506327405106;33083.834580826944;33193.668063319055;33267;33573.83213083919;1099.6920862158609;1124.4883577972003;1154.0341322800323;1170.6136974798296;1212.4786341872903;17239;17431.12844357777;17595.29618815233;17602.207900644502;17620.118994050245;548582;553532;555279;555700;556763;58225.417745822844;59539.40460595339;59699.403005970256;59734;59967;1389.1942673249491;1401.0472878442756;1401.5234820161195;1402.7475054490085;1430.3205977160765;31314.373712525165;32738.50892236666;33025.83487082549;33061.33877322488;33088.1727956803;51713.48286517087;52468.47531524636;52533.212001819236;52562.211566827296;52759.472405275454;360384;363153;365672;366461;367031;28361.858190708914;28836.711632884242;28868.711312886604;28919.277018074717;29034;49534;49970.75014624903;50642.74678626583;51230;51702.741486292325;41696.583034170486;41762.1647567053;42317.78841105775;43026.35460468033;43438;41391;41890.79054604707;42307.34619191948;42582.57417425786;42852.1429571413;35726.28547428985;41531.58468415398;42028.15943681171;42124;42338.57661423346;33822.49266261057;37372;37478.6252137486;37723.43414848725;37804.43293350657;28354.432911341246;28447.573286400308;28630.85684571564;28640.57039144373;28938.42123157483 05:39:45 INFO - PROCESS | 30745 | |2;jquery.html;392.432934409778;393.73226206179805;395.2588895820337;397.66397394201897;418.167845986487;18004;19086.904565477154;19595.118219680113;19710;19801.306954256605;18380.26478940844;18383.172757225922;18750.249990000382;19114.522136946583;19144.61710765784;5544.22380866679;5567.3040869891265;5654.434556544354;5738.282714660668;5739.253896993385;5600.915986260209;5602.2436971009;5609.52319052881;5617.157426386055;5684.857878553028;5452.563794896399;5584.664920104787;5599.944000560004;5627.212190293362;5632.493075623193;5606.55147588194;5609.551235901118;5631.549476041927;5632.155176723483;5641.26663533738;4842.44311904132;5000.774965126578;5003.949960500385;5006.974965125188;5009.524095210949;22679.77320226793;22789.544209115724;23201.187958421542;23400.7659923402;23524.411889702722;709.4359983812881;2280.8787827320584;2284.2119468783244;2285.371522831218;2369.9289021329387;14070.437182512687;14552.547818365105;14671.926640366837;14734.410623575044;14743.262836858114;1958.7061940709007;1990.4824745566257;2034.1863254698092;2060.7115003899467;2066.070268379235;66129.3387066128;73694;77415.6129219356;80113.59943200304;82246.58876705638;10540.104091152338;10571.20715946307;10783.946080269548;10834.891651083546;11070.667879963614;14937.626559336104;15033.323500442506;15122.621934451727;15163.772543411858;15188.088714677155;7896.012998375203;8113.8377232456205;8486.769418434416;8622.223999840044;8754.25588824957;8327.292180164754;8368.37237207212;8451.45065570736;8532.8720069199;8564.48613083217;6511.967440162769;6646.8005959821285;6653.600783952978;6731.697073631698;6737.6968036438475;1884.396992962239;1935.3613307608455;1937.7190307405629;1938.6510428123074;1977.812107849752;960.5869476125193;997.486294558303;1027;1054.915606751458;1135.6309199510192;19438.902805486166;20171.899140504498;20204.595908081756;20259.696104558443;20324.898375508026;1025.5077562769911;1026.594495174402;1036.1814166808288;1057.677408390433;1064;11074.501647425885;11623.12826537996;11624.6512604622;11626.941865290619;11707.648770536898;493009;495861;508482;511001;514975;72922;83771;84091.5795421019;84655;85519.5724021376;1043.1915265669015;1045.0907710292095;1045.5556388534842;1064.8136576099307;1071.6463567022863;17473.650526989644;17678.116094195495;17736;17956.281748729903;17981.820181798015;38543.614563854004;39350.80324598359;39464.40803388009;40246.1950760989;41068.794656026526;53077.7346113267;53183.46816531785;54235;55044.17433738417;55079;8495.787605309917;8638.740837774876;8778.34162437807;8820.11798820113;8862.069482704223;13273.469061237829;13575.253361065235;13662.93168534151;13675.316234188449;13768.105073170213;11696.70758231051;11908.821367679318;11972;12122.09084318662;12203.267803931793;9554.570044347882;11787.351695656822;11851.822222666839;11870.287782733063;12041.157119001586;12044.21712588714;12060.51757929673;12141.15011949155;12272.325022123869;12302.323372214614;7139.393151582174;8525.275351595184;8669.263112635497;8831.337649676429;8874.689385871721;10149.39103653783;11749.353785541878;11870.584529541424;11972.221805582609;12048.216865903689 05:39:45 INFO - PROCESS | 30745 | |3;mootools.html;1497.9925100374496;1537.1468834796688;1714.2714346402777;1827.2051657528975;1827.570520927581;7841.647125879334;8576;8621.310295176387;9144.679936202234;9147.313951453634;8617.439866408695;8847.469151850893;8890.64437422504;8905.376623636348;8919.955400223005;2320.1647406933535;2375.1449478187837;2375.3111597636666;2378.0250097460043;2389.23544465771;2325.0815927708545;2335.5795956727784;2385.153270588942;2393.413613664655;2394.042383046778;2359.8230132740027;2371.3952941999764;2371.8932648030795;2404.2066118181046;2411.2404592553376;2288.084766093559;2315.2938353802083;2337.742848286687;2342.8594284342907;2384.3562238195764;2337.883105844701;2347.976520234793;2357.3752955466816;2366.7396586375485;2382.4282172278704;8769.605367758466;8887.333449991276;8925.419847709943;8930;8938;5174.275601415805;5381.838544843661;5389.514943655051;5391.78432862685;5395.7032363220005;3426.8629254829775;3455.94816077759;3458.6368431314854;3504.4743288506675;3567.4470457079196;1214.3624597086512;1235.0736947289533;1237.1031002523189;1254.5044707340642;1259.7669431155175;12297.877021229762;12354.38228088592;12359.32023738694;12378.62864114078;12384.566540171141;4580.244259697112;4696.9060618787435;4734.73958932262;4767.523247675204;4790.664653474223;10312.690619281284;10440.582376704846;10456.477176141163;10478.266521343585;10498.527566259536;5210.713410762444;5239.842804715865;5273.787028983279;5310.415854256029;5366.651167674088;4333.891652708645;4795.592374648194;4857.344258525124;4934.8766280843265;4946.0355230729665;4016.959830401717;4061.7156799023783;4092.196845161074;4097.733647312974;4165.8333666653;1241.1754720560762;1296.6887946892866;1300.005495795717;1302.2837439408477;1309.8755618216255;922.9769255768525;938.1744065222697;956.7464621875208;971.504532688334;975.1711045611173;5689.43105689436;5763.423657634203;5788.247527821441;5807.303123625107;5924.437178468039;447.483156953719;462.4635422909409;465.39033865635446;467.0542152141872;474.7460108841753;4019.5176578810147;4076.5311989121633;4081.10215752534;4091.5908409158847;4109.157622687342;10800.351978881292;11212.43937803123;11247.212695111428;11251.943740281245;11263.49314280843;10832.783344333227;10944.781104377867;11031.944840275908;11041.33751974884;11057.170712196617;8053.395995300376;8278.172182781795;8325;8329.750107496784;8369.916300837036;5675.091985282335;5678.6876721779045;5684.147377893349;5772.5959182856795;5822.0684690449325;10018.949905250427;10264.435456049989;10307;10335.638252661121;10465.372077675363;10342.586296548054;10391.06480416736;10410.323328983592;10441.477926103513;10502.159827213653;7056.364927156375;7626.58053807046;7889.211078892295;7960.164182760726;8008.519488830689;8784.033756286675;8792.868106978529;8794.780130496789;8814.030456649634;8833.911660883308;7744.225577442211;7838.843223135391;7902.723404680809;7947.84104317922;8165.305948994402;7614.543127412373;7851;7871.094824095073;7919.564423956507;7995.720149794729;6658.600483970978;6778.152730908637;6796.524243302922;6832.350926661959;6840.3501667341525;5045.11710450677;5147.716875571729;5268.051750684914;5269.683818970874;5307.3100496936695;5177.171652535576;5192.818251361185;5225.58195344364;5287.154055351125;5301.469853014668 05:39:45 INFO - PROCESS | 30745 | |4;prototype.html;318.9473736833421;334;336.74743942043466;337.1217977169474;338.3284180900913;5416.214648875911;5515.889682206353;5529.7604470189535;5575.609707320489;5591.356993945692;5470.671759694411;5525.226468294432;5529.253550770644;5532.944670553294;5545.77816887324;4296.63478604319;4312.547182545827;4319.438472998506;4320.913581728363;4348.173846969082;4207.410962465257;4240.109576988821;4319.157764235975;4341.891452713691;4354.281543545327;4263.744175349473;4266.5946735060115;4279.828806847722;4281.143771245764;4292.59220374064;4283.807228674686;4296.140771845612;4296.8281268749215;4301.827926882921;4309.956900431002;3605.5312809334882;3725.1245957200035;3735.2716220337047;3766.5668448128267;3770.2271034437877;5379.220013098118;5380.435054319319;5406.567044829803;5425.755840987125;5436.809711660073;4898.755062246873;4901.460839307673;4915.410150781893;4929.309896614477;4944.604431645495;5557.805476808333;5726.513246374063;5734.881698068878;5753.490370873764;5825.825225243249;4057.7015355086382;4082.0611259410502;4101.774402407867;4106.404571337169;4126.463559737245;5815.040518314473;5947.4052594740615;5956.16613674086;5968.850778730523;5981.641101533878;4195.223883581547;4196.769177695256;4198.118395137056;4198.916021679549;4199.559046300155;4220.388043733703;4251.532331443539;4264.957350426518;4269.167512335127;4280.5291417944;4850.684705494132;4861.6353773467135;4873.269009648581;4885.731284779371;4907.975460122677;5636.408177141423;5641;5785.247917770747;5808.912866307009;5823.330317013513;1435.8205224346957;1452.978205326921;1460.3282490054482;1463.7877507761316;1471.484371097771;907.2968449451596;918.2424499787568;937.704623043739;949.5726922884729;949.852772820214;4970.726610036482;4978.809323897473;5002.574781143643;5044.621653376012;5062;5292.708901010405;5294.788208471618;5319.973400132974;5368.731563421891;5374.990005596878;4965.3048573199785;5018.322526458955;5058.342415485963;5226.686398816008;5715.399883012307;3163.940080073155;3177.7298929591243;3178.984105079506;3180.9363812724077;3209;6106.572539922163;6221.129041934133;6238.313785483593;6240.251169859646;6252.499800015988;6054.424829641177;6112.235970503687;6140.78507252253;6160.568760186834;6165.691715414211;6177.505799536116;6190.288116866528;6221.191245138103;6238.844028899314;6277.466415354655;5791.884162316645;5954.910676339945;5993.850153746192;5996.820095397145;5996.850078748066;5899.46904778572;5922.860883731629;5934.406559344031;5936.525077993837;5961.314448838439;5997.260794369584;6176.227971503562;6201.441870231701;6274.560780745304;6277.591956522811;4153.397757325231;4172.311568591149;4228.767417792051;4240.215560121387;4245.745255284693;5725.828225153252;5811.76752929895;6056.0007598745715;6057.394260573908;6064.757409703562;5717.142428635571;5802.361740208489;5810.273715785527;5817.9127313091185;5818.76724930998;5741.110127930177;5764.481196692318;5797.391273916178;5801.6519008859605;5828.59199856006;5562.805301814417;5692.5445964321925;5717.828465146053;5742.913856292243;5743.569232307677;5752.68360240174;5773.451522105393;5786.855328616818;5841.108651217674;5851.707414629337;5501.889962200654;5741.1388291756575;5762.366139724543;5764.971175144097;5780.855478613068 05:39:45 INFO - PROCESS | 30745 | |5;yui.html;757.8294883651179;777.6811507282016;782.5695867272998;805.198827166969;866.6143566113083;15002.39990400384;15741.921290393531;16361.672766544676;16436.75344869828;16990.235439405227;15137;15333.310001049951;15345.462908798194;15366.462173823918;15395.615109622266;783.9725609603665;787.8621241282752;821.2895845093981;832.1262674192104;841.4152164245852;818.5907046476761;818.9959050204741;823.2631794543879;824.4599787139404;825.1006403020706;847.8134810341714;850.2772643253247;852.0499642898155;854.6367793687689;855.4354126276659;838.7525679924375;840.8234270803139;843.1694780641063;844.5988155626059;850.4982060584254;613.8434699151733;616.6916541729136;617.5337620096798;617.8578926846806;618.8267285160163;15878;15881.444149454714;15889.126098064717;15913.124778137199;15933.84066159335;14482.637934051732;14673.633159170999;14959;14965.476208332764;15121.773173402407;11892.524299028028;12074.577389791315;12333.691657708629;12451.564195253213;12893.67765805853;3788.8105594720155;3870.9612903870884;4016.1566071124807;4047.514298284225;4052.0477687743355;82722.17277827265;84368;84391.5780421094;84917;85308.14691853063;11082.501287441923;11486.885131148581;11594.88405115938;11765.176437649283;11938.22401543897;21643.458913527287;21658.35024949254;21940.45148871291;22016.44958876041;22115.5624884382;8617.82764344722;8761.737147885573;8795.648174073094;8913.465192088495;8966.910330896739;4696.553827386393;4726.415377084223;4730.432348118248;4810.927836082462;4887.169181239198;3694.1872787987136;3754.9249015019545;3808.9428658570146;3823.713221508398;3828;671.4292851076546;679.2019377231733;691.989620155698;692.6398272898166;697.7801992372387;672.5614701402408;738.4055835052727;765.9544721455285;767.9462437629312;792.1880072925183;9864.457454840052;10106.39361638304;10139.847902281472;10204.183665306758;10219.795604087876;671.0739179931663;723.8805597076529;746.8543633991319;761.3756719489965;796.8246985663145;4533.954660453419;4587.977060114678;4644;4657.953420465819;4658.1848176568965;69098.65450672715;69261;70173.64913175504;70560.64719676471;70776.64611676909;95679.52160239154;96828;97088;98307;98558;55821;56148.192590370316;71772.64113679399;84514.5774271137;86293;9096.27229821626;9489.383190092622;9806.166475849634;9927.652532161628;10176.236782241509;37876.431853521666;46742.532574673816;48629;51944.48055519548;52069.47930520646;66771.66614166897;67887;74075.6296218537;75256;77975;12646.557370491988;12822.23066616006;12823.743525129632;13133.934330328288;13191.934040329737;14609.853901460849;14615.196164211071;14630.487932922297;14800.62998425048;15059.096454212782;14141.505047323295;14206.573802785933;14363.497277595234;14586.270686465847;15063.397464101314;14274.857251427353;14371.353289101806;14528.927355363156;14646.780298295322;14851.702965940405;13661.726765464437;13735;14017.649558760704;14305.64235894111;14625.561233163022;10187.439690817077;10951.069159121564;11166.497507612014;11349;12016.279023258632;11682.824757628472;11743.882561174622;11847.348395838311;11884.560229445466;12078.939605302268 05:39:45 INFO - PROCESS | 30745 | __end_tp_report 05:39:45 INFO - PROCESS | 30745 | __start_cc_report 05:39:45 INFO - PROCESS | 30745 | _x_x_mozilla_cycle_collect,337 05:39:45 INFO - PROCESS | 30745 | __end_cc_report 05:39:45 INFO - PROCESS | 30745 | __startTimestamp1465216785843__endTimestamp 05:39:45 INFO - PROCESS | 30745 | 05:39:45 INFO - PROCESS | 30745 | ------- Summary: start ------- 05:39:45 INFO - PROCESS | 30745 | Number of tests: 6 05:39:45 INFO - PROCESS | 30745 | 05:39:45 INFO - PROCESS | 30745 | [#0] dojo.html Cycles:165 Average:5441.18 Median:5659.41 stddev:632.61 (11.2%) stddev-sans-first:608.81 05:39:45 INFO - PROCESS | 30745 | Values: 3164.1 3171.1 3181.6 3200.6 3209.3 5438.8 5455.5 5487.8 5511.2 5511.2 5390.7 5467.9 5469.8 5503.0 5504.1 4997.8 5011.1 5045.1 5048.5 5082.9 4999.6 5151.8 5155.3 5176.0 5192.6 4877.3 4925.2 4994.1 5034.2 5049.4 4907.1 4976.1 5003.9 5004.8 5006.4 4987.8 5040.7 5041.8 5049.5 5074.7 5219.8 5363.5 5380.9 5455.3 5461.0 5804.3 5853.9 5857.9 5875.7 5884.5 5904.9 5911.1 5912.7 5913.5 5918.7 5322.4 5435.1 5441.1 5479.1 5481.5 5941.8 5959.8 6000.0 6004.0 6004.7 5548.4 5744.1 5752.2 5772.3 5772.3 5810.0 5844.2 5865.4 5879.9 5883.3 5659.4 5679.4 5749.8 5825.1 5839.3 5751.5 5752.3 5755.1 5755.5 5771.5 4257.7 4300.4 4329.7 4363.8 4365.0 3899.1 3908.9 3915.9 3948.9 3959.6 5545.2 5556.7 5579.5 5592.2 5611.5 5853.4 5860.6 5880.5 5900.9 5906.6 5655.7 5690.1 5690.3 5690.5 5697.9 4871.6 4882.0 4897.9 4904.7 4942.4 5906.9 6106.3 6175.4 6181.5 6249.2 5930.1 5986.6 5988.8 6021.5 6064.7 5949.3 6165.5 6182.4 6189.1 6226.6 5628.9 5658.5 5669.6 5743.1 5753.9 5814.5 5820.8 5837.1 5840.9 5859.0 5626.8 5645.8 5698.7 5722.4 5728.6 5573.8 5709.9 5741.5 5793.9 5865.0 5563.5 5606.4 5614.6 5617.2 5628.8 5696.9 5752.3 5783.4 5799.6 5805.5 5705.5 5713.7 5734.5 5740.6 5818.4 05:39:45 INFO - PROCESS | 30745 | 05:39:45 INFO - PROCESS | 30745 | [#1] ext.html Cycles:180 Average:54284.10 Median:40877.59 stddev:108006.73 (264.2%) stddev-sans-first:108234.45 05:39:45 INFO - PROCESS | 30745 | Values: 578.5 635.6 639.5 656.5 662.7 38933.0 44177.8 44259.0 44272.0 44426.0 43552.6 44314.0 44358.8 44366.8 44486.1 8700.5 8853.2 8885.3 8931.8 8934.5 8784.6 8822.5 8898.8 8904.2 8919.0 8907.8 8913.1 8947.6 8964.3 8978.6 8876.6 8881.8 8938.6 8957.1 8976.9 8729.8 8852.2 8911.6 8924.1 8946.5 40701.8 41053.4 41085.8 41109.0 41182.6 3602.2 3627.0 3696.4 3734.3 3792.4 29164.6 29259.0 29322.4 32647.3 34150.3 4448.1 4454.9 4458.4 4586.4 4687.9 227408.0 229478.0 231571.0 232949.0 233112.0 34582.5 35622.3 35715.5 60710.0 60982.7 37394.8 37442.3 37442.4 37537.4 37617.2 14726.8 14788.6 14837.9 14847.5 14886.7 13483.3 13491.9 13498.9 13520.1 13607.4 8279.3 8361.9 8376.0 8446.8 8518.9 3209.2 3212.1 3235.1 3258.1 3270.6 1047.5 1080.3 1153.9 1187.3 1205.2 32911.5 33083.8 33193.7 33267.0 33573.8 1099.7 1124.5 1154.0 1170.6 1212.5 17239.0 17431.1 17595.3 17602.2 17620.1 548582.0 553532.0 555279.0 555700.0 556763.0 58225.4 59539.4 59699.4 59734.0 59967.0 1389.2 1401.0 1401.5 1402.7 1430.3 31314.4 32738.5 33025.8 33061.3 33088.2 51713.5 52468.5 52533.2 52562.2 52759.5 360384.0 363153.0 365672.0 366461.0 367031.0 28361.9 28836.7 28868.7 28919.3 29034.0 49534.0 49970.8 50642.7 51230.0 51702.7 41696.6 41762.2 42317.8 43026.4 43438.0 41391.0 41890.8 42307.3 42582.6 42852.1 35726.3 41531.6 42028.2 42124.0 42338.6 33822.5 37372.0 37478.6 37723.4 37804.4 28354.4 28447.6 28630.9 28640.6 28938.4 05:39:45 INFO - PROCESS | 30745 | 05:39:45 INFO - PROCESS | 30745 | [#2] jquery.html Cycles:180 Average:29049.23 Median:2284.79 stddev:82788.73 (3623.5%) stddev-sans-first:82993.01 05:39:45 INFO - PROCESS | 30745 | Values: 392.4 393.7 395.3 397.7 418.2 18004.0 19086.9 19595.1 19710.0 19801.3 18380.3 18383.2 18750.2 19114.5 19144.6 5544.2 5567.3 5654.4 5738.3 5739.3 5600.9 5602.2 5609.5 5617.2 5684.9 5452.6 5584.7 5599.9 5627.2 5632.5 5606.6 5609.6 5631.5 5632.2 5641.3 4842.4 5000.8 5003.9 5007.0 5009.5 22679.8 22789.5 23201.2 23400.8 23524.4 709.4 2280.9 2284.2 2285.4 2369.9 14070.4 14552.5 14671.9 14734.4 14743.3 1958.7 1990.5 2034.2 2060.7 2066.1 66129.3 73694.0 77415.6 80113.6 82246.6 10540.1 10571.2 10783.9 10834.9 11070.7 14937.6 15033.3 15122.6 15163.8 15188.1 7896.0 8113.8 8486.8 8622.2 8754.3 8327.3 8368.4 8451.5 8532.9 8564.5 6512.0 6646.8 6653.6 6731.7 6737.7 1884.4 1935.4 1937.7 1938.7 1977.8 960.6 997.5 1027.0 1054.9 1135.6 19438.9 20171.9 20204.6 20259.7 20324.9 1025.5 1026.6 1036.2 1057.7 1064.0 11074.5 11623.1 11624.7 11626.9 11707.6 493009.0 495861.0 508482.0 511001.0 514975.0 72922.0 83771.0 84091.6 84655.0 85519.6 1043.2 1045.1 1045.6 1064.8 1071.6 17473.7 17678.1 17736.0 17956.3 17981.8 38543.6 39350.8 39464.4 40246.2 41068.8 53077.7 53183.5 54235.0 55044.2 55079.0 8495.8 8638.7 8778.3 8820.1 8862.1 13273.5 13575.3 13662.9 13675.3 13768.1 11696.7 11908.8 11972.0 12122.1 12203.3 9554.6 11787.4 11851.8 11870.3 12041.2 12044.2 12060.5 12141.2 12272.3 12302.3 7139.4 8525.3 8669.3 8831.3 8874.7 10149.4 11749.4 11870.6 11972.2 12048.2 05:39:45 INFO - PROCESS | 30745 | 05:39:45 INFO - PROCESS | 30745 | [#3] mootools.html Cycles:180 Average:5847.62 Median:2581.98 stddev:3347.44 (129.6%) stddev-sans-first:3340.87 05:39:45 INFO - PROCESS | 30745 | Values: 1498.0 1537.1 1714.3 1827.2 1827.6 7841.6 8576.0 8621.3 9144.7 9147.3 8617.4 8847.5 8890.6 8905.4 8920.0 2320.2 2375.1 2375.3 2378.0 2389.2 2325.1 2335.6 2385.2 2393.4 2394.0 2359.8 2371.4 2371.9 2404.2 2411.2 2288.1 2315.3 2337.7 2342.9 2384.4 2337.9 2348.0 2357.4 2366.7 2382.4 8769.6 8887.3 8925.4 8930.0 8938.0 5174.3 5381.8 5389.5 5391.8 5395.7 3426.9 3455.9 3458.6 3504.5 3567.4 1214.4 1235.1 1237.1 1254.5 1259.8 12297.9 12354.4 12359.3 12378.6 12384.6 4580.2 4696.9 4734.7 4767.5 4790.7 10312.7 10440.6 10456.5 10478.3 10498.5 5210.7 5239.8 5273.8 5310.4 5366.7 4333.9 4795.6 4857.3 4934.9 4946.0 4017.0 4061.7 4092.2 4097.7 4165.8 1241.2 1296.7 1300.0 1302.3 1309.9 923.0 938.2 956.7 971.5 975.2 5689.4 5763.4 5788.2 5807.3 5924.4 447.5 462.5 465.4 467.1 474.7 4019.5 4076.5 4081.1 4091.6 4109.2 10800.4 11212.4 11247.2 11251.9 11263.5 10832.8 10944.8 11031.9 11041.3 11057.2 8053.4 8278.2 8325.0 8329.8 8369.9 5675.1 5678.7 5684.1 5772.6 5822.1 10018.9 10264.4 10307.0 10335.6 10465.4 10342.6 10391.1 10410.3 10441.5 10502.2 7056.4 7626.6 7889.2 7960.2 8008.5 8784.0 8792.9 8794.8 8814.0 8833.9 7744.2 7838.8 7902.7 7947.8 8165.3 7614.5 7851.0 7871.1 7919.6 7995.7 6658.6 6778.2 6796.5 6832.4 6840.4 5045.1 5147.7 5268.1 5269.7 5307.3 5177.2 5192.8 5225.6 5287.2 5301.5 05:39:45 INFO - PROCESS | 30745 | 05:39:45 INFO - PROCESS | 30745 | [#4] prototype.html Cycles:180 Average:4836.01 Median:5486.28 stddev:1434.09 (26.1%) stddev-sans-first:1397.47 05:39:45 INFO - PROCESS | 30745 | Values: 318.9 334.0 336.7 337.1 338.3 5416.2 5515.9 5529.8 5575.6 5591.4 5470.7 5525.2 5529.3 5532.9 5545.8 4296.6 4312.5 4319.4 4320.9 4348.2 4207.4 4240.1 4319.2 4341.9 4354.3 4263.7 4266.6 4279.8 4281.1 4292.6 4283.8 4296.1 4296.8 4301.8 4310.0 3605.5 3725.1 3735.3 3766.6 3770.2 5379.2 5380.4 5406.6 5425.8 5436.8 4898.8 4901.5 4915.4 4929.3 4944.6 5557.8 5726.5 5734.9 5753.5 5825.8 4057.7 4082.1 4101.8 4106.4 4126.5 5815.0 5947.4 5956.2 5968.9 5981.6 4195.2 4196.8 4198.1 4198.9 4199.6 4220.4 4251.5 4265.0 4269.2 4280.5 4850.7 4861.6 4873.3 4885.7 4908.0 5636.4 5641.0 5785.2 5808.9 5823.3 1435.8 1453.0 1460.3 1463.8 1471.5 907.3 918.2 937.7 949.6 949.9 4970.7 4978.8 5002.6 5044.6 5062.0 5292.7 5294.8 5320.0 5368.7 5375.0 4965.3 5018.3 5058.3 5226.7 5715.4 3163.9 3177.7 3179.0 3180.9 3209.0 6106.6 6221.1 6238.3 6240.3 6252.5 6054.4 6112.2 6140.8 6160.6 6165.7 6177.5 6190.3 6221.2 6238.8 6277.5 5791.9 5954.9 5993.9 5996.8 5996.9 5899.5 5922.9 5934.4 5936.5 5961.3 5997.3 6176.2 6201.4 6274.6 6277.6 4153.4 4172.3 4228.8 4240.2 4245.7 5725.8 5811.8 6056.0 6057.4 6064.8 5717.1 5802.4 5810.3 5817.9 5818.8 5741.1 5764.5 5797.4 5801.7 5828.6 5562.8 5692.5 5717.8 5742.9 5743.6 5752.7 5773.5 5786.9 5841.1 5851.7 5501.9 5741.1 5762.4 5765.0 5780.9 05:39:45 INFO - PROCESS | 30745 | 05:39:45 INFO - PROCESS | 30745 | [#5] yui.html Cycles:180 Average:19352.43 Median:25700.36 stddev:25940.00 (100.9%) stddev-sans-first:25975.19 05:39:45 INFO - PROCESS | 30745 | Values: 757.8 777.7 782.6 805.2 866.6 15002.4 15741.9 16361.7 16436.8 16990.2 15137.0 15333.3 15345.5 15366.5 15395.6 784.0 787.9 821.3 832.1 841.4 818.6 819.0 823.3 824.5 825.1 847.8 850.3 852.0 854.6 855.4 838.8 840.8 843.2 844.6 850.5 613.8 616.7 617.5 617.9 618.8 15878.0 15881.4 15889.1 15913.1 15933.8 14482.6 14673.6 14959.0 14965.5 15121.8 11892.5 12074.6 12333.7 12451.6 12893.7 3788.8 3871.0 4016.2 4047.5 4052.0 82722.2 84368.0 84391.6 84917.0 85308.1 11082.5 11486.9 11594.9 11765.2 11938.2 21643.5 21658.4 21940.5 22016.4 22115.6 8617.8 8761.7 8795.6 8913.5 8966.9 4696.6 4726.4 4730.4 4810.9 4887.2 3694.2 3754.9 3808.9 3823.7 3828.0 671.4 679.2 692.0 692.6 697.8 672.6 738.4 766.0 767.9 792.2 9864.5 10106.4 10139.8 10204.2 10219.8 671.1 723.9 746.9 761.4 796.8 4534.0 4588.0 4644.0 4658.0 4658.2 69098.7 69261.0 70173.6 70560.6 70776.6 95679.5 96828.0 97088.0 98307.0 98558.0 55821.0 56148.2 71772.6 84514.6 86293.0 9096.3 9489.4 9806.2 9927.7 10176.2 37876.4 46742.5 48629.0 51944.5 52069.5 66771.7 67887.0 74075.6 75256.0 77975.0 12646.6 12822.2 12823.7 13133.9 13191.9 14609.9 14615.2 14630.5 14800.6 15059.1 14141.5 14206.6 14363.5 14586.3 15063.4 14274.9 14371.4 14528.9 14646.8 14851.7 13661.7 13735.0 14017.6 14305.6 14625.6 10187.4 10951.1 11166.5 11349.0 12016.3 11682.8 11743.9 11847.3 11884.6 12078.9 05:39:45 INFO - PROCESS | 30745 | -------- Summary: end -------- 05:39:45 INFO - PROCESS | 30745 | 05:39:46 INFO - TEST-INFO | 30745: exit 0 05:39:46 INFO - TEST-OK | dromaeo_css | took 1111035ms 05:39:46 INFO - TEST-START | kraken 05:39:46 INFO - operating with platform_type : linux_ 05:39:46 INFO - Initialising browser for kraken test... 05:39:46 INFO - TEST-INFO | started process 30989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3WRuDs/profile http://localhost:37026/getInfo.html) 05:39:51 INFO - PROCESS | 30989 | __metrics Screen width/height:1600/1200 05:39:51 INFO - PROCESS | 30989 | colorDepth:24 05:39:51 INFO - PROCESS | 30989 | Browser inner width/height: 1024/697 05:39:51 INFO - PROCESS | 30989 | __metrics 05:39:52 ERROR - PROCESS | 30989 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 05:39:52 INFO - TEST-INFO | 30989: exit 0 05:39:52 INFO - Browser initialized. 05:39:52 INFO - Running cycle 1/1 for kraken test... 05:39:52 INFO - TEST-INFO | started process 31109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3WRuDs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:04 INFO - PROCESS | 31109 | RSS: Main: 167452672 05:40:04 INFO - PROCESS | 31109 | 05:40:07 INFO - PROCESS | 31109 | Cycle 1(1): loaded http://localhost:37026/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37026/tests/kraken/driver.html?testName=audio-beat-detection) 05:40:08 INFO - PROCESS | 31109 | RSS: Main: 172658688 05:40:08 INFO - PROCESS | 31109 | 05:40:10 INFO - PROCESS | 31109 | Cycle 1(1): loaded http://localhost:37026/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37026/tests/kraken/driver.html?testName=audio-dft) 05:40:11 INFO - PROCESS | 31109 | RSS: Main: 171712512 05:40:11 INFO - PROCESS | 31109 | 05:40:14 INFO - PROCESS | 31109 | Cycle 1(1): loaded http://localhost:37026/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37026/tests/kraken/driver.html?testName=audio-fft) 05:40:14 INFO - PROCESS | 31109 | RSS: Main: 166494208 05:40:14 INFO - PROCESS | 31109 | 05:40:17 INFO - PROCESS | 31109 | Cycle 1(1): loaded http://localhost:37026/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37026/tests/kraken/driver.html?testName=audio-oscillator) 05:40:17 INFO - PROCESS | 31109 | RSS: Main: 167501824 05:40:17 INFO - PROCESS | 31109 | 05:40:19 INFO - PROCESS | 31109 | Cycle 1(1): loaded http://localhost:37026/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37026/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:40:20 INFO - PROCESS | 31109 | RSS: Main: 167591936 05:40:20 INFO - PROCESS | 31109 | 05:40:23 INFO - PROCESS | 31109 | Cycle 1(1): loaded http://localhost:37026/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37026/tests/kraken/driver.html?testName=imaging-darkroom) 05:40:24 INFO - PROCESS | 31109 | RSS: Main: 168022016 05:40:24 INFO - PROCESS | 31109 | 05:40:27 INFO - PROCESS | 31109 | Cycle 1(1): loaded http://localhost:37026/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37026/tests/kraken/driver.html?testName=imaging-desaturate) 05:40:28 INFO - PROCESS | 31109 | RSS: Main: 165498880 05:40:28 INFO - PROCESS | 31109 | 05:40:31 INFO - PROCESS | 31109 | Cycle 1(1): loaded http://localhost:37026/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37026/tests/kraken/driver.html?testName=json-parse-financial) 05:40:31 INFO - PROCESS | 31109 | RSS: Main: 167030784 05:40:31 INFO - PROCESS | 31109 | 05:40:33 INFO - PROCESS | 31109 | Cycle 1(1): loaded http://localhost:37026/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37026/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:40:33 INFO - PROCESS | 31109 | RSS: Main: 167272448 05:40:33 INFO - PROCESS | 31109 | 05:40:35 INFO - PROCESS | 31109 | Cycle 1(1): loaded http://localhost:37026/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37026/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:40:36 INFO - PROCESS | 31109 | RSS: Main: 167608320 05:40:36 INFO - PROCESS | 31109 | 05:40:38 INFO - PROCESS | 31109 | Cycle 1(1): loaded http://localhost:37026/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37026/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:40:39 INFO - PROCESS | 31109 | RSS: Main: 168136704 05:40:39 INFO - PROCESS | 31109 | 05:40:41 INFO - PROCESS | 31109 | Cycle 1(1): loaded http://localhost:37026/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:40:42 INFO - PROCESS | 31109 | RSS: Main: 168493056 05:40:42 INFO - PROCESS | 31109 | 05:40:45 INFO - PROCESS | 31109 | Cycle 1(1): loaded http://localhost:37026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:40:45 INFO - PROCESS | 31109 | RSS: Main: 168054784 05:40:45 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | Cycle 1(1): loaded http://localhost:37026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37026/tests/kraken/driver.html?testName=ai-astar) 05:40:47 INFO - PROCESS | 31109 | RSS: Main: 168820736 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | __start_tp_report 05:40:47 INFO - PROCESS | 31109 | _x_x_mozilla_page_load 05:40:47 INFO - PROCESS | 31109 | _x_x_mozilla_page_load_details 05:40:47 INFO - PROCESS | 31109 | |i|pagename|runs| 05:40:47 INFO - PROCESS | 31109 | |0;ai-astar;111;106;114;113;113;113;112;111;110;112 05:40:47 INFO - PROCESS | 31109 | |1;audio-beat-detection;150;128;151;190;134;160;158;133;182;134 05:40:47 INFO - PROCESS | 31109 | |2;audio-dft;164;164;161;164;163;172;165;162;161;162 05:40:47 INFO - PROCESS | 31109 | |3;audio-fft;77;75;75;160;75;78;75;75;168;75 05:40:47 INFO - PROCESS | 31109 | |4;audio-oscillator;84;84;149;84;85;84;141;86;86;143 05:40:47 INFO - PROCESS | 31109 | |5;imaging-gaussian-blur;117;118;117;118;117;117;117;117;118;118 05:40:47 INFO - PROCESS | 31109 | |6;imaging-darkroom;147;146;147;147;147;147;147;148;147;147 05:40:47 INFO - PROCESS | 31109 | |7;imaging-desaturate;96;96;96;96;96;96;95;96;96;95 05:40:47 INFO - PROCESS | 31109 | |8;json-parse-financial;56;57;54;54;55;55;56;57;56;54 05:40:47 INFO - PROCESS | 31109 | |9;json-stringify-tinderbox;61;63;62;61;62;61;62;61;62;62 05:40:47 INFO - PROCESS | 31109 | |10;stanford-crypto-aes;80;81;79;86;83;82;89;90;118;88 05:40:47 INFO - PROCESS | 31109 | |11;stanford-crypto-ccm;135;123;134;126;126;128;132;141;132;124 05:40:47 INFO - PROCESS | 31109 | |12;stanford-crypto-pbkdf2;158;159;162;158;166;160;166;159;158;157 05:40:47 INFO - PROCESS | 31109 | |13;stanford-crypto-sha256-iterative;65;66;64;63;65;61;65;62;65;63 05:40:47 INFO - PROCESS | 31109 | __end_tp_report 05:40:47 INFO - PROCESS | 31109 | __start_cc_report 05:40:47 INFO - PROCESS | 31109 | _x_x_mozilla_cycle_collect,912 05:40:47 INFO - PROCESS | 31109 | __end_cc_report 05:40:47 INFO - PROCESS | 31109 | __startTimestamp1465216847657__endTimestamp 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | ------- Summary: start ------- 05:40:47 INFO - PROCESS | 31109 | Number of tests: 14 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:2.27 (2.0%) stddev-sans-first:2.40 05:40:47 INFO - PROCESS | 31109 | Values: 111.0 106.0 114.0 113.0 113.0 113.0 112.0 111.0 110.0 112.0 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:154.50 stddev:21.17 (13.7%) stddev-sans-first:22.44 05:40:47 INFO - PROCESS | 31109 | Values: 150.0 128.0 151.0 190.0 134.0 160.0 158.0 133.0 182.0 134.0 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:3.19 (1.9%) stddev-sans-first:3.38 05:40:47 INFO - PROCESS | 31109 | Values: 164.0 164.0 161.0 164.0 163.0 172.0 165.0 162.0 161.0 162.0 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | [#3] audio-fft Cycles:10 Average:93.30 Median:75.00 stddev:37.32 (49.8%) stddev-sans-first:39.12 05:40:47 INFO - PROCESS | 31109 | Values: 77.0 75.0 75.0 160.0 75.0 78.0 75.0 75.0 168.0 75.0 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:84.00 stddev:28.88 (34.4%) stddev-sans-first:29.83 05:40:47 INFO - PROCESS | 31109 | Values: 84.0 84.0 149.0 84.0 85.0 84.0 141.0 86.0 86.0 143.0 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:40:47 INFO - PROCESS | 31109 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 05:40:47 INFO - PROCESS | 31109 | Values: 147.0 146.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:40:47 INFO - PROCESS | 31109 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.17 (2.1%) stddev-sans-first:1.22 05:40:47 INFO - PROCESS | 31109 | Values: 56.0 57.0 54.0 54.0 55.0 55.0 56.0 57.0 56.0 54.0 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 05:40:47 INFO - PROCESS | 31109 | Values: 61.0 63.0 62.0 61.0 62.0 61.0 62.0 61.0 62.0 62.0 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:84.50 stddev:11.36 (13.4%) stddev-sans-first:11.72 05:40:47 INFO - PROCESS | 31109 | Values: 80.0 81.0 79.0 86.0 83.0 82.0 89.0 90.0 118.0 88.0 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:132.00 stddev:5.69 (4.3%) stddev-sans-first:5.75 05:40:47 INFO - PROCESS | 31109 | Values: 135.0 123.0 134.0 126.0 126.0 128.0 132.0 141.0 132.0 124.0 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:159.50 stddev:3.30 (2.1%) stddev-sans-first:3.40 05:40:47 INFO - PROCESS | 31109 | Values: 158.0 159.0 162.0 158.0 166.0 160.0 166.0 159.0 158.0 157.0 05:40:47 INFO - PROCESS | 31109 | 05:40:47 INFO - PROCESS | 31109 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:65.00 stddev:1.60 (2.5%) stddev-sans-first:1.64 05:40:47 INFO - PROCESS | 31109 | Values: 65.0 66.0 64.0 63.0 65.0 61.0 65.0 62.0 65.0 63.0 05:40:47 INFO - PROCESS | 31109 | -------- Summary: end -------- 05:40:47 INFO - PROCESS | 31109 | 05:40:48 INFO - TEST-INFO | 31109: exit 0 05:40:48 INFO - TEST-OK | kraken | took 62074ms 05:40:48 INFO - SUITE-END | took 1173s 05:40:48 INFO - Completed test suite (00:19:33) 05:40:48 INFO - javascript benchmark 05:40:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7250.351369481424, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3164.1298642873207, 3171.0803866878605, 3181.5704879841214, 3200.583924089868, 3209.2939553298265, 5438.7824487020525, 5455.509004189622, 5487.807926722566, 5511.200875873001, 5511.22842802008, 5390.73046347683, 5467.917981230285, 5469.781208751645, 5503.0, 5504.064309067458, 4997.750112494379, 5011.1481048221885, 5045.091883460976, 5048.469910659383, 5082.949170508303, 4999.550040496355, 5151.81968631098, 5155.252488389181, 5176.0, 5192.636515443921, 4877.268409738532, 4925.162722337175, 4994.126027945132, 5034.244863270502, 5049.368828896388, 4907.067657145131, 4976.104301225778, 5003.949960500385, 5004.774785134641, 5006.374203224597, 4987.775550100254, 5040.747962601855, 5041.79832806691, 5049.4950504949575, 5074.695518268915, 5219.8434046978655, 5363.517283444469, 5380.946190538084, 5455.318085239345, 5460.972695136538, 5804.2744656917885, 5853.85365365865, 5857.941420585782, 5875.735591898332, 5884.47039766423, 5904.911426328608, 5911.083782013795, 5912.674802885883, 5913.497352725023, 5918.674472903988, 5322.387925388591, 5435.130379139318, 5441.075017247077, 5479.123340265538, 5481.451854814487, 5941.7623295067715, 5959.821205363846, 5999.970000149971, 6003.969980150158, 6004.729787159588, 5548.4174161713245, 5744.080947048452, 5752.165935939265, 5772.307323121252, 5772.336181339199, 5809.9832529307205, 5844.1818145459665, 5865.442782935615, 5879.941200587939, 5883.294004719461, 5659.405762394971, 5679.403662615448, 5749.798757043483, 5825.0679891217205, 5839.299284085937, 5751.4536119068625, 5752.252207213036, 5755.1367294906095, 5755.453231942959, 5771.538276937835, 4257.74453532789, 4300.440942677495, 4329.740215587075, 4363.781810909441, 4364.956350436455, 3899.0642245861354, 3908.902277443087, 3915.882523524299, 3948.861789837342, 3959.584243654375, 5545.223668686387, 5556.666600004012, 5579.497845193952, 5592.217089607459, 5611.494965453129, 5853.356130825606, 5860.589758716934, 5880.470757631833, 5900.881982360329, 5906.586538942319, 5655.6606603603095, 5690.146478028246, 5690.2887139107615, 5690.487856092889, 5697.9430205698245, 4871.585915197248, 4882.023595280958, 4897.902041959141, 4904.656674032854, 4942.406911170682, 5906.911396329058, 6106.3089915548935, 6175.3515880832765, 6181.536384771161, 6249.218847644044, 5930.11048342752, 5986.580939334205, 5988.848901112572, 6021.488173505301, 6064.696765161636, 5949.286085669747, 6165.475934545614, 6182.443580077815, 6189.102580125947, 6226.62640241587, 5628.85927851807, 5658.462446067617, 5669.631473954345, 5743.1385292206505, 5753.942460575341, 5814.534837212928, 5820.76716931335, 5837.066069428871, 5840.912386314294, 5859.0, 5626.831195064155, 5645.802396916089, 5698.658080515016, 5722.4277572242445, 5728.570357223141, 5573.804916827891, 5709.914351284817, 5741.540676745767, 5793.884122317446, 5864.9706751467675, 5563.471470210324, 5606.383297837153, 5614.6069775116985, 5617.213590097308, 5628.774849005994, 5696.857578560569, 5752.338481074563, 5783.392743761844, 5799.594028418139, 5805.535557155333, 5705.4579814917515, 5713.714314284186, 5734.5125664319, 5740.569457290803, 5818.359980402237], "value": 5397.556372310027, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.4562511239435, 635.5868685354521, 639.4756299834137, 656.4912193050385, 662.7382184037302, 38933.0, 44177.77911110444, 44259.0, 44272.0, 44426.0, 43552.56447435525, 44314.0, 44358.778206108924, 44366.77816610921, 44486.110277794425, 8700.52147131906, 8853.15894989975, 8885.289176865868, 8931.821363572724, 8934.508602026886, 8784.64861405543, 8822.470651760883, 8898.777530561756, 8904.154105360012, 8919.0, 8907.777305567348, 8913.064128266536, 8947.552622368856, 8964.282857371394, 8978.595963181673, 8876.600552975131, 8881.822363552757, 8938.597763100675, 8957.149070838292, 8976.910230897673, 8729.825403491957, 8852.247558957497, 8911.598978046004, 8924.062973387765, 8946.507942063185, 40701.796491017354, 41053.384199237036, 41085.794571027254, 41109.0, 41182.58817411817, 3602.189507360849, 3627.0, 3696.4085746280466, 3734.290484807905, 3792.393217085281, 29164.562531562042, 29259.0, 29322.413551728845, 32647.347053059042, 34150.316993660235, 4448.132614140244, 4454.866354009385, 4458.398116254297, 4586.4266966629175, 4687.859364219079, 227408.0, 229478.0, 231571.0, 232949.0, 233111.9999999983, 34582.481262781075, 35622.28755424877, 35715.464268036, 60710.0, 60982.69508652428, 37394.81302593524, 37442.25115497729, 37442.43836342457, 37537.43693844594, 37617.24765504675, 14726.779098313535, 14788.556343309718, 14837.851621483864, 14847.480338188328, 14886.70226595462, 13483.258420786755, 13491.865081349257, 13498.93250533741, 13520.053596248168, 13607.387667554984, 8279.254867061993, 8361.916380836114, 8376.036755773042, 8446.788830279169, 8518.87221691675, 3209.1816586770224, 3212.100611828692, 3235.142687187897, 3258.0714496368423, 3270.5748252727467, 1047.5439139595967, 1080.3247970018738, 1153.9307641541534, 1187.2935603316014, 1205.15036898986, 32911.506327405106, 33083.834580826944, 33193.668063319055, 33267.0, 33573.83213083919, 1099.6920862158609, 1124.4883577972003, 1154.0341322800323, 1170.6136974798296, 1212.4786341872903, 17239.0, 17431.12844357777, 17595.29618815233, 17602.207900644502, 17620.118994050245, 548582.0, 553532.0, 555279.0, 555700.0, 556763.0, 58225.417745822844, 59539.40460595339, 59699.403005970256, 59734.0, 59967.0, 1389.1942673249491, 1401.0472878442756, 1401.5234820161195, 1402.7475054490085, 1430.3205977160765, 31314.373712525165, 32738.50892236666, 33025.83487082549, 33061.33877322488, 33088.1727956803, 51713.48286517087, 52468.47531524636, 52533.212001819236, 52562.211566827296, 52759.472405275454, 360384.0, 363153.0, 365672.0, 366461.0, 367031.0, 28361.858190708914, 28836.711632884242, 28868.711312886604, 28919.277018074717, 29034.0, 49534.0, 49970.75014624903, 50642.74678626583, 51230.0, 51702.741486292325, 41696.583034170486, 41762.1647567053, 42317.78841105775, 43026.35460468033, 43438.0, 41391.0, 41890.79054604707, 42307.34619191948, 42582.57417425786, 42852.1429571413, 35726.28547428985, 41531.58468415398, 42028.15943681171, 42124.0, 42338.57661423346, 33822.49266261057, 37372.0, 37478.6252137486, 37723.43414848725, 37804.43293350657, 28354.432911341246, 28447.573286400308, 28630.85684571564, 28640.57039144373, 28938.42123157483], "value": 18811.350263232867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.432934409778, 393.73226206179805, 395.2588895820337, 397.66397394201897, 418.167845986487, 18004.0, 19086.904565477154, 19595.118219680113, 19710.0, 19801.306954256605, 18380.26478940844, 18383.172757225922, 18750.249990000382, 19114.522136946583, 19144.61710765784, 5544.22380866679, 5567.3040869891265, 5654.434556544354, 5738.282714660668, 5739.253896993385, 5600.915986260209, 5602.2436971009, 5609.52319052881, 5617.157426386055, 5684.857878553028, 5452.563794896399, 5584.664920104787, 5599.944000560004, 5627.212190293362, 5632.493075623193, 5606.55147588194, 5609.551235901118, 5631.549476041927, 5632.155176723483, 5641.26663533738, 4842.44311904132, 5000.774965126578, 5003.949960500385, 5006.974965125188, 5009.524095210949, 22679.77320226793, 22789.544209115724, 23201.187958421542, 23400.7659923402, 23524.411889702722, 709.4359983812881, 2280.8787827320584, 2284.2119468783244, 2285.371522831218, 2369.9289021329387, 14070.437182512687, 14552.547818365105, 14671.926640366837, 14734.410623575044, 14743.262836858114, 1958.7061940709007, 1990.4824745566257, 2034.1863254698092, 2060.7115003899467, 2066.070268379235, 66129.3387066128, 73694.0, 77415.6129219356, 80113.59943200304, 82246.58876705638, 10540.104091152338, 10571.20715946307, 10783.946080269548, 10834.891651083546, 11070.667879963614, 14937.626559336104, 15033.323500442506, 15122.621934451727, 15163.772543411858, 15188.088714677155, 7896.012998375203, 8113.8377232456205, 8486.769418434416, 8622.223999840044, 8754.25588824957, 8327.292180164754, 8368.37237207212, 8451.45065570736, 8532.8720069199, 8564.48613083217, 6511.967440162769, 6646.8005959821285, 6653.600783952978, 6731.697073631698, 6737.6968036438475, 1884.396992962239, 1935.3613307608455, 1937.7190307405629, 1938.6510428123074, 1977.812107849752, 960.5869476125193, 997.486294558303, 1027.0, 1054.915606751458, 1135.6309199510192, 19438.902805486166, 20171.899140504498, 20204.595908081756, 20259.696104558443, 20324.898375508026, 1025.5077562769911, 1026.594495174402, 1036.1814166808288, 1057.677408390433, 1064.0, 11074.501647425885, 11623.12826537996, 11624.6512604622, 11626.941865290619, 11707.648770536898, 493009.0, 495861.0, 508482.0, 511001.0, 514975.0, 72922.0, 83771.0, 84091.5795421019, 84655.0, 85519.5724021376, 1043.1915265669015, 1045.0907710292095, 1045.5556388534842, 1064.8136576099307, 1071.6463567022863, 17473.650526989644, 17678.116094195495, 17736.0, 17956.281748729903, 17981.820181798015, 38543.614563854004, 39350.80324598359, 39464.40803388009, 40246.1950760989, 41068.794656026526, 53077.7346113267, 53183.46816531785, 54235.0, 55044.17433738417, 55079.0, 8495.787605309917, 8638.740837774876, 8778.34162437807, 8820.11798820113, 8862.069482704223, 13273.469061237829, 13575.253361065235, 13662.93168534151, 13675.316234188449, 13768.105073170213, 11696.70758231051, 11908.821367679318, 11972.0, 12122.09084318662, 12203.267803931793, 9554.570044347882, 11787.351695656822, 11851.822222666839, 11870.287782733063, 12041.157119001586, 12044.21712588714, 12060.51757929673, 12141.15011949155, 12272.325022123869, 12302.323372214614, 7139.393151582174, 8525.275351595184, 8669.263112635497, 8831.337649676429, 8874.689385871721, 10149.39103653783, 11749.353785541878, 11870.584529541424, 11972.221805582609, 12048.216865903689], "value": 9344.755189607795, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.9925100374496, 1537.1468834796688, 1714.2714346402777, 1827.2051657528975, 1827.570520927581, 7841.647125879334, 8576.0, 8621.310295176387, 9144.679936202234, 9147.313951453634, 8617.439866408695, 8847.469151850893, 8890.64437422504, 8905.376623636348, 8919.955400223005, 2320.1647406933535, 2375.1449478187837, 2375.3111597636666, 2378.0250097460043, 2389.23544465771, 2325.0815927708545, 2335.5795956727784, 2385.153270588942, 2393.413613664655, 2394.042383046778, 2359.8230132740027, 2371.3952941999764, 2371.8932648030795, 2404.2066118181046, 2411.2404592553376, 2288.084766093559, 2315.2938353802083, 2337.742848286687, 2342.8594284342907, 2384.3562238195764, 2337.883105844701, 2347.976520234793, 2357.3752955466816, 2366.7396586375485, 2382.4282172278704, 8769.605367758466, 8887.333449991276, 8925.419847709943, 8930.0, 8938.0, 5174.275601415805, 5381.838544843661, 5389.514943655051, 5391.78432862685, 5395.7032363220005, 3426.8629254829775, 3455.94816077759, 3458.6368431314854, 3504.4743288506675, 3567.4470457079196, 1214.3624597086512, 1235.0736947289533, 1237.1031002523189, 1254.5044707340642, 1259.7669431155175, 12297.877021229762, 12354.38228088592, 12359.32023738694, 12378.62864114078, 12384.566540171141, 4580.244259697112, 4696.9060618787435, 4734.73958932262, 4767.523247675204, 4790.664653474223, 10312.690619281284, 10440.582376704846, 10456.477176141163, 10478.266521343585, 10498.527566259536, 5210.713410762444, 5239.842804715865, 5273.787028983279, 5310.415854256029, 5366.651167674088, 4333.891652708645, 4795.592374648194, 4857.344258525124, 4934.8766280843265, 4946.0355230729665, 4016.959830401717, 4061.7156799023783, 4092.196845161074, 4097.733647312974, 4165.8333666653, 1241.1754720560762, 1296.6887946892866, 1300.005495795717, 1302.2837439408477, 1309.8755618216255, 922.9769255768525, 938.1744065222697, 956.7464621875208, 971.504532688334, 975.1711045611173, 5689.43105689436, 5763.423657634203, 5788.247527821441, 5807.303123625107, 5924.437178468039, 447.483156953719, 462.4635422909409, 465.39033865635446, 467.0542152141872, 474.7460108841753, 4019.5176578810147, 4076.5311989121633, 4081.10215752534, 4091.5908409158847, 4109.157622687342, 10800.351978881292, 11212.43937803123, 11247.212695111428, 11251.943740281245, 11263.49314280843, 10832.783344333227, 10944.781104377867, 11031.944840275908, 11041.33751974884, 11057.170712196617, 8053.395995300376, 8278.172182781795, 8325.0, 8329.750107496784, 8369.916300837036, 5675.091985282335, 5678.6876721779045, 5684.147377893349, 5772.5959182856795, 5822.0684690449325, 10018.949905250427, 10264.435456049989, 10307.0, 10335.638252661121, 10465.372077675363, 10342.586296548054, 10391.06480416736, 10410.323328983592, 10441.477926103513, 10502.159827213653, 7056.364927156375, 7626.58053807046, 7889.211078892295, 7960.164182760726, 8008.519488830689, 8784.033756286675, 8792.868106978529, 8794.780130496789, 8814.030456649634, 8833.911660883308, 7744.225577442211, 7838.843223135391, 7902.723404680809, 7947.84104317922, 8165.305948994402, 7614.543127412373, 7851.0, 7871.094824095073, 7919.564423956507, 7995.720149794729, 6658.600483970978, 6778.152730908637, 6796.524243302922, 6832.350926661959, 6840.3501667341525, 5045.11710450677, 5147.716875571729, 5268.051750684914, 5269.683818970874, 5307.3100496936695, 5177.171652535576, 5192.818251361185, 5225.58195344364, 5287.154055351125, 5301.469853014668], "value": 4612.297557744801, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.9473736833421, 334.0, 336.74743942043466, 337.1217977169474, 338.3284180900913, 5416.214648875911, 5515.889682206353, 5529.7604470189535, 5575.609707320489, 5591.356993945692, 5470.671759694411, 5525.226468294432, 5529.253550770644, 5532.944670553294, 5545.77816887324, 4296.63478604319, 4312.547182545827, 4319.438472998506, 4320.913581728363, 4348.173846969082, 4207.410962465257, 4240.109576988821, 4319.157764235975, 4341.891452713691, 4354.281543545327, 4263.744175349473, 4266.5946735060115, 4279.828806847722, 4281.143771245764, 4292.59220374064, 4283.807228674686, 4296.140771845612, 4296.8281268749215, 4301.827926882921, 4309.956900431002, 3605.5312809334882, 3725.1245957200035, 3735.2716220337047, 3766.5668448128267, 3770.2271034437877, 5379.220013098118, 5380.435054319319, 5406.567044829803, 5425.755840987125, 5436.809711660073, 4898.755062246873, 4901.460839307673, 4915.410150781893, 4929.309896614477, 4944.604431645495, 5557.805476808333, 5726.513246374063, 5734.881698068878, 5753.490370873764, 5825.825225243249, 4057.7015355086382, 4082.0611259410502, 4101.774402407867, 4106.404571337169, 4126.463559737245, 5815.040518314473, 5947.4052594740615, 5956.16613674086, 5968.850778730523, 5981.641101533878, 4195.223883581547, 4196.769177695256, 4198.118395137056, 4198.916021679549, 4199.559046300155, 4220.388043733703, 4251.532331443539, 4264.957350426518, 4269.167512335127, 4280.5291417944, 4850.684705494132, 4861.6353773467135, 4873.269009648581, 4885.731284779371, 4907.975460122677, 5636.408177141423, 5641.0, 5785.247917770747, 5808.912866307009, 5823.330317013513, 1435.8205224346957, 1452.978205326921, 1460.3282490054482, 1463.7877507761316, 1471.484371097771, 907.2968449451596, 918.2424499787568, 937.704623043739, 949.5726922884729, 949.852772820214, 4970.726610036482, 4978.809323897473, 5002.574781143643, 5044.621653376012, 5062.0, 5292.708901010405, 5294.788208471618, 5319.973400132974, 5368.731563421891, 5374.990005596878, 4965.3048573199785, 5018.322526458955, 5058.342415485963, 5226.686398816008, 5715.399883012307, 3163.940080073155, 3177.7298929591243, 3178.984105079506, 3180.9363812724077, 3209.0, 6106.572539922163, 6221.129041934133, 6238.313785483593, 6240.251169859646, 6252.499800015988, 6054.424829641177, 6112.235970503687, 6140.78507252253, 6160.568760186834, 6165.691715414211, 6177.505799536116, 6190.288116866528, 6221.191245138103, 6238.844028899314, 6277.466415354655, 5791.884162316645, 5954.910676339945, 5993.850153746192, 5996.820095397145, 5996.850078748066, 5899.46904778572, 5922.860883731629, 5934.406559344031, 5936.525077993837, 5961.314448838439, 5997.260794369584, 6176.227971503562, 6201.441870231701, 6274.560780745304, 6277.591956522811, 4153.397757325231, 4172.311568591149, 4228.767417792051, 4240.215560121387, 4245.745255284693, 5725.828225153252, 5811.76752929895, 6056.0007598745715, 6057.394260573908, 6064.757409703562, 5717.142428635571, 5802.361740208489, 5810.273715785527, 5817.9127313091185, 5818.76724930998, 5741.110127930177, 5764.481196692318, 5797.391273916178, 5801.6519008859605, 5828.59199856006, 5562.805301814417, 5692.5445964321925, 5717.828465146053, 5742.913856292243, 5743.569232307677, 5752.68360240174, 5773.451522105393, 5786.855328616818, 5841.108651217674, 5851.707414629337, 5501.889962200654, 5741.1388291756575, 5762.366139724543, 5764.971175144097, 5780.855478613068], "value": 4373.036051142985, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.8294883651179, 777.6811507282016, 782.5695867272998, 805.198827166969, 866.6143566113083, 15002.39990400384, 15741.921290393531, 16361.672766544676, 16436.75344869828, 16990.235439405227, 15137.0, 15333.310001049951, 15345.462908798194, 15366.462173823918, 15395.615109622266, 783.9725609603665, 787.8621241282752, 821.2895845093981, 832.1262674192104, 841.4152164245852, 818.5907046476761, 818.9959050204741, 823.2631794543879, 824.4599787139404, 825.1006403020706, 847.8134810341714, 850.2772643253247, 852.0499642898155, 854.6367793687689, 855.4354126276659, 838.7525679924375, 840.8234270803139, 843.1694780641063, 844.5988155626059, 850.4982060584254, 613.8434699151733, 616.6916541729136, 617.5337620096798, 617.8578926846806, 618.8267285160163, 15878.0, 15881.444149454714, 15889.126098064717, 15913.124778137199, 15933.84066159335, 14482.637934051732, 14673.633159170999, 14959.0, 14965.476208332764, 15121.773173402407, 11892.524299028028, 12074.577389791315, 12333.691657708629, 12451.564195253213, 12893.67765805853, 3788.8105594720155, 3870.9612903870884, 4016.1566071124807, 4047.514298284225, 4052.0477687743355, 82722.17277827265, 84368.0, 84391.5780421094, 84917.0, 85308.14691853063, 11082.501287441923, 11486.885131148581, 11594.88405115938, 11765.176437649283, 11938.22401543897, 21643.458913527287, 21658.35024949254, 21940.45148871291, 22016.44958876041, 22115.5624884382, 8617.82764344722, 8761.737147885573, 8795.648174073094, 8913.465192088495, 8966.910330896739, 4696.553827386393, 4726.415377084223, 4730.432348118248, 4810.927836082462, 4887.169181239198, 3694.1872787987136, 3754.9249015019545, 3808.9428658570146, 3823.713221508398, 3828.0, 671.4292851076546, 679.2019377231733, 691.989620155698, 692.6398272898166, 697.7801992372387, 672.5614701402408, 738.4055835052727, 765.9544721455285, 767.9462437629312, 792.1880072925183, 9864.457454840052, 10106.39361638304, 10139.847902281472, 10204.183665306758, 10219.795604087876, 671.0739179931663, 723.8805597076529, 746.8543633991319, 761.3756719489965, 796.8246985663145, 4533.954660453419, 4587.977060114678, 4644.0, 4657.953420465819, 4658.1848176568965, 69098.65450672715, 69261.0, 70173.64913175504, 70560.64719676471, 70776.64611676909, 95679.52160239154, 96828.0, 97088.0, 98307.0, 98558.0, 55821.0, 56148.192590370316, 71772.64113679399, 84514.5774271137, 86293.0, 9096.27229821626, 9489.383190092622, 9806.166475849634, 9927.652532161628, 10176.236782241509, 37876.431853521666, 46742.532574673816, 48629.0, 51944.48055519548, 52069.47930520646, 66771.66614166897, 67887.0, 74075.6296218537, 75256.0, 77975.0, 12646.557370491988, 12822.23066616006, 12823.743525129632, 13133.934330328288, 13191.934040329737, 14609.853901460849, 14615.196164211071, 14630.487932922297, 14800.62998425048, 15059.096454212782, 14141.505047323295, 14206.573802785933, 14363.497277595234, 14586.270686465847, 15063.397464101314, 14274.857251427353, 14371.353289101806, 14528.927355363156, 14646.780298295322, 14851.702965940405, 13661.726765464437, 13735.0, 14017.649558760704, 14305.64235894111, 14625.561233163022, 10187.439690817077, 10951.069159121564, 11166.497507612014, 11349.0, 12016.279023258632, 11682.824757628472, 11743.882561174622, 11847.348395838311, 11884.560229445466, 12078.939605302268], "value": 7589.751516042096, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 114.0, 113.0, 113.0, 113.0, 112.0, 111.0, 110.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 128.0, 151.0, 190.0, 134.0, 160.0, 158.0, 133.0, 182.0, 134.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 161.0, 164.0, 163.0, 172.0, 165.0, 162.0, 161.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 160.0, 75.0, 78.0, 75.0, 75.0, 168.0, 75.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 149.0, 84.0, 85.0, 84.0, 141.0, 86.0, 86.0, 143.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 54.0, 54.0, 55.0, 55.0, 56.0, 57.0, 56.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 61.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 79.0, 86.0, 83.0, 82.0, 89.0, 90.0, 118.0, 88.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 123.0, 134.0, 126.0, 126.0, 128.0, 132.0, 141.0, 132.0, 124.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 159.0, 162.0, 158.0, 166.0, 160.0, 166.0, 159.0, 158.0, 157.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 63.0, 65.0, 61.0, 65.0, 62.0, 65.0, 63.0], "value": 63.9, "unit": "score"}]}]} 05:40:48 INFO - Return code: 0 05:40:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:40:48 ERROR - # TBPL SUCCESS # 05:40:48 INFO - Running post-action listener: _resource_record_post_action 05:40:48 INFO - ##### 05:40:48 INFO - ##### Finished run-tests step (success) 05:40:48 INFO - ##### 05:40:48 INFO - Running post-run listener: _resource_record_post_run 05:40:49 INFO - Total resource usage - Wall time: 1191s; CPU: 14.0%; Read bytes: 4096; Write bytes: 502919168; Read time: 16; Write time: 668236 05:40:49 INFO - TinderboxPrint: CPU usage
13.5% 05:40:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 05:40:49 INFO - TinderboxPrint: I/O write bytes / time
502,919,168 / 668,236 05:40:49 INFO - TinderboxPrint: CPU idle
8,217.1 (86.5%) 05:40:49 INFO - TinderboxPrint: CPU user
1,225.9 (12.9%) 05:40:49 INFO - TinderboxPrint: Swap in / out
0 / 0 05:40:49 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 211312640; Read time: 0; Write time: 417452 05:40:49 INFO - run-tests - Wall time: 1175s; CPU: 14.0%; Read bytes: 4096; Write bytes: 291606528; Read time: 16; Write time: 250784 05:40:49 INFO - Running post-run listener: _upload_blobber_files 05:40:49 INFO - Blob upload gear active. 05:40:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:40:49 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 05:40:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:40:50 INFO - (blobuploader) - INFO - Open directory for files ... 05:40:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:40:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:40:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:53 INFO - (blobuploader) - INFO - Done attempting. 05:40:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:40:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:40:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:54 INFO - (blobuploader) - INFO - Done attempting. 05:40:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:40:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:40:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:54 INFO - (blobuploader) - INFO - Done attempting. 05:40:54 INFO - (blobuploader) - INFO - Iteration through files over. 05:40:54 INFO - Return code: 0 05:40:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:40:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:40:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0deb9643fbd66302b32af63ec8aebb1a2115935ad2d14077069f2f4a28fd4ea23805cbe607626bd6b6ae553c9dc450690491e39ff0af77e2356feeadfba97f19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c50d40f8ab9460a96241d49f9fe19c0cff21fa13568bc433182f2462289855bce0eb0a37947f24d58f0e1a7b2a3855ea9a847289333344d6cde6e56f0effbba6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83764040df8fe6c360493e0f27625de2a9e3d1b2183f0ea7b087f6dee3ca5fccdf9bb071b78de466b234204b66256902281a3bfc0fdb2babe8ef956129c3faf8"} 05:40:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:40:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:40:54 INFO - Contents: 05:40:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0deb9643fbd66302b32af63ec8aebb1a2115935ad2d14077069f2f4a28fd4ea23805cbe607626bd6b6ae553c9dc450690491e39ff0af77e2356feeadfba97f19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c50d40f8ab9460a96241d49f9fe19c0cff21fa13568bc433182f2462289855bce0eb0a37947f24d58f0e1a7b2a3855ea9a847289333344d6cde6e56f0effbba6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83764040df8fe6c360493e0f27625de2a9e3d1b2183f0ea7b087f6dee3ca5fccdf9bb071b78de466b234204b66256902281a3bfc0fdb2babe8ef956129c3faf8"} 05:40:54 INFO - Running post-run listener: copy_logs_to_upload_dir 05:40:54 INFO - Copying logs to upload dir... 05:40:54 INFO - mkdir: /builds/slave/test/build/upload/logs 05:40:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.455327 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-06 05:40:54.170692) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 05:40:54.174121) ========= 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=af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0deb9643fbd66302b32af63ec8aebb1a2115935ad2d14077069f2f4a28fd4ea23805cbe607626bd6b6ae553c9dc450690491e39ff0af77e2356feeadfba97f19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c50d40f8ab9460a96241d49f9fe19c0cff21fa13568bc433182f2462289855bce0eb0a37947f24d58f0e1a7b2a3855ea9a847289333344d6cde6e56f0effbba6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83764040df8fe6c360493e0f27625de2a9e3d1b2183f0ea7b087f6dee3ca5fccdf9bb071b78de466b234204b66256902281a3bfc0fdb2babe8ef956129c3faf8"} build_url:https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0deb9643fbd66302b32af63ec8aebb1a2115935ad2d14077069f2f4a28fd4ea23805cbe607626bd6b6ae553c9dc450690491e39ff0af77e2356feeadfba97f19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c50d40f8ab9460a96241d49f9fe19c0cff21fa13568bc433182f2462289855bce0eb0a37947f24d58f0e1a7b2a3855ea9a847289333344d6cde6e56f0effbba6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83764040df8fe6c360493e0f27625de2a9e3d1b2183f0ea7b087f6dee3ca5fccdf9bb071b78de466b234204b66256902281a3bfc0fdb2babe8ef956129c3faf8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 05:40:54.201306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:40:54.202141) ========= 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=af724c981e2a0f424dbabf99000001e7-1465215351.607566-1791264664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:40:54.283831) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 05:40:54.284186) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 05:40:54.284498) ========= ========= Total master_lag: 0.18 =========