builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1466165725.61 results: success (0) buildid: 20160617023006 builduid: 3c64782603b04a8c913c5737adc00ea4 revision: 048bc3681be741fa5677744a0a30cff6a7358557 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 05:15:25.608020) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 05:15:25.608711) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 05:15:25.609012) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 05:15:25.640536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 05:15:25.640815) ========= 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=232498196343f89f466a4a9a000001c8-1466165099.349357-309396154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 05:15:25-- 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% 234M=0s 2016-06-17 05:15:25 (234 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.200835 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 05:15:25.881885) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 05:15:25.882315) ========= 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=232498196343f89f466a4a9a000001c8-1466165099.349357-309396154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.085398 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 05:15:25.981669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 05:15:25.982080) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 048bc3681be741fa5677744a0a30cff6a7358557 --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 048bc3681be741fa5677744a0a30cff6a7358557 --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=232498196343f89f466a4a9a000001c8-1466165099.349357-309396154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 05:15:26,051 truncating revision to first 12 chars 2016-06-17 05:15:26,051 Setting DEBUG logging. 2016-06-17 05:15:26,051 attempt 1/10 2016-06-17 05:15:26,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/048bc3681be7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 05:15:26,555 unpacking tar archive at: fx-team-048bc3681be7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.882682 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 05:15:26.877930) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 05:15:26.878236) ========= script_repo_revision: 048bc3681be741fa5677744a0a30cff6a7358557 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 05:15:26.878668) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 05:15:26.878956) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 05:15:26.890335) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-17 05:15:26.890920) ========= /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=232498196343f89f466a4a9a000001c8-1466165099.349357-309396154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:15:27 INFO - MultiFileLogger online at 20160617 05:15:27 in /builds/slave/test 05:15:27 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:15:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:27 INFO - {'append_to_log': False, 05:15:27 INFO - 'base_work_dir': '/builds/slave/test', 05:15:27 INFO - 'blob_upload_branch': 'Fx-Team', 05:15:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:27 INFO - 'branch': 'Fx-Team', 05:15:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:27 INFO - 'config_files': ('talos/linux_config.py',), 05:15:27 INFO - 'default_actions': ('clobber', 05:15:27 INFO - 'read-buildbot-config', 05:15:27 INFO - 'download-and-extract', 05:15:27 INFO - 'populate-webroot', 05:15:27 INFO - 'create-virtualenv', 05:15:27 INFO - 'install', 05:15:27 INFO - 'run-tests'), 05:15:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:27 INFO - 'download_minidump_stackwalk': True, 05:15:27 INFO - 'download_symbols': 'ondemand', 05:15:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:27 INFO - 'installer_path': 'installer.exe', 05:15:27 INFO - 'log_level': 'info', 05:15:27 INFO - 'log_name': 'talos', 05:15:27 INFO - 'log_to_console': True, 05:15:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:15:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:15:27 INFO - 'opt_config_files': (), 05:15:27 INFO - 'pip_index': False, 05:15:27 INFO - 'sps_profile': False, 05:15:27 INFO - 'sps_profile_interval': 0, 05:15:27 INFO - 'suite': 'dromaeojs-e10s', 05:15:27 INFO - 'system_bits': '32', 05:15:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:27 INFO - 'title': 'talos-linux64-ix-025', 05:15:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:27 INFO - 'use_talos_json': True, 05:15:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:27 INFO - 'work_dir': 'build'} 05:15:27 INFO - ##### 05:15:27 INFO - ##### Running clobber step. 05:15:27 INFO - ##### 05:15:27 INFO - Running pre-action listener: _resource_record_pre_action 05:15:27 INFO - Running main action method: clobber 05:15:27 INFO - rmtree: /builds/slave/test/build 05:15:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:29 INFO - Running post-action listener: _resource_record_post_action 05:15:29 INFO - ##### 05:15:29 INFO - ##### Finished clobber step (success) 05:15:29 INFO - ##### 05:15:29 INFO - ##### 05:15:29 INFO - ##### Running read-buildbot-config step. 05:15:29 INFO - ##### 05:15:29 INFO - Running pre-action listener: _resource_record_pre_action 05:15:29 INFO - Running main action method: read_buildbot_config 05:15:29 INFO - Using buildbot properties: 05:15:29 INFO - { 05:15:29 INFO - "project": "", 05:15:29 INFO - "product": "firefox", 05:15:29 INFO - "script_repo_revision": "production", 05:15:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:15:29 INFO - "repository": "", 05:15:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:15:29 INFO - "buildid": "20160617023006", 05:15:29 INFO - "pgo_build": "True", 05:15:29 INFO - "basedir": "/builds/slave/test", 05:15:29 INFO - "buildnumber": 484, 05:15:29 INFO - "slavename": "talos-linux64-ix-025", 05:15:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:15:29 INFO - "platform": "ubuntu64_hw", 05:15:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:15:29 INFO - "branch": "fx-team", 05:15:29 INFO - "repo_path": "integration/fx-team", 05:15:29 INFO - "revision": "048bc3681be741fa5677744a0a30cff6a7358557", 05:15:29 INFO - "stage_platform": "linux64-pgo", 05:15:29 INFO - "builduid": "3c64782603b04a8c913c5737adc00ea4", 05:15:29 INFO - "slavebuilddir": "test" 05:15:29 INFO - } 05:15:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:15:29 INFO - Running post-action listener: _resource_record_post_action 05:15:29 INFO - ##### 05:15:29 INFO - ##### Finished read-buildbot-config step (success) 05:15:29 INFO - ##### 05:15:29 INFO - ##### 05:15:29 INFO - ##### Running download-and-extract step. 05:15:29 INFO - ##### 05:15:29 INFO - Running pre-action listener: _resource_record_pre_action 05:15:29 INFO - Running main action method: download_and_extract 05:15:29 INFO - mkdir: /builds/slave/test/build/tests 05:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:29 INFO - https://queue.taskcluster.net/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:15:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:15:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:15:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:15:29 INFO - Downloaded 1361 bytes. 05:15:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:15:29 INFO - Using the following test package requirements: 05:15:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:15:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:15:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:15:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:29 INFO - u'jsshell-linux-x86_64.zip'], 05:15:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:15:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:15:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:15:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:15:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:15:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:15:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:29 INFO - https://queue.taskcluster.net/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:15:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:15:31 INFO - Downloaded 24220995 bytes. 05:15:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:15:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:15:32 INFO - Return code: 0 05:15:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:32 INFO - https://queue.taskcluster.net/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:15:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:15:39 INFO - Downloaded 24220995 bytes. 05:15:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:15:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:15:40 INFO - Return code: 0 05:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:40 INFO - https://queue.taskcluster.net/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:15:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:15:41 INFO - Downloaded 14405384 bytes. 05:15:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:15:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:15:42 INFO - Return code: 0 05:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:42 INFO - https://queue.taskcluster.net/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:15:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:15:43 INFO - Downloaded 59402061 bytes. 05:15:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:43 INFO - mkdir: /builds/slave/test/properties 05:15:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:15:43 INFO - Writing to file /builds/slave/test/properties/build_url 05:15:43 INFO - Contents: 05:15:43 INFO - build_url:https://queue.taskcluster.net/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:44 INFO - Running post-action listener: _resource_record_post_action 05:15:44 INFO - Running post-action listener: set_extra_try_arguments 05:15:44 INFO - ##### 05:15:44 INFO - ##### Finished download-and-extract step (success) 05:15:44 INFO - ##### 05:15:44 INFO - ##### 05:15:44 INFO - ##### Running populate-webroot step. 05:15:44 INFO - ##### 05:15:44 INFO - Running pre-action listener: _resource_record_pre_action 05:15:44 INFO - Running main action method: populate_webroot 05:15:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:15:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:15:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:15:44 INFO - '--tppagecycles', 05:15:44 INFO - '7'], 05:15:44 INFO - 'tests': ['tsvgm']}}, 05:15:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:15:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:15:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:15:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:15:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:15:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:15:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:44 INFO - 'talos_options': ['--disable-e10s'], 05:15:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:44 INFO - 'talos_options': ['--disable-e10s'], 05:15:44 INFO - 'tests': ['damp', 'tps']}, 05:15:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:44 INFO - 'tests': ['damp', 'tps']}, 05:15:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:15:44 INFO - 'tests': ['dromaeo_dom']}, 05:15:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:15:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:15:44 INFO - 'tests': ['basic_compositor_video']}, 05:15:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:15:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:15:44 INFO - 'tests': ['a11yr', 05:15:44 INFO - 'ts_paint', 05:15:44 INFO - 'tpaint', 05:15:44 INFO - 'sessionrestore', 05:15:44 INFO - 'sessionrestore_no_auto_restore', 05:15:44 INFO - 'tabpaint']}, 05:15:44 INFO - 'other-e10s': {'tests': ['a11yr', 05:15:44 INFO - 'ts_paint', 05:15:44 INFO - 'tpaint', 05:15:44 INFO - 'sessionrestore', 05:15:44 INFO - 'sessionrestore_no_auto_restore', 05:15:44 INFO - 'tabpaint']}, 05:15:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:15:44 INFO - 'ts_paint', 05:15:44 INFO - 'tpaint', 05:15:44 INFO - 'sessionrestore', 05:15:44 INFO - 'sessionrestore_no_auto_restore', 05:15:44 INFO - 'tabpaint']}, 05:15:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:15:44 INFO - 'ts_paint', 05:15:44 INFO - 'tpaint', 05:15:44 INFO - 'sessionrestore', 05:15:44 INFO - 'sessionrestore_no_auto_restore', 05:15:44 INFO - 'tabpaint']}, 05:15:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:15:44 INFO - 'tests': ['a11yr', 05:15:44 INFO - 'ts_paint', 05:15:44 INFO - 'tpaint', 05:15:44 INFO - 'sessionrestore', 05:15:44 INFO - 'sessionrestore_no_auto_restore', 05:15:44 INFO - 'tabpaint']}, 05:15:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:15:44 INFO - 'tests': ['a11yr', 05:15:44 INFO - 'ts_paint', 05:15:44 INFO - 'tpaint', 05:15:44 INFO - 'sessionrestore', 05:15:44 INFO - 'sessionrestore_no_auto_restore', 05:15:44 INFO - 'tabpaint']}, 05:15:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:15:44 INFO - 'tests': ['tsvgx', 05:15:44 INFO - 'tsvgr_opacity', 05:15:44 INFO - 'tart', 05:15:44 INFO - 'tscrollx', 05:15:44 INFO - 'cart']}, 05:15:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:15:44 INFO - 'tsvgr_opacity', 05:15:44 INFO - 'tart', 05:15:44 INFO - 'tscrollx', 05:15:44 INFO - 'cart']}, 05:15:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:44 INFO - 'talos_options': ['--disable-e10s'], 05:15:44 INFO - 'tests': ['tp5o']}, 05:15:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:44 INFO - 'tests': ['tp5o']}, 05:15:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:44 INFO - 'talos_options': ['--disable-e10s', 05:15:44 INFO - '--xperf_path', 05:15:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:44 INFO - 'tests': ['tp5n']}, 05:15:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:44 INFO - 'talos_options': ['--xperf_path', 05:15:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:44 INFO - 'tests': ['tp5n']}}, 05:15:44 INFO - 'talos.zip': {'path': '', 05:15:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:15:44 INFO - Running post-action listener: _resource_record_post_action 05:15:44 INFO - ##### 05:15:44 INFO - ##### Finished populate-webroot step (success) 05:15:44 INFO - ##### 05:15:44 INFO - ##### 05:15:44 INFO - ##### Running create-virtualenv step. 05:15:44 INFO - ##### 05:15:44 INFO - Running pre-action listener: _resource_record_pre_action 05:15:44 INFO - Running main action method: create_virtualenv 05:15:44 INFO - Creating virtualenv /builds/slave/test/build/venv 05:15:44 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:15:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:15:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:15:44 INFO - Using real prefix '/usr' 05:15:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:15:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:15:47 INFO - Installing pip.................done. 05:15:47 INFO - Return code: 0 05:15:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f061980df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375110>, '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 0x12e1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e16c0>, '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': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', '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:15:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:15:47 INFO - Using env: {'DISPLAY': ':0', 05:15:47 INFO - 'HOME': '/home/cltbld', 05:15:47 INFO - 'LANG': 'en_US.UTF-8', 05:15:47 INFO - 'LANGUAGE': 'en_US:en', 05:15:47 INFO - 'LOGNAME': 'cltbld', 05:15:47 INFO - 'MAIL': '/var/mail/cltbld', 05:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:47 INFO - 'MOZ_NO_REMOTE': '1', 05:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:47 INFO - 'NO_EM_RESTART': '1', 05:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:47 INFO - 'PWD': '/builds/slave/test', 05:15:47 INFO - 'SHELL': '/bin/bash', 05:15:47 INFO - 'SHLVL': '1', 05:15:47 INFO - 'TERM': 'linux', 05:15:47 INFO - 'TMOUT': '86400', 05:15:47 INFO - 'USER': 'cltbld', 05:15:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', 05:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:47 INFO - '_': '/tools/buildbot/bin/python'} 05:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:47 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:15:47 INFO - Cleaning up... 05:15:47 INFO - Return code: 0 05:15:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f061980df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375110>, '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 0x12e1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e16c0>, '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': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', '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:15:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:15:47 INFO - Using env: {'DISPLAY': ':0', 05:15:47 INFO - 'HOME': '/home/cltbld', 05:15:47 INFO - 'LANG': 'en_US.UTF-8', 05:15:47 INFO - 'LANGUAGE': 'en_US:en', 05:15:47 INFO - 'LOGNAME': 'cltbld', 05:15:47 INFO - 'MAIL': '/var/mail/cltbld', 05:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:47 INFO - 'MOZ_NO_REMOTE': '1', 05:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:47 INFO - 'NO_EM_RESTART': '1', 05:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:47 INFO - 'PWD': '/builds/slave/test', 05:15:47 INFO - 'SHELL': '/bin/bash', 05:15:47 INFO - 'SHLVL': '1', 05:15:47 INFO - 'TERM': 'linux', 05:15:47 INFO - 'TMOUT': '86400', 05:15:47 INFO - 'USER': 'cltbld', 05:15:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', 05:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:47 INFO - '_': '/tools/buildbot/bin/python'} 05:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:47 INFO - Downloading/unpacking psutil>=3.1.1 05:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:15:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:49 INFO - Installing collected packages: psutil 05:15:49 INFO - Running setup.py install for psutil 05:15:49 INFO - building 'psutil._psutil_linux' extension 05:15:49 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:15:51 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:15:51 INFO - building 'psutil._psutil_posix' extension 05:15:51 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:15:51 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:15:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:51 INFO - Successfully installed psutil 05:15:51 INFO - Cleaning up... 05:15:51 INFO - Return code: 0 05:15:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:15:51 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:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:51 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:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:51 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 0x7f061980df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375110>, '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 0x12e1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e16c0>, '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': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', '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:15:51 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:15:51 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:15:51 INFO - Using env: {'DISPLAY': ':0', 05:15:51 INFO - 'HOME': '/home/cltbld', 05:15:51 INFO - 'LANG': 'en_US.UTF-8', 05:15:51 INFO - 'LANGUAGE': 'en_US:en', 05:15:51 INFO - 'LOGNAME': 'cltbld', 05:15:51 INFO - 'MAIL': '/var/mail/cltbld', 05:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:51 INFO - 'MOZ_NO_REMOTE': '1', 05:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:51 INFO - 'NO_EM_RESTART': '1', 05:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:51 INFO - 'PWD': '/builds/slave/test', 05:15:51 INFO - 'SHELL': '/bin/bash', 05:15:51 INFO - 'SHLVL': '1', 05:15:51 INFO - 'TERM': 'linux', 05:15:51 INFO - 'TMOUT': '86400', 05:15:51 INFO - 'USER': 'cltbld', 05:15:51 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', 05:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:51 INFO - '_': '/tools/buildbot/bin/python'} 05:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:15:53 INFO - Installing collected packages: mozsystemmonitor 05:15:53 INFO - Running setup.py install for mozsystemmonitor 05:15:53 INFO - Successfully installed mozsystemmonitor 05:15:53 INFO - Cleaning up... 05:15:53 INFO - Return code: 0 05:15:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:15: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:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f061980df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375110>, '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 0x12e1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e16c0>, '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': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', '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:15: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==2.5.1'] in /builds/slave/test/build 05:15: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==2.5.1 05:15:53 INFO - Using env: {'DISPLAY': ':0', 05:15:53 INFO - 'HOME': '/home/cltbld', 05:15:53 INFO - 'LANG': 'en_US.UTF-8', 05:15:53 INFO - 'LANGUAGE': 'en_US:en', 05:15:53 INFO - 'LOGNAME': 'cltbld', 05:15:53 INFO - 'MAIL': '/var/mail/cltbld', 05:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:53 INFO - 'MOZ_NO_REMOTE': '1', 05:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:53 INFO - 'NO_EM_RESTART': '1', 05:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:53 INFO - 'PWD': '/builds/slave/test', 05:15:53 INFO - 'SHELL': '/bin/bash', 05:15:53 INFO - 'SHLVL': '1', 05:15:53 INFO - 'TERM': 'linux', 05:15:53 INFO - 'TMOUT': '86400', 05:15:53 INFO - 'USER': 'cltbld', 05:15:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', 05:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:53 INFO - '_': '/tools/buildbot/bin/python'} 05:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:53 INFO - Downloading/unpacking jsonschema==2.5.1 05:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:15:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:15:55 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:15:55 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:15:55 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:15:55 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:15:55 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:15:55 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:15:56 INFO - Downloading functools32-3.2.3-2.tar.gz 05:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:15:56 INFO - warning: no files found matching '*.txt' 05:15:56 INFO - no previously-included directories found matching 'build' 05:15:56 INFO - no previously-included directories found matching 'dist' 05:15:56 INFO - no previously-included directories found matching '.git*' 05:15:56 INFO - Installing collected packages: jsonschema, functools32 05:15:56 INFO - Running setup.py install for functools32 05:15:56 INFO - warning: no files found matching '*.txt' 05:15:56 INFO - no previously-included directories found matching 'build' 05:15:56 INFO - no previously-included directories found matching 'dist' 05:15:56 INFO - no previously-included directories found matching '.git*' 05:15:56 INFO - Successfully installed jsonschema functools32 05:15:56 INFO - Cleaning up... 05:15:56 INFO - Return code: 0 05:15:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:56 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 0x7f061980df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375110>, '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 0x12e1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e16c0>, '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': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', '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:15:56 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:15:56 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:15:56 INFO - Using env: {'DISPLAY': ':0', 05:15:56 INFO - 'HOME': '/home/cltbld', 05:15:56 INFO - 'LANG': 'en_US.UTF-8', 05:15:56 INFO - 'LANGUAGE': 'en_US:en', 05:15:56 INFO - 'LOGNAME': 'cltbld', 05:15:56 INFO - 'MAIL': '/var/mail/cltbld', 05:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:56 INFO - 'MOZ_NO_REMOTE': '1', 05:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:56 INFO - 'NO_EM_RESTART': '1', 05:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:56 INFO - 'PWD': '/builds/slave/test', 05:15:56 INFO - 'SHELL': '/bin/bash', 05:15:56 INFO - 'SHLVL': '1', 05:15:56 INFO - 'TERM': 'linux', 05:15:56 INFO - 'TMOUT': '86400', 05:15:56 INFO - 'USER': 'cltbld', 05:15:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', 05:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:56 INFO - '_': '/tools/buildbot/bin/python'} 05:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:15: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:15: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:15: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:15: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:15: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:15: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:15:58 INFO - Downloading blobuploader-1.2.4.tar.gz 05:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:15:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:15:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:59 INFO - Downloading docopt-0.6.1.tar.gz 05:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:15:59 INFO - Installing collected packages: blobuploader, requests, docopt 05:15:59 INFO - Running setup.py install for blobuploader 05:15:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:15:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:15:59 INFO - Running setup.py install for requests 05:15:59 INFO - Running setup.py install for docopt 05:15:59 INFO - Successfully installed blobuploader requests docopt 05:15:59 INFO - Cleaning up... 05:15:59 INFO - Return code: 0 05:15:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:59 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 0x7f061980df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375110>, '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 0x12e1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e16c0>, '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': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', '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:15:59 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:15:59 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:15:59 INFO - Using env: {'DISPLAY': ':0', 05:15:59 INFO - 'HOME': '/home/cltbld', 05:15:59 INFO - 'LANG': 'en_US.UTF-8', 05:15:59 INFO - 'LANGUAGE': 'en_US:en', 05:15:59 INFO - 'LOGNAME': 'cltbld', 05:15:59 INFO - 'MAIL': '/var/mail/cltbld', 05:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:59 INFO - 'MOZ_NO_REMOTE': '1', 05:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:59 INFO - 'NO_EM_RESTART': '1', 05:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:59 INFO - 'PWD': '/builds/slave/test', 05:15:59 INFO - 'SHELL': '/bin/bash', 05:15:59 INFO - 'SHLVL': '1', 05:15:59 INFO - 'TERM': 'linux', 05:15:59 INFO - 'TMOUT': '86400', 05:15:59 INFO - 'USER': 'cltbld', 05:15:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', 05:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:59 INFO - '_': '/tools/buildbot/bin/python'} 05:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:00 INFO - Running setup.py (path:/tmp/pip-CiIugv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:00 INFO - Running setup.py (path:/tmp/pip-zh7HIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:00 INFO - Running setup.py (path:/tmp/pip-MS9Xxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:00 INFO - Running setup.py (path:/tmp/pip-aJRRDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:00 INFO - Running setup.py (path:/tmp/pip-72CYkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:00 INFO - Running setup.py (path:/tmp/pip-BLVDn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:00 INFO - Running setup.py (path:/tmp/pip-LdMvAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:00 INFO - Running setup.py (path:/tmp/pip-_lCklE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:00 INFO - Running setup.py (path:/tmp/pip-B9pHLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:00 INFO - Running setup.py (path:/tmp/pip-fSZUW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:00 INFO - Running setup.py (path:/tmp/pip-8x5sFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:00 INFO - Running setup.py (path:/tmp/pip-MWmf1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:00 INFO - Running setup.py (path:/tmp/pip-uCaHgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:00 INFO - Running setup.py (path:/tmp/pip-1LfYV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:01 INFO - Running setup.py (path:/tmp/pip-kS8U6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:01 INFO - Running setup.py (path:/tmp/pip-zwLrrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:01 INFO - Running setup.py (path:/tmp/pip-XTWAme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:01 INFO - Running setup.py install for manifestparser 05:16:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:01 INFO - Running setup.py install for mozcrash 05:16:01 INFO - Running setup.py install for mozdebug 05:16:01 INFO - Running setup.py install for mozdevice 05:16:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:16:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:01 INFO - Running setup.py install for mozfile 05:16:01 INFO - Running setup.py install for mozhttpd 05:16:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:01 INFO - Running setup.py install for mozinfo 05:16:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:01 INFO - Running setup.py install for mozInstall 05:16:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:02 INFO - Running setup.py install for mozleak 05:16:02 INFO - Running setup.py install for mozlog 05:16:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:02 INFO - Running setup.py install for moznetwork 05:16:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:02 INFO - Running setup.py install for mozprocess 05:16:02 INFO - Running setup.py install for mozprofile 05:16:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:02 INFO - Running setup.py install for mozrunner 05:16:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:02 INFO - Running setup.py install for mozscreenshot 05:16:02 INFO - Running setup.py install for moztest 05:16:02 INFO - Running setup.py install for mozversion 05:16:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:03 INFO - Cleaning up... 05:16:03 INFO - Return code: 0 05:16:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:03 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 0x7f061980df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375110>, '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 0x12e1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e16c0>, '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': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', '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:16:03 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:16:03 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:16:03 INFO - Using env: {'DISPLAY': ':0', 05:16:03 INFO - 'HOME': '/home/cltbld', 05:16:03 INFO - 'LANG': 'en_US.UTF-8', 05:16:03 INFO - 'LANGUAGE': 'en_US:en', 05:16:03 INFO - 'LOGNAME': 'cltbld', 05:16:03 INFO - 'MAIL': '/var/mail/cltbld', 05:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:03 INFO - 'MOZ_NO_REMOTE': '1', 05:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:03 INFO - 'NO_EM_RESTART': '1', 05:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:03 INFO - 'PWD': '/builds/slave/test', 05:16:03 INFO - 'SHELL': '/bin/bash', 05:16:03 INFO - 'SHLVL': '1', 05:16:03 INFO - 'TERM': 'linux', 05:16:03 INFO - 'TMOUT': '86400', 05:16:03 INFO - 'USER': 'cltbld', 05:16:03 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', 05:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:03 INFO - '_': '/tools/buildbot/bin/python'} 05:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:03 INFO - Running setup.py (path:/tmp/pip-T5blGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:03 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:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:03 INFO - Running setup.py (path:/tmp/pip-r9bRK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:03 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:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:03 INFO - Running setup.py (path:/tmp/pip-FY_AdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:03 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:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:03 INFO - Running setup.py (path:/tmp/pip-C65UHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:03 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:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:03 INFO - Running setup.py (path:/tmp/pip-I3NUIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:03 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:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:03 INFO - Running setup.py (path:/tmp/pip-MNC3ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:03 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:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:03 INFO - Running setup.py (path:/tmp/pip-i4gIdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:03 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:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:03 INFO - Running setup.py (path:/tmp/pip-t8VP65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:03 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:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:03 INFO - Running setup.py (path:/tmp/pip-WtrWwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:03 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:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:03 INFO - Running setup.py (path:/tmp/pip-aRfBZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:03 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:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:03 INFO - Running setup.py (path:/tmp/pip-499YH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:04 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:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:04 INFO - Running setup.py (path:/tmp/pip-Npv1TJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:04 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:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:04 INFO - Running setup.py (path:/tmp/pip-1lgkvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:04 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:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:04 INFO - Running setup.py (path:/tmp/pip-rsgKqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:04 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:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:04 INFO - Running setup.py (path:/tmp/pip-aHHdg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:04 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:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:04 INFO - Running setup.py (path:/tmp/pip-iOk2pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:04 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:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:04 INFO - Running setup.py (path:/tmp/pip-0qza7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:04 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:16:04 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:16:04 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:16:04 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:16:04 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:16:04 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:16:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:04 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:16:04 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:16:04 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:16:04 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:16:04 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:16:04 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:16:06 INFO - Downloading blessings-1.6.tar.gz 05:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:16:06 INFO - Installing collected packages: blessings 05:16:06 INFO - Running setup.py install for blessings 05:16:06 INFO - Successfully installed blessings 05:16:06 INFO - Cleaning up... 05:16:06 INFO - Return code: 0 05:16:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:16:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:06 INFO - Reading from file tmpfile_stdout 05:16:06 INFO - Current package versions: 05:16:06 INFO - argparse == 1.2.1 05:16:06 INFO - blessings == 1.6 05:16:06 INFO - blobuploader == 1.2.4 05:16:06 INFO - docopt == 0.6.1 05:16:06 INFO - functools32 == 3.2.3-2 05:16:06 INFO - jsonschema == 2.5.1 05:16:06 INFO - manifestparser == 1.1 05:16:06 INFO - mozInstall == 1.12 05:16:06 INFO - mozcrash == 0.17 05:16:06 INFO - mozdebug == 0.1 05:16:06 INFO - mozdevice == 0.48 05:16:06 INFO - mozfile == 1.2 05:16:06 INFO - mozhttpd == 0.7 05:16:06 INFO - mozinfo == 0.9 05:16:06 INFO - mozleak == 0.1 05:16:06 INFO - mozlog == 3.2 05:16:06 INFO - moznetwork == 0.27 05:16:06 INFO - mozprocess == 0.22 05:16:06 INFO - mozprofile == 0.28 05:16:06 INFO - mozrunner == 6.11 05:16:06 INFO - mozscreenshot == 0.1 05:16:06 INFO - mozsystemmonitor == 0.3 05:16:06 INFO - moztest == 0.7 05:16:06 INFO - mozversion == 1.4 05:16:06 INFO - psutil == 3.1.1 05:16:06 INFO - requests == 1.2.3 05:16:06 INFO - wsgiref == 0.1.2 05:16:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:06 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:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:06 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:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:06 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 0x7f061980df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375110>, '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 0x12e1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e16c0>, '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': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', '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:16:06 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:16:06 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:16:06 INFO - Using env: {'DISPLAY': ':0', 05:16:06 INFO - 'HOME': '/home/cltbld', 05:16:06 INFO - 'LANG': 'en_US.UTF-8', 05:16:06 INFO - 'LANGUAGE': 'en_US:en', 05:16:06 INFO - 'LOGNAME': 'cltbld', 05:16:06 INFO - 'MAIL': '/var/mail/cltbld', 05:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:06 INFO - 'MOZ_NO_REMOTE': '1', 05:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:06 INFO - 'NO_EM_RESTART': '1', 05:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:06 INFO - 'PWD': '/builds/slave/test', 05:16:06 INFO - 'SHELL': '/bin/bash', 05:16:06 INFO - 'SHLVL': '1', 05:16:06 INFO - 'TERM': 'linux', 05:16:06 INFO - 'TMOUT': '86400', 05:16:06 INFO - 'USER': 'cltbld', 05:16:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', 05:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:06 INFO - '_': '/tools/buildbot/bin/python'} 05:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:07 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:16:07 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:16:07 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:16:07 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:16:07 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:16:07 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:16:07 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:16:07 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:16:07 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:16:07 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:16:07 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:16:07 INFO - Cleaning up... 05:16:07 INFO - Return code: 0 05:16:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:16:07 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:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:07 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:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:07 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 0x7f061980df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375110>, '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 0x12e1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e16c0>, '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': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', '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:16:07 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:16:07 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:16:07 INFO - Using env: {'DISPLAY': ':0', 05:16:07 INFO - 'HOME': '/home/cltbld', 05:16:07 INFO - 'LANG': 'en_US.UTF-8', 05:16:07 INFO - 'LANGUAGE': 'en_US:en', 05:16:07 INFO - 'LOGNAME': 'cltbld', 05:16:07 INFO - 'MAIL': '/var/mail/cltbld', 05:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:07 INFO - 'MOZ_NO_REMOTE': '1', 05:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:07 INFO - 'NO_EM_RESTART': '1', 05:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:07 INFO - 'PWD': '/builds/slave/test', 05:16:07 INFO - 'SHELL': '/bin/bash', 05:16:07 INFO - 'SHLVL': '1', 05:16:07 INFO - 'TERM': 'linux', 05:16:07 INFO - 'TMOUT': '86400', 05:16:07 INFO - 'USER': 'cltbld', 05:16:07 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', 05:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:07 INFO - '_': '/tools/buildbot/bin/python'} 05:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:16:07 INFO - Cleaning up... 05:16:07 INFO - Return code: 0 05:16:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:16:07 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:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:07 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:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:07 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 0x7f061980df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375110>, '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 0x12e1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e16c0>, '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': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', '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:16:07 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:16:07 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:16:07 INFO - Using env: {'DISPLAY': ':0', 05:16:07 INFO - 'HOME': '/home/cltbld', 05:16:07 INFO - 'LANG': 'en_US.UTF-8', 05:16:07 INFO - 'LANGUAGE': 'en_US:en', 05:16:07 INFO - 'LOGNAME': 'cltbld', 05:16:07 INFO - 'MAIL': '/var/mail/cltbld', 05:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:07 INFO - 'MOZ_NO_REMOTE': '1', 05:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:07 INFO - 'NO_EM_RESTART': '1', 05:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:07 INFO - 'PWD': '/builds/slave/test', 05:16:07 INFO - 'SHELL': '/bin/bash', 05:16:07 INFO - 'SHLVL': '1', 05:16:07 INFO - 'TERM': 'linux', 05:16:07 INFO - 'TMOUT': '86400', 05:16:07 INFO - 'USER': 'cltbld', 05:16:07 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', 05:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:07 INFO - '_': '/tools/buildbot/bin/python'} 05:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:07 INFO - Downloading/unpacking flake8 05:16:07 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:16:07 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:16:07 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:16:07 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:16:07 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:16:07 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:16:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:16:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:16:09 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:16:09 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:16:09 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:16:09 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:16:09 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:16:09 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:16:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:16:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:16:09 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:16:09 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:16:09 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:16:09 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:16:09 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:16:09 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:16:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:16:09 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:16:09 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:16:09 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:16:09 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:16:09 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:16:09 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:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:16:10 INFO - no previously-included directories found matching 'docs/_build' 05:16:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:16:10 INFO - Running setup.py install for pep8 05:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:16:10 INFO - no previously-included directories found matching 'docs/_build' 05:16:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:16:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:16:10 INFO - Cleaning up... 05:16:10 INFO - Return code: 0 05:16:10 INFO - Running post-action listener: _resource_record_post_action 05:16:10 INFO - Running post-action listener: _start_resource_monitoring 05:16:10 INFO - Starting resource monitoring. 05:16:10 INFO - ##### 05:16:10 INFO - ##### Finished create-virtualenv step (success) 05:16:10 INFO - ##### 05:16:10 INFO - ##### 05:16:10 INFO - ##### Running install step. 05:16:10 INFO - ##### 05:16:10 INFO - Running pre-action listener: _resource_record_pre_action 05:16:10 INFO - Running main action method: install 05:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:10 INFO - Reading from file tmpfile_stdout 05:16:10 INFO - Detecting whether we're running mozinstall >=1.0... 05:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:16:10 INFO - Reading from file tmpfile_stdout 05:16:10 INFO - Output received: 05:16:10 INFO - Usage: mozinstall [options] installer 05:16:10 INFO - Options: 05:16:10 INFO - -h, --help show this help message and exit 05:16:10 INFO - -d DEST, --destination=DEST 05:16:10 INFO - Directory to install application into. [default: 05:16:10 INFO - "/builds/slave/test"] 05:16:10 INFO - --app=APP Application being installed. [default: firefox] 05:16:10 INFO - mkdir: /builds/slave/test/build/application 05:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:16:27 INFO - Reading from file tmpfile_stdout 05:16:27 INFO - Output received: 05:16:27 INFO - /builds/slave/test/build/application/firefox/firefox 05:16:27 INFO - Running post-action listener: _resource_record_post_action 05:16:27 INFO - ##### 05:16:27 INFO - ##### Finished install step (success) 05:16:27 INFO - ##### 05:16:27 INFO - ##### 05:16:27 INFO - ##### Running run-tests step. 05:16:27 INFO - ##### 05:16:27 INFO - Running pre-action listener: _resource_record_pre_action 05:16:27 INFO - Running main action method: run_tests 05:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:16:27 INFO - Python 2.7.3 05:16:27 INFO - Return code: 0 05:16:27 INFO - grabbing minidump binary from tooltool 05:16:27 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:16:27 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 0x1375110>, '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 0x12e1230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e16c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:16:27 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:16:27 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:16:27 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:16:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:16:27 INFO - Return code: 0 05:16:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:16:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:16:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:16:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:16:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:16:28 INFO - Return code: 0 05:16:28 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/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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:16:28 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/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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:16:28 INFO - Using env: {'DISPLAY': ':0', 05:16:28 INFO - 'HOME': '/home/cltbld', 05:16:28 INFO - 'LANG': 'en_US.UTF-8', 05:16:28 INFO - 'LANGUAGE': 'en_US:en', 05:16:28 INFO - 'LOGNAME': 'cltbld', 05:16:28 INFO - 'MAIL': '/var/mail/cltbld', 05:16:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:28 INFO - 'MOZ_NO_REMOTE': '1', 05:16:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:28 INFO - 'NO_EM_RESTART': '1', 05:16:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:28 INFO - 'PWD': '/builds/slave/test', 05:16:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:28 INFO - 'SHELL': '/bin/bash', 05:16:28 INFO - 'SHLVL': '1', 05:16:28 INFO - 'TERM': 'linux', 05:16:28 INFO - 'TMOUT': '86400', 05:16:28 INFO - 'USER': 'cltbld', 05:16:28 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466165099.349357-309396154', 05:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:28 INFO - '_': '/tools/buildbot/bin/python'} 05:16:28 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/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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:16:29 INFO - mozversion application_buildid: 20160617023006 05:16:29 INFO - mozversion application_changeset: 048bc3681be741fa5677744a0a30cff6a7358557 05:16:29 INFO - mozversion application_display_name: Nightly 05:16:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:16:29 INFO - mozversion application_name: Firefox 05:16:29 INFO - mozversion application_remotingname: firefox 05:16:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:16:29 INFO - mozversion application_vendor: Mozilla 05:16:29 INFO - mozversion application_version: 50.0a1 05:16:29 INFO - mozversion platform_buildid: 20160617023006 05:16:29 INFO - mozversion platform_changeset: 048bc3681be741fa5677744a0a30cff6a7358557 05:16:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:16:29 INFO - mozversion platform_version: 50.0a1 05:16:29 INFO - using testdate: 1466165789 05:16:29 INFO - actual date: 1466165789 05:16:29 INFO - starting webserver on 'localhost:32859' 05:16:29 INFO - SUITE-START | Running 2 tests 05:16:29 INFO - TEST-START | dromaeo_css 05:16:29 INFO - operating with platform_type : linux_ 05:16:29 INFO - Initialising browser for dromaeo_css test... 05:16:29 INFO - TEST-INFO | started process 3313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAIUOOP/profile http://localhost:32859/getInfo.html) 05:16:36 INFO - PROCESS | 3313 | __metrics Screen width/height:1600/1200 05:16:36 INFO - PROCESS | 3313 | colorDepth:24 05:16:36 INFO - PROCESS | 3313 | Browser inner width/height: 1024/697 05:16:36 INFO - PROCESS | 3313 | __metrics 05:16:36 ERROR - PROCESS | 3313 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:16:37 INFO - TEST-INFO | 3313: exit 0 05:16:37 INFO - Browser initialized. 05:16:37 INFO - Running cycle 1/1 for dromaeo_css test... 05:16:37 INFO - TEST-INFO | started process 3437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAIUOOP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:49 INFO - PROCESS | 3437 | RSS: Main: 185122816 05:16:49 INFO - PROCESS | 3437 | 05:17:39 INFO - PROCESS | 3437 | 1466165859449 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:19:47 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:32859/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32859/tests/dromaeo/cssquery-ext.html) 05:19:48 INFO - PROCESS | 3437 | RSS: Main: 188317696 05:19:48 INFO - PROCESS | 3437 | 05:22:50 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:32859/tests/dromaeo/cssquery-ext.html (next: http://localhost:32859/tests/dromaeo/cssquery-jquery.html) 05:22:51 INFO - PROCESS | 3437 | RSS: Main: 187551744 05:22:51 INFO - PROCESS | 3437 | 05:25:52 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:32859/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32859/tests/dromaeo/cssquery-mootools.html) 05:25:53 INFO - PROCESS | 3437 | RSS: Main: 188874752 05:25:53 INFO - PROCESS | 3437 | 05:28:55 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:32859/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32859/tests/dromaeo/cssquery-prototype.html) 05:28:55 INFO - PROCESS | 3437 | RSS: Main: 186277888 05:28:55 INFO - PROCESS | 3437 | 05:31:58 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:32859/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32859/tests/dromaeo/cssquery-yui.html) 05:31:58 INFO - PROCESS | 3437 | RSS: Main: 188706816 05:31:58 INFO - PROCESS | 3437 | 05:35:01 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:32859/tests/dromaeo/cssquery-yui.html (next: http://localhost:32859/tests/dromaeo/cssquery-dojo.html) 05:35:01 INFO - PROCESS | 3437 | RSS: Main: 189800448 05:35:01 INFO - PROCESS | 3437 | 05:35:01 INFO - PROCESS | 3437 | __start_tp_report 05:35:01 INFO - PROCESS | 3437 | _x_x_mozilla_page_load 05:35:01 INFO - PROCESS | 3437 | _x_x_mozilla_page_load_details 05:35:01 INFO - PROCESS | 3437 | |i|pagename|runs| 05:35:01 INFO - PROCESS | 3437 | |0;dojo.html;3092.6443459002217;3125.296808218153;3141.513065474851;3150.4486714824916;3155.321605854741;5429.728513574325;5434.673919564829;5452.073147564914;5491.039068163065;5554.1946417769395;5358.115910874711;5373.946260537394;5434.402215756264;5463.48096930792;5475.5072043516075;4821.6383771217215;4913.3612630358;5039.571636410909;5039.647224694273;5041.8235361762345;682.4495239075494;4939.456659767441;4948.678335908173;4983.8537136458635;5010.6993580385115;4904.901901961958;4924.409070911495;4925.433575138869;4943.678660887049;4990.051890140861;4878;4953.578945789613;4975.328330675348;4986.40163180417;5036.345275114249;4823.927641085352;4828.782704778293;4869.780859861315;4879;4894.535019173173;5337.332833395825;5355.223492593552;5369.355677318707;5369.5972802040005;5375.973120134413;5671.347795003586;5683.772649094031;5752.453516915886;5759.68321742304;5761.827145185651;5755;5799.33307669615;5805.767769289223;5811.709414529299;5875.6474611523445;5406.08096623575;5417.918731219035;5421.105517589593;5426;5439.075357189287;5753.165790960287;5897.262842144732;5911.201987731602;5916.674582897982;5943.167956486095;5782.855428614234;5787.2476578045425;5790.623609465371;5790.826275211751;5794.8551286217335;5856.472917437366;5858.912116318259;5860.794872179454;5864.70676466175;5870;5622;5637.46444087811;5650.463205995424;5686.772529098873;5820.476157145792;5602.243697100921;5630.831075067755;5674.829755107354;5712.114622233477;5742.942570574324;4385.342198670225;4411.917933960196;4429.844955426544;4445.244308467568;4462.0183559616835;3907.902302442405;3943.38877473992;3951.269015232191;3969.6625786808445;3983.7211395202057;5574.080276754371;5583.469570390806;5594.636348637326;5596;5605.775768969277;5797.4782269595935;5882.588218824641;5885.205497257901;5896.3219229788265;5947.910781338283;5428.70142142186;5441.374241962225;5454.863628409242;5468.6171967962655;5480.177973303957;4982.352294201731;4995.900081998339;4997.875053123701;5016.197408414636;5047.747612619354;5868.882622347529;5919.260092488439;5928.9407105928385;5929.0513517836935;5936.762529498772;5791.015527360359;5809.070548712186;5819.185314055951;5872.941270587239;5894.764209431574;6040.275166979991;6042.697865106639;6069.119977603311;6081.179040829431;6089.969550152221;5547.472990065938;5627.493525582717;5765.625234359753;5766.6540007598;5785.82642520725;5756.539476841926;5758.1362795581;5774.682392468455;5799.681017544076;5820.068788993741;5623.212750215055;5638.21065050885;5639.351474580476;5646.124850648156;5684.687342196054;5540.944590554204;5624.015797235549;5639.238702775237;5664.631798933056;5669.603127781016;5448.482394172547;5490.1764735288425;5496.422875598165;5545.722713864371;5670.943290567042;5712.80005199816;5732.770689172553;5732.799352022659;5734.54123670097;5758.481736643722;5612.354579223278;5616.1014237721765;5645.4072322405555;5659.9717001416375;5671.6597004179885 05:35:01 INFO - PROCESS | 3437 | |1;ext.html;579.5682216748523;632.5761739634445;636.9203849518807;645.9644719540429;648.2706954675991;41466.792666036665;42530.57469425309;42633.57366426335;46105.308420373636;46249.768751156196;43614.78192609041;43748.3437748434;43777.343339849926;43889;44372.77813610927;8940.418872773282;9067.95466022669;9068.591913363915;9081.636734530612;9096.499692516909;9003.41477803944;9028.413153145057;9083.09169083093;9083.727488175333;9119.726408207764;9077.319201059947;9146.176844084031;9155.176034156924;9155.496447695408;9170;9042.23141033013;9088.50013249271;9089.54552272387;9099.772505687411;9108.271338292921;8919;9011.41425807327;9012.369134160612;9032.322575806775;9045.005049444555;42374;42713.572864271584;42743.78628106871;42772.358414623806;42855;3457.8271086445575;3700.2414505026404;3841.635044670752;4033.4353190553347;4312.137572485484;32560.511592326133;32571.6742832571;32637.184070398194;32865.83567082149;33335.16662083467;4235.767032813194;4238.470191226097;4266.466691663542;4318.244307246219;4398.780060996969;372614;373869;373918;375328;377207;33758;57513.712431437576;57986.4201357981;58086.7095664519;58225;35120;36844;36945;37023.259534809695;37054.258914822094;15491.612709682122;15753;15766.448174313844;15774;15804.683906321809;13019.283939383235;13263.933680331536;13429;13452.991025673115;13460.93269533646;8260.958695206486;8282.17178282167;8306.335493160532;8339.708110216234;8342.791430214293;3287.227501537137;3344.2475443025123;3345.481450375196;3357.4460214064407;3359.177001634615;1022.9488525573692;1070.4326706845384;1097.8847221041835;1147.74175810442;1172.027217409565;31487.527687084712;31736.523952140735;31918.521222181687;32131.03606891797;32558.837205814292;1122.354646078508;1158.4902642837126;1188.5721140389453;1191.1852293031463;1262.772700913826;16334.346626135059;16532.173391330387;16939.407120750715;16975.575610609834;17069.31722731077;540782;544722;547102;547142;547445;56112.15831762527;56558;56723.71638141866;57088.71455642695;57308.71345643245;1332.3871019331216;1368.774152264865;1382.592135320083;1390.2631605249235;1391.8468968413467;30636.234094147825;30925;31253.374932501676;31256.749730010546;32085.518717219726;50079;50540.74729626328;50636;50809.23786143137;50974;290880;359640;362202;363126;365071;40789.592104078576;44311.55688443074;44756.32865506955;45297.77351113223;45735.771321143184;49693.75153124211;49790;49797;51009.744951275;51024.74487627538;41969.37045944252;42031.57968420399;42220.57779422167;42886.35670464883;43456.565434345255;41703;41789.58210417857;41997.79001104975;42072;42856.78571607122;36148;39402.80298598488;39631;40524.39213411742;40576.391354130305;36125.458118127724;36702.7154049607;36733.44899826451;37049.259014819014;37987.810060949516;27725.168244952685;28222.43555128927;28437;28501.42997140087;28704.282392940342 05:35:01 INFO - PROCESS | 3437 | |2;jquery.html;382.3022983055924;385.6606186555832;391.0346246949636;391.42851436902123;407.4153589598924;13844.169349838992;18070.5482362941;18657.53356166093;19786.604267914634;19808.90095549522;18132.18405171767;18515.629687406243;18820.341288054886;19417;19468.41594752156;5348.251244825728;5395.325584301962;5533.391326954032;5752.482276595106;5804.738786754606;4079.3676980068135;5707.914381284284;5738.56960727945;5851.590388672795;6250.0624906263965;6500.772472963447;6609.537332386711;6616;6630.635315057694;6635.834104147387;6532.444742196919;6590.769323073693;6654.068430419745;6660.800175994728;6663.833404164886;5005.924911126336;5812.534997200214;5819.301683797929;5822.446867547576;5854.121881717734;13900.16599004063;14005.229712365815;20703.689444658343;21252.468688282763;23055.19306824253;2232.5599988007643;2244.0350649220827;2280.8631482111127;2308.4575124845646;2910.2142421546064;9645.131938125533;9947.502624868728;10206.744831379201;13972.72054558903;14909.179995100265;1822.1253798176817;1924.4034349351746;1938.8739731917522;1952.6234005026565;1994.1524851937868;75383.24616753818;79733.60133199354;80611.99999999942;80878.19121808765;80895;10633.787324253472;10884.346939183675;10899.727506812234;11118.888811111947;11154.665360039211;15135.243237838064;15256.847431525764;15274.15992120444;15301.311440985182;15323.23383830804;8139.674413023531;8419.200175983271;8432;8472.110428405053;8529.488230706178;8098.595070246464;8201.507909525328;8222.259996600334;8433.536155511383;8434.409591328671;4616.330632058332;4712.458067322234;4764.547368000034;4769.73766442849;4816.494268101869;1908.3320837706692;1930.3050901675385;1998;2014.4460273424925;2042.3566576528347;909.2226146644656;960.4429430930044;1032.5198782566142;1078.3314345106085;1096.797092537867;18461.53846153857;18557.16492757829;18850.05749712509;18973.90513047426;19422.70865937012;948.9810203795886;959.2278216036018;990.4700984973005;995.9004099590128;1011.9392836429838;10240.64157754475;10735.892641073646;10842.578710644677;10892.836607450894;10900.1279897608;415756;427634;438007;438011;446048;90225.54887225523;92767;92963;94377.0562294382;94672;971.121135372489;992.2805965674972;1004.3572113847143;1017.5115944346607;1019.3934608907688;16895.719077924325;16953.576160596083;17092.914535427244;17313.653726925644;17721.468355949342;30761.8461907689;35390.46914296339;42843.57156428396;43328.78335608302;43729.12541749084;58210;58986.41013589809;60322;60500.697496512235;61179.08231376622;8607.784805379915;8753.080926502626;8785.385023048326;8991.055939126298;9057.728268151966;12791.296478693388;13325.800112998118;13347.399367028702;13360.93319533396;13587.59237222885;11520;11552.480138393625;11831.230969986924;11951.94024029909;12158.574449894211;11326.60356887538;11896.464659090188;11922;11954.10344224204;12127.818082728943;12217.877821221675;12231.694207644525;12345.135840491439;12348.753024939631;12627.936860316007;8680.95828500584;8730.214280714767;8804.163604457566;8881.911180888108;8904.955475222583;8995.190432861074;11235.943820280847;12170.513179472722;12211.816822747489;12298.446569904198 05:35:01 INFO - PROCESS | 3437 | |3;mootools.html;1468.3245706974792;1496.3640452807554;1593.6015996001;1717.896926184429;1738.4871462918438;7571.886421703679;8086.9595652021735;8237.58812059396;8711.607977640997;8712.433691810027;8446.155384461566;8487.448315859465;8515.872261916076;8518.787030324245;8633.95683021584;2219.844610877235;2248.4378905273684;2248.6064938635755;2255.605269077913;2257.6726374675663;2242.8990695418665;2248.898799554024;2256.6615007748806;2263.038208761278;2266.626006708891;2165.545235500547;2167.934961951144;2170.1970270999673;2217.855839370444;2239.1715065425815;2045.478403007231;2045.8670186437982;2056.5681206946483;2058.4545095549693;2062.0411508648476;2107.557412943284;2131.467133216696;2133.6586146216687;2134.807867291951;2137.732783402075;8621.69824056155;8660.523671198082;8668;8668.8699669505;8703.086175951561;4895.657303988723;4991.575716064139;5008.073506401327;5039.143345631252;5051.545360917498;3060.5256185291314;3139.136737397211;3237.9352412951607;3238.8380580971093;3263.0863358259726;1058.3438268273642;1063.3672964586058;1072.4316112460408;1074.5755426606447;1103.172620534599;11619.6514104577;11742.47158877844;11748.823767643493;11758.647240582795;11766.941165294118;4408.140412619508;4422.557744225552;4477.686561940698;4486.214912390318;4489.371487991683;9983.950080249697;10010.54952527138;10073.647422340184;10116.949415252877;10135.290529663;4948.752562371867;4950.554450099508;4973.602111831045;5049.293098966147;5052.242163675404;4107.630313271819;4601.74690392025;4697.647676424282;4718.197906355927;4742.9762851186215;3713.220223752988;3776.339140650375;3782.0355809269013;3782.4893639358334;3854.5181852268465;1132.5130194016651;1135.3528488761492;1150.5225331487338;1157.4444266752007;1159.6694941941507;873.1835733589114;970.2819913264134;990.321629683669;1004.1715584642699;1006.9597216111273;5783.739731712083;5817;5897.351291357947;5901.970490147522;6106.175666285084;406.69497876592555;409.68767514644435;411.54729797223416;414.11999501060245;418.5145231531409;3928.273269445162;4122.42286079949;4135.937960930589;4136.9793151034055;4150.024744185114;10329.586816527255;10598.894011059945;10642.308249963882;10724.892751072546;10758.73103172427;9860.16188623975;10259.58961641541;10340.896591033994;10558.419286939292;10593.523291451904;7941.761747147595;8018.919810801817;8130.186981301823;8153.8776918346275;8192.098869124391;5804.82585522435;6002;6117.235345581802;6186.876262474815;6356;9274.44353338802;9559.330846840654;9667.323287369816;9716;9806.26453016041;9593.90406095958;9879.407235565888;9930.751731206778;9976.950115249667;9992.700218993441;7665.731699390494;7727.768166955;7865.6460459280615;7905.920940790518;7906.16985216544;8380.53907035119;8409.453385529921;8418.957905210435;8445.282151017233;8496.957515212385;7245.456590755609;7535.660895259836;7642.5032372895585;7812.296893279632;7875.606219689107;7515.286047825448;7571.091469023752;7618.771436856903;7622.085349758065;7664.578448185181;6894.517383783087;6942.271061538668;6952.930470695431;6991.545549539263;6998.090248267693;5090.4655011223285;5124.666896651705;5195.9740201298755;5240.5807535397835;5280.3663560373;5240.921386179134;5344.866378340573;5366.517013468807;5420.4850539198715;5493.505584497414 05:35:01 INFO - PROCESS | 3437 | |4;prototype.html;297.97914146009776;303.79949233505886;309.3534512868105;309.599069205379;309.99380012399746;5477.67133971961;5539.9169012464845;5568.888622227558;5648.4633959773855;5714.971425142874;5596.83778665054;5598.776048958037;5603.019471592475;5606.6636001839815;5617.915731264035;4306.720063195882;4308.612224899751;4309.84915527955;4310.245707001278;4312.719673221231;4050.412690159925;4276.695607839608;4282.635975942048;4319.3802324128455;4321.157374311994;4211.094614657848;4214.4099826024385;4215.515215750197;4233.872983810491;4257.318828987362;4181.498220213563;4229.471316085489;4246.575342465729;4252.0645457999035;4259.936100958488;3490.930181396358;3708.165662725865;3728.8881333560034;3744;3747.362948298796;5376.55900223857;5396.271503347037;5480.314960629921;5489.149181876775;5489.533389661883;4809.470958194595;4824.697331720451;4826.179549476562;4849.345338379344;4867.050925069613;5603.663780173202;5788.160716696098;5827.4755272025295;5827.737751801179;5865.941340586583;4023.396490526415;4023.718339716221;4035.8587449439424;4047.5345335286524;4064.634182923551;6050.394960503959;6173.41352571505;6179.845503862394;6210.9068363974575;6219.906701399483;3998.1603863188475;4088.8773336799945;4095.9795201023803;4103.97948010258;4142.668586513072;4146.875593732193;4147.315692910696;4177.185448837447;4178.26880295947;4189.329707246887;4862.6839255448285;4878.658368948568;4885.3649025627155;4889.193283108248;4907.3620429343955;5270.863836017564;5788.88422231553;5851.912221316684;5958.463738263577;5967.552433567413;1405.5713007532597;1425.337218193545;1429.385364293343;1432.427029188333;1442.9278536073364;861.2507118806678;894.1684233662756;900.4552245891141;910.8269428808505;913.8309412758528;4990.6257030722845;4992.126377883856;5016.774245158977;5034;5044.243363495431;5300.204969254565;5328.6802791832615;5347.866303342447;5380.677159370451;5393.570703763506;4795.808167673254;5023.266972894346;5025.723585202776;5035.244713292962;5134.691918484903;2833.504136776056;2834.5464725643797;2839.673437554666;2855.457463082008;2886.5525843494293;5362.8737965027785;5385.3268341457315;5439.3200849893765;5448.404053324786;5468.234447177399;5206.349206349207;5384.78460861569;5396.433374495621;5408.486193811582;5445.482679145475;5344.812931547377;5417.3770016447825;5431.089615476929;5472.151816468454;5506.614536982453;5113.705371673944;5286.259923610621;5302.469753024667;5319.962607291541;5326.6537675050995;5001.8499445016705;5164.922526162036;5235.240890070994;5279.709615971158;5281.128613778684;5351.571874249973;5353.812616558402;5414;5423.400096971482;5468.562514998711;3688.170161713593;3743.157789497341;3761.5298087739034;3790.65884070435;3801.3917773156163;5626.2685850839125;5879.559033072622;6069.538888916731;6072.635641861502;6105.877882442415;5876.0913347893065;5931.673757943182;5935.673537955281;5950.5239580834295;5960.314563825043;5828.125781132864;5858.853528661817;5925;5942.940570594239;5945.672987985702;5600.1319795430145;5758.819442014461;5804.76780928775;5806.374215219746;5815.185873977562;5845.661735305912;5925.200097986716;5940.346561878104;5979.880402391841;6005.789797357072;5655.586103474131;5786.913196302143;5803.767849285981;5810.593258472036;5813.912791308218 05:35:01 INFO - PROCESS | 3437 | |5;yui.html;737.8302990312225;740.80739007858;769.6998170713421;779.0806847919453;792.7153734067364;14421.855781442182;15324.923375383121;16197.757033644504;16217.108059056747;16236.107014114219;14963.925180374083;15116.47092351768;15134.394624215045;15136.545903622882;15166.393344266244;669.6852479334705;784.1022029775903;803.3573141486817;803.6825453945688;815.8449894520052;801.4309840013598;803.9115697273295;805.6253841963486;808.030363563723;810.3112354498688;858.995705021474;862.1464749897588;865.3596338709341;865.6191275838643;867.0852250875324;851.0510780479751;857.2456238510102;859.4800145911759;860.6600392844854;861.2937391339104;616.6577549460048;622.5268795715243;624.5160000999261;624.9562530622858;626.3798839149255;14384.424623015067;14433.206173660445;14433.350499227456;14438.350274237579;14441.422343106367;14666.19335936523;15084.773728394082;15261.542153735405;15311.846881531153;15398.461053863173;12001.759964800742;12057.698557536132;12161.51353945841;12312.81530777039;12340.876591234062;3940.389239667856;3942.625450582219;3969.3450580654157;4009.6190861868367;4011.618896204885;75484;75830;76092.61953690251;77021;78260.99999999943;11699.181057326075;11947.283163010246;11951.103667224992;11959.461824217931;11971.52113915451;22497.100115995177;22546.887265563895;22559.88720056389;22563.09747610077;22627.66058509124;8841.292696584387;8856.512891790884;8905.955470222607;8991.145841145211;9069.183773460289;4809.278608208797;4836.613070954315;4850.078485087822;4912.828051018198;4951.257311403247;3648.689861361761;3757.8684746034305;3762.887113386603;3768.340540405473;3779.3575092234387;626.5175814622716;640.9200497162296;641.2113100885937;646.1309538670481;660.2934859700171;723.0816862584488;739.2792027772879;767.6622286194057;771.4329967473902;794.7814351053506;9717.805643887083;9977;10156.238282128723;10305.793884122275;10427.270091093551;648.4002297874447;667.746256422566;718.0736849464237;750.2834792772888;764.957927313992;4834.927476087862;4971.428285747185;4971.776270067783;4975.726335051534;4999.500049994971;91011.54494227486;95099;95327.52336238413;109430;119595;109001.45499272611;110602.44698776616;111230;111309;111774;54763.45236547663;56746.71626641841;56761.71619141878;56850.43149568534;57353.71323143441;10265.178785696977;10619.415932123808;10707.571697132027;10905.672829815117;11065.502052407823;50890.74554627203;51804.22293665673;51825.48174518206;53203;53296.73351633217;71811.28188718254;79820;80448.59775701084;81736.59131704303;83967;13527.661808454868;13758.518451854137;13765.518206862711;13965.301734913417;14357.856421435652;15424.691506169589;15443.150626715638;16071.919640401724;16384.508464746075;16575;14648.780268295772;15041.774373384189;15218.847811521742;15403.229838508254;16115.274812633694;14802.481913132988;14857.47998820036;14885.181315027778;15743.606409839846;15839.604009899846;14604.196769177797;14738.2630868454;14880.925595371953;15030.774538381715;15409.84590154084;12125.575604853788;12455.875441245471;12561.309127998047;12904.16122952005;12991.740165196832;12026.458809353775;12473.605654754361;12659.620211393672;12682.244659115588;12931.935340323238 05:35:01 INFO - PROCESS | 3437 | __end_tp_report 05:35:01 INFO - PROCESS | 3437 | __start_cc_report 05:35:01 INFO - PROCESS | 3437 | _x_x_mozilla_cycle_collect,360 05:35:01 INFO - PROCESS | 3437 | __end_cc_report 05:35:01 INFO - PROCESS | 3437 | __startTimestamp1466166901436__endTimestamp 05:35:01 INFO - PROCESS | 3437 | 05:35:01 INFO - PROCESS | 3437 | ------- Summary: start ------- 05:35:01 INFO - PROCESS | 3437 | Number of tests: 6 05:35:01 INFO - PROCESS | 3437 | 05:35:01 INFO - PROCESS | 3437 | [#0] dojo.html Cycles:165 Average:5359.89 Median:5616.10 stddev:710.63 (12.7%) stddev-sans-first:690.19 05:35:01 INFO - PROCESS | 3437 | Values: 3092.6 3125.3 3141.5 3150.4 3155.3 5429.7 5434.7 5452.1 5491.0 5554.2 5358.1 5373.9 5434.4 5463.5 5475.5 4821.6 4913.4 5039.6 5039.6 5041.8 682.4 4939.5 4948.7 4983.9 5010.7 4904.9 4924.4 4925.4 4943.7 4990.1 4878.0 4953.6 4975.3 4986.4 5036.3 4823.9 4828.8 4869.8 4879.0 4894.5 5337.3 5355.2 5369.4 5369.6 5376.0 5671.3 5683.8 5752.5 5759.7 5761.8 5755.0 5799.3 5805.8 5811.7 5875.6 5406.1 5417.9 5421.1 5426.0 5439.1 5753.2 5897.3 5911.2 5916.7 5943.2 5782.9 5787.2 5790.6 5790.8 5794.9 5856.5 5858.9 5860.8 5864.7 5870.0 5622.0 5637.5 5650.5 5686.8 5820.5 5602.2 5630.8 5674.8 5712.1 5742.9 4385.3 4411.9 4429.8 4445.2 4462.0 3907.9 3943.4 3951.3 3969.7 3983.7 5574.1 5583.5 5594.6 5596.0 5605.8 5797.5 5882.6 5885.2 5896.3 5947.9 5428.7 5441.4 5454.9 5468.6 5480.2 4982.4 4995.9 4997.9 5016.2 5047.7 5868.9 5919.3 5928.9 5929.1 5936.8 5791.0 5809.1 5819.2 5872.9 5894.8 6040.3 6042.7 6069.1 6081.2 6090.0 5547.5 5627.5 5765.6 5766.7 5785.8 5756.5 5758.1 5774.7 5799.7 5820.1 5623.2 5638.2 5639.4 5646.1 5684.7 5540.9 5624.0 5639.2 5664.6 5669.6 5448.5 5490.2 5496.4 5545.7 5670.9 5712.8 5732.8 5732.8 5734.5 5758.5 5612.4 5616.1 5645.4 5660.0 5671.7 05:35:01 INFO - PROCESS | 3437 | 05:35:01 INFO - PROCESS | 3437 | [#1] ext.html Cycles:180 Average:58067.60 Median:42014.68 stddev:114614.20 (272.8%) stddev-sans-first:114854.45 05:35:01 INFO - PROCESS | 3437 | Values: 579.6 632.6 636.9 646.0 648.3 41466.8 42530.6 42633.6 46105.3 46249.8 43614.8 43748.3 43777.3 43889.0 44372.8 8940.4 9068.0 9068.6 9081.6 9096.5 9003.4 9028.4 9083.1 9083.7 9119.7 9077.3 9146.2 9155.2 9155.5 9170.0 9042.2 9088.5 9089.5 9099.8 9108.3 8919.0 9011.4 9012.4 9032.3 9045.0 42374.0 42713.6 42743.8 42772.4 42855.0 3457.8 3700.2 3841.6 4033.4 4312.1 32560.5 32571.7 32637.2 32865.8 33335.2 4235.8 4238.5 4266.5 4318.2 4398.8 372614.0 373869.0 373918.0 375328.0 377207.0 33758.0 57513.7 57986.4 58086.7 58225.0 35120.0 36844.0 36945.0 37023.3 37054.3 15491.6 15753.0 15766.4 15774.0 15804.7 13019.3 13263.9 13429.0 13453.0 13460.9 8261.0 8282.2 8306.3 8339.7 8342.8 3287.2 3344.2 3345.5 3357.4 3359.2 1022.9 1070.4 1097.9 1147.7 1172.0 31487.5 31736.5 31918.5 32131.0 32558.8 1122.4 1158.5 1188.6 1191.2 1262.8 16334.3 16532.2 16939.4 16975.6 17069.3 540782.0 544722.0 547102.0 547142.0 547445.0 56112.2 56558.0 56723.7 57088.7 57308.7 1332.4 1368.8 1382.6 1390.3 1391.8 30636.2 30925.0 31253.4 31256.7 32085.5 50079.0 50540.7 50636.0 50809.2 50974.0 290880.0 359640.0 362202.0 363126.0 365071.0 40789.6 44311.6 44756.3 45297.8 45735.8 49693.8 49790.0 49797.0 51009.7 51024.7 41969.4 42031.6 42220.6 42886.4 43456.6 41703.0 41789.6 41997.8 42072.0 42856.8 36148.0 39402.8 39631.0 40524.4 40576.4 36125.5 36702.7 36733.4 37049.3 37987.8 27725.2 28222.4 28437.0 28501.4 28704.3 05:35:01 INFO - PROCESS | 3437 | 05:35:01 INFO - PROCESS | 3437 | [#2] jquery.html Cycles:180 Average:27339.37 Median:17886.39 stddev:71780.28 (401.3%) stddev-sans-first:71953.11 05:35:01 INFO - PROCESS | 3437 | Values: 382.3 385.7 391.0 391.4 407.4 13844.2 18070.5 18657.5 19786.6 19808.9 18132.2 18515.6 18820.3 19417.0 19468.4 5348.3 5395.3 5533.4 5752.5 5804.7 4079.4 5707.9 5738.6 5851.6 6250.1 6500.8 6609.5 6616.0 6630.6 6635.8 6532.4 6590.8 6654.1 6660.8 6663.8 5005.9 5812.5 5819.3 5822.4 5854.1 13900.2 14005.2 20703.7 21252.5 23055.2 2232.6 2244.0 2280.9 2308.5 2910.2 9645.1 9947.5 10206.7 13972.7 14909.2 1822.1 1924.4 1938.9 1952.6 1994.2 75383.2 79733.6 80612.0 80878.2 80895.0 10633.8 10884.3 10899.7 11118.9 11154.7 15135.2 15256.8 15274.2 15301.3 15323.2 8139.7 8419.2 8432.0 8472.1 8529.5 8098.6 8201.5 8222.3 8433.5 8434.4 4616.3 4712.5 4764.5 4769.7 4816.5 1908.3 1930.3 1998.0 2014.4 2042.4 909.2 960.4 1032.5 1078.3 1096.8 18461.5 18557.2 18850.1 18973.9 19422.7 949.0 959.2 990.5 995.9 1011.9 10240.6 10735.9 10842.6 10892.8 10900.1 415756.0 427634.0 438007.0 438011.0 446048.0 90225.5 92767.0 92963.0 94377.1 94672.0 971.1 992.3 1004.4 1017.5 1019.4 16895.7 16953.6 17092.9 17313.7 17721.5 30761.8 35390.5 42843.6 43328.8 43729.1 58210.0 58986.4 60322.0 60500.7 61179.1 8607.8 8753.1 8785.4 8991.1 9057.7 12791.3 13325.8 13347.4 13360.9 13587.6 11520.0 11552.5 11831.2 11951.9 12158.6 11326.6 11896.5 11922.0 11954.1 12127.8 12217.9 12231.7 12345.1 12348.8 12627.9 8681.0 8730.2 8804.2 8881.9 8905.0 8995.2 11235.9 12170.5 12211.8 12298.4 05:35:01 INFO - PROCESS | 3437 | 05:35:01 INFO - PROCESS | 3437 | [#3] mootools.html Cycles:180 Average:5635.69 Median:4922.20 stddev:3223.99 (65.5%) stddev-sans-first:3217.82 05:35:01 INFO - PROCESS | 3437 | Values: 1468.3 1496.4 1593.6 1717.9 1738.5 7571.9 8087.0 8237.6 8711.6 8712.4 8446.2 8487.4 8515.9 8518.8 8634.0 2219.8 2248.4 2248.6 2255.6 2257.7 2242.9 2248.9 2256.7 2263.0 2266.6 2165.5 2167.9 2170.2 2217.9 2239.2 2045.5 2045.9 2056.6 2058.5 2062.0 2107.6 2131.5 2133.7 2134.8 2137.7 8621.7 8660.5 8668.0 8668.9 8703.1 4895.7 4991.6 5008.1 5039.1 5051.5 3060.5 3139.1 3237.9 3238.8 3263.1 1058.3 1063.4 1072.4 1074.6 1103.2 11619.7 11742.5 11748.8 11758.6 11766.9 4408.1 4422.6 4477.7 4486.2 4489.4 9984.0 10010.5 10073.6 10116.9 10135.3 4948.8 4950.6 4973.6 5049.3 5052.2 4107.6 4601.7 4697.6 4718.2 4743.0 3713.2 3776.3 3782.0 3782.5 3854.5 1132.5 1135.4 1150.5 1157.4 1159.7 873.2 970.3 990.3 1004.2 1007.0 5783.7 5817.0 5897.4 5902.0 6106.2 406.7 409.7 411.5 414.1 418.5 3928.3 4122.4 4135.9 4137.0 4150.0 10329.6 10598.9 10642.3 10724.9 10758.7 9860.2 10259.6 10340.9 10558.4 10593.5 7941.8 8018.9 8130.2 8153.9 8192.1 5804.8 6002.0 6117.2 6186.9 6356.0 9274.4 9559.3 9667.3 9716.0 9806.3 9593.9 9879.4 9930.8 9977.0 9992.7 7665.7 7727.8 7865.6 7905.9 7906.2 8380.5 8409.5 8419.0 8445.3 8497.0 7245.5 7535.7 7642.5 7812.3 7875.6 7515.3 7571.1 7618.8 7622.1 7664.6 6894.5 6942.3 6952.9 6991.5 6998.1 5090.5 5124.7 5196.0 5240.6 5280.4 5240.9 5344.9 5366.5 5420.5 5493.5 05:35:01 INFO - PROCESS | 3437 | 05:35:01 INFO - PROCESS | 3437 | [#4] prototype.html Cycles:180 Average:4695.01 Median:5311.22 stddev:1399.55 (26.4%) stddev-sans-first:1364.01 05:35:01 INFO - PROCESS | 3437 | Values: 298.0 303.8 309.4 309.6 310.0 5477.7 5539.9 5568.9 5648.5 5715.0 5596.8 5598.8 5603.0 5606.7 5617.9 4306.7 4308.6 4309.8 4310.2 4312.7 4050.4 4276.7 4282.6 4319.4 4321.2 4211.1 4214.4 4215.5 4233.9 4257.3 4181.5 4229.5 4246.6 4252.1 4259.9 3490.9 3708.2 3728.9 3744.0 3747.4 5376.6 5396.3 5480.3 5489.1 5489.5 4809.5 4824.7 4826.2 4849.3 4867.1 5603.7 5788.2 5827.5 5827.7 5865.9 4023.4 4023.7 4035.9 4047.5 4064.6 6050.4 6173.4 6179.8 6210.9 6219.9 3998.2 4088.9 4096.0 4104.0 4142.7 4146.9 4147.3 4177.2 4178.3 4189.3 4862.7 4878.7 4885.4 4889.2 4907.4 5270.9 5788.9 5851.9 5958.5 5967.6 1405.6 1425.3 1429.4 1432.4 1442.9 861.3 894.2 900.5 910.8 913.8 4990.6 4992.1 5016.8 5034.0 5044.2 5300.2 5328.7 5347.9 5380.7 5393.6 4795.8 5023.3 5025.7 5035.2 5134.7 2833.5 2834.5 2839.7 2855.5 2886.6 5362.9 5385.3 5439.3 5448.4 5468.2 5206.3 5384.8 5396.4 5408.5 5445.5 5344.8 5417.4 5431.1 5472.2 5506.6 5113.7 5286.3 5302.5 5320.0 5326.7 5001.8 5164.9 5235.2 5279.7 5281.1 5351.6 5353.8 5414.0 5423.4 5468.6 3688.2 3743.2 3761.5 3790.7 3801.4 5626.3 5879.6 6069.5 6072.6 6105.9 5876.1 5931.7 5935.7 5950.5 5960.3 5828.1 5858.9 5925.0 5942.9 5945.7 5600.1 5758.8 5804.8 5806.4 5815.2 5845.7 5925.2 5940.3 5979.9 6005.8 5655.6 5786.9 5803.8 5810.6 5813.9 05:35:01 INFO - PROCESS | 3437 | 05:35:01 INFO - PROCESS | 3437 | [#5] yui.html Cycles:180 Average:20534.16 Median:3941.51 stddev:28609.27 (725.8%) stddev-sans-first:28650.91 05:35:01 INFO - PROCESS | 3437 | Values: 737.8 740.8 769.7 779.1 792.7 14421.9 15324.9 16197.8 16217.1 16236.1 14963.9 15116.5 15134.4 15136.5 15166.4 669.7 784.1 803.4 803.7 815.8 801.4 803.9 805.6 808.0 810.3 859.0 862.1 865.4 865.6 867.1 851.1 857.2 859.5 860.7 861.3 616.7 622.5 624.5 625.0 626.4 14384.4 14433.2 14433.4 14438.4 14441.4 14666.2 15084.8 15261.5 15311.8 15398.5 12001.8 12057.7 12161.5 12312.8 12340.9 3940.4 3942.6 3969.3 4009.6 4011.6 75484.0 75830.0 76092.6 77021.0 78261.0 11699.2 11947.3 11951.1 11959.5 11971.5 22497.1 22546.9 22559.9 22563.1 22627.7 8841.3 8856.5 8906.0 8991.1 9069.2 4809.3 4836.6 4850.1 4912.8 4951.3 3648.7 3757.9 3762.9 3768.3 3779.4 626.5 640.9 641.2 646.1 660.3 723.1 739.3 767.7 771.4 794.8 9717.8 9977.0 10156.2 10305.8 10427.3 648.4 667.7 718.1 750.3 765.0 4834.9 4971.4 4971.8 4975.7 4999.5 91011.5 95099.0 95327.5 109430.0 119595.0 109001.5 110602.4 111230.0 111309.0 111774.0 54763.5 56746.7 56761.7 56850.4 57353.7 10265.2 10619.4 10707.6 10905.7 11065.5 50890.7 51804.2 51825.5 53203.0 53296.7 71811.3 79820.0 80448.6 81736.6 83967.0 13527.7 13758.5 13765.5 13965.3 14357.9 15424.7 15443.2 16071.9 16384.5 16575.0 14648.8 15041.8 15218.8 15403.2 16115.3 14802.5 14857.5 14885.2 15743.6 15839.6 14604.2 14738.3 14880.9 15030.8 15409.8 12125.6 12455.9 12561.3 12904.2 12991.7 12026.5 12473.6 12659.6 12682.2 12931.9 05:35:01 INFO - PROCESS | 3437 | -------- Summary: end -------- 05:35:01 INFO - PROCESS | 3437 | 05:35:02 INFO - TEST-INFO | 3437: exit 0 05:35:02 INFO - TEST-OK | dromaeo_css | took 1113018ms 05:35:02 INFO - TEST-START | kraken 05:35:02 INFO - operating with platform_type : linux_ 05:35:02 INFO - Initialising browser for kraken test... 05:35:02 INFO - TEST-INFO | started process 3680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxrg2Uq/profile http://localhost:32859/getInfo.html) 05:35:07 INFO - PROCESS | 3680 | __metrics Screen width/height:1600/1200 05:35:07 INFO - PROCESS | 3680 | colorDepth:24 05:35:07 INFO - PROCESS | 3680 | Browser inner width/height: 1024/697 05:35:07 INFO - PROCESS | 3680 | __metrics 05:35:07 ERROR - PROCESS | 3680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:35:08 INFO - TEST-INFO | 3680: exit 0 05:35:08 INFO - Browser initialized. 05:35:08 INFO - Running cycle 1/1 for kraken test... 05:35:08 INFO - TEST-INFO | started process 3800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxrg2Uq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:20 INFO - PROCESS | 3800 | RSS: Main: 185081856 05:35:20 INFO - PROCESS | 3800 | 05:35:23 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:32859/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32859/tests/kraken/driver.html?testName=audio-beat-detection) 05:35:24 INFO - PROCESS | 3800 | RSS: Main: 190980096 05:35:24 INFO - PROCESS | 3800 | 05:35:26 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:32859/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32859/tests/kraken/driver.html?testName=audio-dft) 05:35:27 INFO - PROCESS | 3800 | RSS: Main: 190849024 05:35:27 INFO - PROCESS | 3800 | 05:35:30 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:32859/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32859/tests/kraken/driver.html?testName=audio-fft) 05:35:30 INFO - PROCESS | 3800 | RSS: Main: 185405440 05:35:30 INFO - PROCESS | 3800 | 05:35:33 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:32859/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32859/tests/kraken/driver.html?testName=audio-oscillator) 05:35:33 INFO - PROCESS | 3800 | RSS: Main: 185937920 05:35:33 INFO - PROCESS | 3800 | 05:35:36 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:32859/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32859/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:35:36 INFO - PROCESS | 3800 | RSS: Main: 186273792 05:35:36 INFO - PROCESS | 3800 | 05:35:39 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:32859/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32859/tests/kraken/driver.html?testName=imaging-darkroom) 05:35:40 INFO - PROCESS | 3800 | RSS: Main: 187121664 05:35:40 INFO - PROCESS | 3800 | 05:35:43 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:32859/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32859/tests/kraken/driver.html?testName=imaging-desaturate) 05:35:44 INFO - PROCESS | 3800 | RSS: Main: 184156160 05:35:44 INFO - PROCESS | 3800 | 05:35:47 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:32859/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32859/tests/kraken/driver.html?testName=json-parse-financial) 05:35:48 INFO - PROCESS | 3800 | RSS: Main: 185577472 05:35:48 INFO - PROCESS | 3800 | 05:35:49 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:32859/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32859/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:35:50 INFO - PROCESS | 3800 | RSS: Main: 186232832 05:35:50 INFO - PROCESS | 3800 | 05:35:52 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:32859/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32859/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:35:52 INFO - PROCESS | 3800 | RSS: Main: 186826752 05:35:52 INFO - PROCESS | 3800 | 05:35:54 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:32859/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32859/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:35:55 INFO - PROCESS | 3800 | RSS: Main: 186740736 05:35:55 INFO - PROCESS | 3800 | 05:35:58 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:32859/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:35:58 INFO - PROCESS | 3800 | RSS: Main: 187052032 05:35:58 INFO - PROCESS | 3800 | 05:36:01 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:32859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:36:02 INFO - PROCESS | 3800 | RSS: Main: 186646528 05:36:02 INFO - PROCESS | 3800 | 05:36:03 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:32859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32859/tests/kraken/driver.html?testName=ai-astar) 05:36:03 INFO - PROCESS | 3800 | RSS: Main: 187486208 05:36:03 INFO - PROCESS | 3800 | 05:36:03 INFO - PROCESS | 3800 | __start_tp_report 05:36:03 INFO - PROCESS | 3800 | _x_x_mozilla_page_load 05:36:03 INFO - PROCESS | 3800 | _x_x_mozilla_page_load_details 05:36:03 INFO - PROCESS | 3800 | |i|pagename|runs| 05:36:03 INFO - PROCESS | 3800 | |0;ai-astar;112;107;113;112;113;111;111;110;111;110 05:36:03 INFO - PROCESS | 3800 | |1;audio-beat-detection;159;127;160;177;128;159;162;130;184;128 05:36:03 INFO - PROCESS | 3800 | |2;audio-dft;162;162;163;161;164;175;161;162;161;164 05:36:03 INFO - PROCESS | 3800 | |3;audio-fft;77;75;75;164;76;74;75;75;171;75 05:36:03 INFO - PROCESS | 3800 | |4;audio-oscillator;89;85;140;88;85;88;143;85;85;142 05:36:03 INFO - PROCESS | 3800 | |5;imaging-gaussian-blur;118;118;118;118;118;118;118;118;119;117 05:36:03 INFO - PROCESS | 3800 | |6;imaging-darkroom;147;147;147;149;147;148;147;149;147;148 05:36:03 INFO - PROCESS | 3800 | |7;imaging-desaturate;96;95;96;96;96;96;96;96;98;95 05:36:03 INFO - PROCESS | 3800 | |8;json-parse-financial;56;58;58;58;56;57;60;57;57;59 05:36:03 INFO - PROCESS | 3800 | |9;json-stringify-tinderbox;60;62;61;61;63;62;63;62;62;61 05:36:03 INFO - PROCESS | 3800 | |10;stanford-crypto-aes;81;80;79;81;81;80;81;80;113;85 05:36:03 INFO - PROCESS | 3800 | |11;stanford-crypto-ccm;132;126;124;121;125;129;144;129;133;127 05:36:03 INFO - PROCESS | 3800 | |12;stanford-crypto-pbkdf2;168;158;167;162;163;163;162;160;159;162 05:36:03 INFO - PROCESS | 3800 | |13;stanford-crypto-sha256-iterative;73;65;65;63;63;62;64;63;62;66 05:36:03 INFO - PROCESS | 3800 | __end_tp_report 05:36:03 INFO - PROCESS | 3800 | __start_cc_report 05:36:03 INFO - PROCESS | 3800 | _x_x_mozilla_cycle_collect,918 05:36:03 INFO - PROCESS | 3800 | __end_cc_report 05:36:03 INFO - PROCESS | 3800 | __startTimestamp1466166963980__endTimestamp 05:36:03 INFO - PROCESS | 3800 | 05:36:03 INFO - PROCESS | 3800 | ------- Summary: start ------- 05:36:03 INFO - PROCESS | 3800 | Number of tests: 14 05:36:03 INFO - PROCESS | 3800 | 05:36:03 INFO - PROCESS | 3800 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.50 stddev:1.76 (1.6%) stddev-sans-first:1.83 05:36:03 INFO - PROCESS | 3800 | Values: 112.0 107.0 113.0 112.0 113.0 111.0 111.0 110.0 111.0 110.0 05:36:03 INFO - PROCESS | 3800 | 05:36:03 INFO - PROCESS | 3800 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:159.50 stddev:21.52 (13.5%) stddev-sans-first:22.65 05:36:03 INFO - PROCESS | 3800 | Values: 159.0 127.0 160.0 177.0 128.0 159.0 162.0 130.0 184.0 128.0 05:36:03 INFO - PROCESS | 3800 | 05:36:03 INFO - PROCESS | 3800 | [#2] audio-dft Cycles:10 Average:163.50 Median:162.50 stddev:4.20 (2.6%) stddev-sans-first:4.42 05:36:03 INFO - PROCESS | 3800 | Values: 162.0 162.0 163.0 161.0 164.0 175.0 161.0 162.0 161.0 164.0 05:36:03 INFO - PROCESS | 3800 | 05:36:03 INFO - PROCESS | 3800 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.00 stddev:38.94 (51.9%) stddev-sans-first:40.83 05:36:03 INFO - PROCESS | 3800 | Values: 77.0 75.0 75.0 164.0 76.0 74.0 75.0 75.0 171.0 75.0 05:36:03 INFO - PROCESS | 3800 | 05:36:03 INFO - PROCESS | 3800 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:85.00 stddev:26.73 (31.5%) stddev-sans-first:27.87 05:36:03 INFO - PROCESS | 3800 | Values: 89.0 85.0 140.0 88.0 85.0 88.0 143.0 85.0 85.0 142.0 05:36:03 INFO - PROCESS | 3800 | 05:36:03 INFO - PROCESS | 3800 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 05:36:03 INFO - PROCESS | 3800 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 119.0 117.0 05:36:03 INFO - PROCESS | 3800 | 05:36:03 INFO - PROCESS | 3800 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 05:36:03 INFO - PROCESS | 3800 | Values: 147.0 147.0 147.0 149.0 147.0 148.0 147.0 149.0 147.0 148.0 05:36:03 INFO - PROCESS | 3800 | 05:36:03 INFO - PROCESS | 3800 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 05:36:03 INFO - PROCESS | 3800 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 98.0 95.0 05:36:03 INFO - PROCESS | 3800 | 05:36:03 INFO - PROCESS | 3800 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:1.26 (2.2%) stddev-sans-first:1.20 05:36:03 INFO - PROCESS | 3800 | Values: 56.0 58.0 58.0 58.0 56.0 57.0 60.0 57.0 57.0 59.0 05:36:03 INFO - PROCESS | 3800 | 05:36:03 INFO - PROCESS | 3800 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.95 (1.5%) stddev-sans-first:0.78 05:36:03 INFO - PROCESS | 3800 | Values: 60.0 62.0 61.0 61.0 63.0 62.0 63.0 62.0 62.0 61.0 05:36:03 INFO - PROCESS | 3800 | 05:36:03 INFO - PROCESS | 3800 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:81.00 stddev:10.28 (12.7%) stddev-sans-first:10.84 05:36:03 INFO - PROCESS | 3800 | Values: 81.0 80.0 79.0 81.0 81.0 80.0 81.0 80.0 113.0 85.0 05:36:03 INFO - PROCESS | 3800 | 05:36:03 INFO - PROCESS | 3800 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:129.00 stddev:6.39 (5.0%) stddev-sans-first:6.69 05:36:04 INFO - PROCESS | 3800 | Values: 132.0 126.0 124.0 121.0 125.0 129.0 144.0 129.0 133.0 127.0 05:36:04 INFO - PROCESS | 3800 | 05:36:04 INFO - PROCESS | 3800 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:162.50 stddev:3.17 (2.0%) stddev-sans-first:2.64 05:36:04 INFO - PROCESS | 3800 | Values: 168.0 158.0 167.0 162.0 163.0 163.0 162.0 160.0 159.0 162.0 05:36:04 INFO - PROCESS | 3800 | 05:36:04 INFO - PROCESS | 3800 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.50 stddev:3.24 (5.0%) stddev-sans-first:1.41 05:36:04 INFO - PROCESS | 3800 | Values: 73.0 65.0 65.0 63.0 63.0 62.0 64.0 63.0 62.0 66.0 05:36:04 INFO - PROCESS | 3800 | -------- Summary: end -------- 05:36:04 INFO - PROCESS | 3800 | 05:36:04 INFO - TEST-INFO | 3800: exit 0 05:36:04 INFO - TEST-OK | kraken | took 62757ms 05:36:04 INFO - SUITE-END | took 1175s 05:36:05 INFO - Completed test suite (00:19:35) 05:36:05 INFO - javascript benchmark 05:36:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7185.408233841747, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.6443459002217, 3125.296808218153, 3141.513065474851, 3150.4486714824916, 3155.321605854741, 5429.728513574325, 5434.673919564829, 5452.073147564914, 5491.039068163065, 5554.1946417769395, 5358.115910874711, 5373.946260537394, 5434.402215756264, 5463.48096930792, 5475.5072043516075, 4821.6383771217215, 4913.3612630358, 5039.571636410909, 5039.647224694273, 5041.8235361762345, 682.4495239075494, 4939.456659767441, 4948.678335908173, 4983.8537136458635, 5010.6993580385115, 4904.901901961958, 4924.409070911495, 4925.433575138869, 4943.678660887049, 4990.051890140861, 4878.0, 4953.578945789613, 4975.328330675348, 4986.40163180417, 5036.345275114249, 4823.927641085352, 4828.782704778293, 4869.780859861315, 4879.0, 4894.535019173173, 5337.332833395825, 5355.223492593552, 5369.355677318707, 5369.5972802040005, 5375.973120134413, 5671.347795003586, 5683.772649094031, 5752.453516915886, 5759.68321742304, 5761.827145185651, 5755.0, 5799.33307669615, 5805.767769289223, 5811.709414529299, 5875.6474611523445, 5406.08096623575, 5417.918731219035, 5421.105517589593, 5426.0, 5439.075357189287, 5753.165790960287, 5897.262842144732, 5911.201987731602, 5916.674582897982, 5943.167956486095, 5782.855428614234, 5787.2476578045425, 5790.623609465371, 5790.826275211751, 5794.8551286217335, 5856.472917437366, 5858.912116318259, 5860.794872179454, 5864.70676466175, 5870.0, 5622.0, 5637.46444087811, 5650.463205995424, 5686.772529098873, 5820.476157145792, 5602.243697100921, 5630.831075067755, 5674.829755107354, 5712.114622233477, 5742.942570574324, 4385.342198670225, 4411.917933960196, 4429.844955426544, 4445.244308467568, 4462.0183559616835, 3907.902302442405, 3943.38877473992, 3951.269015232191, 3969.6625786808445, 3983.7211395202057, 5574.080276754371, 5583.469570390806, 5594.636348637326, 5596.0, 5605.775768969277, 5797.4782269595935, 5882.588218824641, 5885.205497257901, 5896.3219229788265, 5947.910781338283, 5428.70142142186, 5441.374241962225, 5454.863628409242, 5468.6171967962655, 5480.177973303957, 4982.352294201731, 4995.900081998339, 4997.875053123701, 5016.197408414636, 5047.747612619354, 5868.882622347529, 5919.260092488439, 5928.9407105928385, 5929.0513517836935, 5936.762529498772, 5791.015527360359, 5809.070548712186, 5819.185314055951, 5872.941270587239, 5894.764209431574, 6040.275166979991, 6042.697865106639, 6069.119977603311, 6081.179040829431, 6089.969550152221, 5547.472990065938, 5627.493525582717, 5765.625234359753, 5766.6540007598, 5785.82642520725, 5756.539476841926, 5758.1362795581, 5774.682392468455, 5799.681017544076, 5820.068788993741, 5623.212750215055, 5638.21065050885, 5639.351474580476, 5646.124850648156, 5684.687342196054, 5540.944590554204, 5624.015797235549, 5639.238702775237, 5664.631798933056, 5669.603127781016, 5448.482394172547, 5490.1764735288425, 5496.422875598165, 5545.722713864371, 5670.943290567042, 5712.80005199816, 5732.770689172553, 5732.799352022659, 5734.54123670097, 5758.481736643722, 5612.354579223278, 5616.1014237721765, 5645.4072322405555, 5659.9717001416375, 5671.6597004179885], "value": 5314.047416702092, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.5682216748523, 632.5761739634445, 636.9203849518807, 645.9644719540429, 648.2706954675991, 41466.792666036665, 42530.57469425309, 42633.57366426335, 46105.308420373636, 46249.768751156196, 43614.78192609041, 43748.3437748434, 43777.343339849926, 43889.0, 44372.77813610927, 8940.418872773282, 9067.95466022669, 9068.591913363915, 9081.636734530612, 9096.499692516909, 9003.41477803944, 9028.413153145057, 9083.09169083093, 9083.727488175333, 9119.726408207764, 9077.319201059947, 9146.176844084031, 9155.176034156924, 9155.496447695408, 9170.0, 9042.23141033013, 9088.50013249271, 9089.54552272387, 9099.772505687411, 9108.271338292921, 8919.0, 9011.41425807327, 9012.369134160612, 9032.322575806775, 9045.005049444555, 42374.0, 42713.572864271584, 42743.78628106871, 42772.358414623806, 42855.0, 3457.8271086445575, 3700.2414505026404, 3841.635044670752, 4033.4353190553347, 4312.137572485484, 32560.511592326133, 32571.6742832571, 32637.184070398194, 32865.83567082149, 33335.16662083467, 4235.767032813194, 4238.470191226097, 4266.466691663542, 4318.244307246219, 4398.780060996969, 372614.0, 373869.0, 373918.0, 375328.0, 377207.0, 33758.0, 57513.712431437576, 57986.4201357981, 58086.7095664519, 58225.0, 35120.0, 36844.0, 36945.0, 37023.259534809695, 37054.258914822094, 15491.612709682122, 15753.0, 15766.448174313844, 15774.0, 15804.683906321809, 13019.283939383235, 13263.933680331536, 13429.0, 13452.991025673115, 13460.93269533646, 8260.958695206486, 8282.17178282167, 8306.335493160532, 8339.708110216234, 8342.791430214293, 3287.227501537137, 3344.2475443025123, 3345.481450375196, 3357.4460214064407, 3359.177001634615, 1022.9488525573692, 1070.4326706845384, 1097.8847221041835, 1147.74175810442, 1172.027217409565, 31487.527687084712, 31736.523952140735, 31918.521222181687, 32131.03606891797, 32558.837205814292, 1122.354646078508, 1158.4902642837126, 1188.5721140389453, 1191.1852293031463, 1262.772700913826, 16334.346626135059, 16532.173391330387, 16939.407120750715, 16975.575610609834, 17069.31722731077, 540782.0, 544722.0, 547102.0, 547142.0, 547445.0, 56112.15831762527, 56558.0, 56723.71638141866, 57088.71455642695, 57308.71345643245, 1332.3871019331216, 1368.774152264865, 1382.592135320083, 1390.2631605249235, 1391.8468968413467, 30636.234094147825, 30925.0, 31253.374932501676, 31256.749730010546, 32085.518717219726, 50079.0, 50540.74729626328, 50636.0, 50809.23786143137, 50974.0, 290880.0, 359640.0, 362202.0, 363126.0, 365071.0, 40789.592104078576, 44311.55688443074, 44756.32865506955, 45297.77351113223, 45735.771321143184, 49693.75153124211, 49790.0, 49797.0, 51009.744951275, 51024.74487627538, 41969.37045944252, 42031.57968420399, 42220.57779422167, 42886.35670464883, 43456.565434345255, 41703.0, 41789.58210417857, 41997.79001104975, 42072.0, 42856.78571607122, 36148.0, 39402.80298598488, 39631.0, 40524.39213411742, 40576.391354130305, 36125.458118127724, 36702.7154049607, 36733.44899826451, 37049.259014819014, 37987.810060949516, 27725.168244952685, 28222.43555128927, 28437.0, 28501.42997140087, 28704.282392940342], "value": 19313.443688455853, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.3022983055924, 385.6606186555832, 391.0346246949636, 391.42851436902123, 407.4153589598924, 13844.169349838992, 18070.5482362941, 18657.53356166093, 19786.604267914634, 19808.90095549522, 18132.18405171767, 18515.629687406243, 18820.341288054886, 19417.0, 19468.41594752156, 5348.251244825728, 5395.325584301962, 5533.391326954032, 5752.482276595106, 5804.738786754606, 4079.3676980068135, 5707.914381284284, 5738.56960727945, 5851.590388672795, 6250.0624906263965, 6500.772472963447, 6609.537332386711, 6616.0, 6630.635315057694, 6635.834104147387, 6532.444742196919, 6590.769323073693, 6654.068430419745, 6660.800175994728, 6663.833404164886, 5005.924911126336, 5812.534997200214, 5819.301683797929, 5822.446867547576, 5854.121881717734, 13900.16599004063, 14005.229712365815, 20703.689444658343, 21252.468688282763, 23055.19306824253, 2232.5599988007643, 2244.0350649220827, 2280.8631482111127, 2308.4575124845646, 2910.2142421546064, 9645.131938125533, 9947.502624868728, 10206.744831379201, 13972.72054558903, 14909.179995100265, 1822.1253798176817, 1924.4034349351746, 1938.8739731917522, 1952.6234005026565, 1994.1524851937868, 75383.24616753818, 79733.60133199354, 80611.99999999942, 80878.19121808765, 80895.0, 10633.787324253472, 10884.346939183675, 10899.727506812234, 11118.888811111947, 11154.665360039211, 15135.243237838064, 15256.847431525764, 15274.15992120444, 15301.311440985182, 15323.23383830804, 8139.674413023531, 8419.200175983271, 8432.0, 8472.110428405053, 8529.488230706178, 8098.595070246464, 8201.507909525328, 8222.259996600334, 8433.536155511383, 8434.409591328671, 4616.330632058332, 4712.458067322234, 4764.547368000034, 4769.73766442849, 4816.494268101869, 1908.3320837706692, 1930.3050901675385, 1998.0, 2014.4460273424925, 2042.3566576528347, 909.2226146644656, 960.4429430930044, 1032.5198782566142, 1078.3314345106085, 1096.797092537867, 18461.53846153857, 18557.16492757829, 18850.05749712509, 18973.90513047426, 19422.70865937012, 948.9810203795886, 959.2278216036018, 990.4700984973005, 995.9004099590128, 1011.9392836429838, 10240.64157754475, 10735.892641073646, 10842.578710644677, 10892.836607450894, 10900.1279897608, 415756.0, 427634.0, 438007.0, 438011.0, 446048.0, 90225.54887225523, 92767.0, 92963.0, 94377.0562294382, 94672.0, 971.121135372489, 992.2805965674972, 1004.3572113847143, 1017.5115944346607, 1019.3934608907688, 16895.719077924325, 16953.576160596083, 17092.914535427244, 17313.653726925644, 17721.468355949342, 30761.8461907689, 35390.46914296339, 42843.57156428396, 43328.78335608302, 43729.12541749084, 58210.0, 58986.41013589809, 60322.0, 60500.697496512235, 61179.08231376622, 8607.784805379915, 8753.080926502626, 8785.385023048326, 8991.055939126298, 9057.728268151966, 12791.296478693388, 13325.800112998118, 13347.399367028702, 13360.93319533396, 13587.59237222885, 11520.0, 11552.480138393625, 11831.230969986924, 11951.94024029909, 12158.574449894211, 11326.60356887538, 11896.464659090188, 11922.0, 11954.10344224204, 12127.818082728943, 12217.877821221675, 12231.694207644525, 12345.135840491439, 12348.753024939631, 12627.936860316007, 8680.95828500584, 8730.214280714767, 8804.163604457566, 8881.911180888108, 8904.955475222583, 8995.190432861074, 11235.943820280847, 12170.513179472722, 12211.816822747489, 12298.446569904198], "value": 9244.137691229715, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.3245706974792, 1496.3640452807554, 1593.6015996001, 1717.896926184429, 1738.4871462918438, 7571.886421703679, 8086.9595652021735, 8237.58812059396, 8711.607977640997, 8712.433691810027, 8446.155384461566, 8487.448315859465, 8515.872261916076, 8518.787030324245, 8633.95683021584, 2219.844610877235, 2248.4378905273684, 2248.6064938635755, 2255.605269077913, 2257.6726374675663, 2242.8990695418665, 2248.898799554024, 2256.6615007748806, 2263.038208761278, 2266.626006708891, 2165.545235500547, 2167.934961951144, 2170.1970270999673, 2217.855839370444, 2239.1715065425815, 2045.478403007231, 2045.8670186437982, 2056.5681206946483, 2058.4545095549693, 2062.0411508648476, 2107.557412943284, 2131.467133216696, 2133.6586146216687, 2134.807867291951, 2137.732783402075, 8621.69824056155, 8660.523671198082, 8668.0, 8668.8699669505, 8703.086175951561, 4895.657303988723, 4991.575716064139, 5008.073506401327, 5039.143345631252, 5051.545360917498, 3060.5256185291314, 3139.136737397211, 3237.9352412951607, 3238.8380580971093, 3263.0863358259726, 1058.3438268273642, 1063.3672964586058, 1072.4316112460408, 1074.5755426606447, 1103.172620534599, 11619.6514104577, 11742.47158877844, 11748.823767643493, 11758.647240582795, 11766.941165294118, 4408.140412619508, 4422.557744225552, 4477.686561940698, 4486.214912390318, 4489.371487991683, 9983.950080249697, 10010.54952527138, 10073.647422340184, 10116.949415252877, 10135.290529663, 4948.752562371867, 4950.554450099508, 4973.602111831045, 5049.293098966147, 5052.242163675404, 4107.630313271819, 4601.74690392025, 4697.647676424282, 4718.197906355927, 4742.9762851186215, 3713.220223752988, 3776.339140650375, 3782.0355809269013, 3782.4893639358334, 3854.5181852268465, 1132.5130194016651, 1135.3528488761492, 1150.5225331487338, 1157.4444266752007, 1159.6694941941507, 873.1835733589114, 970.2819913264134, 990.321629683669, 1004.1715584642699, 1006.9597216111273, 5783.739731712083, 5817.0, 5897.351291357947, 5901.970490147522, 6106.175666285084, 406.69497876592555, 409.68767514644435, 411.54729797223416, 414.11999501060245, 418.5145231531409, 3928.273269445162, 4122.42286079949, 4135.937960930589, 4136.9793151034055, 4150.024744185114, 10329.586816527255, 10598.894011059945, 10642.308249963882, 10724.892751072546, 10758.73103172427, 9860.16188623975, 10259.58961641541, 10340.896591033994, 10558.419286939292, 10593.523291451904, 7941.761747147595, 8018.919810801817, 8130.186981301823, 8153.8776918346275, 8192.098869124391, 5804.82585522435, 6002.0, 6117.235345581802, 6186.876262474815, 6356.0, 9274.44353338802, 9559.330846840654, 9667.323287369816, 9716.0, 9806.26453016041, 9593.90406095958, 9879.407235565888, 9930.751731206778, 9976.950115249667, 9992.700218993441, 7665.731699390494, 7727.768166955, 7865.6460459280615, 7905.920940790518, 7906.16985216544, 8380.53907035119, 8409.453385529921, 8418.957905210435, 8445.282151017233, 8496.957515212385, 7245.456590755609, 7535.660895259836, 7642.5032372895585, 7812.296893279632, 7875.606219689107, 7515.286047825448, 7571.091469023752, 7618.771436856903, 7622.085349758065, 7664.578448185181, 6894.517383783087, 6942.271061538668, 6952.930470695431, 6991.545549539263, 6998.090248267693, 5090.4655011223285, 5124.666896651705, 5195.9740201298755, 5240.5807535397835, 5280.3663560373, 5240.921386179134, 5344.866378340573, 5366.517013468807, 5420.4850539198715, 5493.505584497414], "value": 4407.671188769953, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.97914146009776, 303.79949233505886, 309.3534512868105, 309.599069205379, 309.99380012399746, 5477.67133971961, 5539.9169012464845, 5568.888622227558, 5648.4633959773855, 5714.971425142874, 5596.83778665054, 5598.776048958037, 5603.019471592475, 5606.6636001839815, 5617.915731264035, 4306.720063195882, 4308.612224899751, 4309.84915527955, 4310.245707001278, 4312.719673221231, 4050.412690159925, 4276.695607839608, 4282.635975942048, 4319.3802324128455, 4321.157374311994, 4211.094614657848, 4214.4099826024385, 4215.515215750197, 4233.872983810491, 4257.318828987362, 4181.498220213563, 4229.471316085489, 4246.575342465729, 4252.0645457999035, 4259.936100958488, 3490.930181396358, 3708.165662725865, 3728.8881333560034, 3744.0, 3747.362948298796, 5376.55900223857, 5396.271503347037, 5480.314960629921, 5489.149181876775, 5489.533389661883, 4809.470958194595, 4824.697331720451, 4826.179549476562, 4849.345338379344, 4867.050925069613, 5603.663780173202, 5788.160716696098, 5827.4755272025295, 5827.737751801179, 5865.941340586583, 4023.396490526415, 4023.718339716221, 4035.8587449439424, 4047.5345335286524, 4064.634182923551, 6050.394960503959, 6173.41352571505, 6179.845503862394, 6210.9068363974575, 6219.906701399483, 3998.1603863188475, 4088.8773336799945, 4095.9795201023803, 4103.97948010258, 4142.668586513072, 4146.875593732193, 4147.315692910696, 4177.185448837447, 4178.26880295947, 4189.329707246887, 4862.6839255448285, 4878.658368948568, 4885.3649025627155, 4889.193283108248, 4907.3620429343955, 5270.863836017564, 5788.88422231553, 5851.912221316684, 5958.463738263577, 5967.552433567413, 1405.5713007532597, 1425.337218193545, 1429.385364293343, 1432.427029188333, 1442.9278536073364, 861.2507118806678, 894.1684233662756, 900.4552245891141, 910.8269428808505, 913.8309412758528, 4990.6257030722845, 4992.126377883856, 5016.774245158977, 5034.0, 5044.243363495431, 5300.204969254565, 5328.6802791832615, 5347.866303342447, 5380.677159370451, 5393.570703763506, 4795.808167673254, 5023.266972894346, 5025.723585202776, 5035.244713292962, 5134.691918484903, 2833.504136776056, 2834.5464725643797, 2839.673437554666, 2855.457463082008, 2886.5525843494293, 5362.8737965027785, 5385.3268341457315, 5439.3200849893765, 5448.404053324786, 5468.234447177399, 5206.349206349207, 5384.78460861569, 5396.433374495621, 5408.486193811582, 5445.482679145475, 5344.812931547377, 5417.3770016447825, 5431.089615476929, 5472.151816468454, 5506.614536982453, 5113.705371673944, 5286.259923610621, 5302.469753024667, 5319.962607291541, 5326.6537675050995, 5001.8499445016705, 5164.922526162036, 5235.240890070994, 5279.709615971158, 5281.128613778684, 5351.571874249973, 5353.812616558402, 5414.0, 5423.400096971482, 5468.562514998711, 3688.170161713593, 3743.157789497341, 3761.5298087739034, 3790.65884070435, 3801.3917773156163, 5626.2685850839125, 5879.559033072622, 6069.538888916731, 6072.635641861502, 6105.877882442415, 5876.0913347893065, 5931.673757943182, 5935.673537955281, 5950.5239580834295, 5960.314563825043, 5828.125781132864, 5858.853528661817, 5925.0, 5942.940570594239, 5945.672987985702, 5600.1319795430145, 5758.819442014461, 5804.76780928775, 5806.374215219746, 5815.185873977562, 5845.661735305912, 5925.200097986716, 5940.346561878104, 5979.880402391841, 6005.789797357072, 5655.586103474131, 5786.913196302143, 5803.767849285981, 5810.593258472036, 5813.912791308218], "value": 4236.54189746836, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.8302990312225, 740.80739007858, 769.6998170713421, 779.0806847919453, 792.7153734067364, 14421.855781442182, 15324.923375383121, 16197.757033644504, 16217.108059056747, 16236.107014114219, 14963.925180374083, 15116.47092351768, 15134.394624215045, 15136.545903622882, 15166.393344266244, 669.6852479334705, 784.1022029775903, 803.3573141486817, 803.6825453945688, 815.8449894520052, 801.4309840013598, 803.9115697273295, 805.6253841963486, 808.030363563723, 810.3112354498688, 858.995705021474, 862.1464749897588, 865.3596338709341, 865.6191275838643, 867.0852250875324, 851.0510780479751, 857.2456238510102, 859.4800145911759, 860.6600392844854, 861.2937391339104, 616.6577549460048, 622.5268795715243, 624.5160000999261, 624.9562530622858, 626.3798839149255, 14384.424623015067, 14433.206173660445, 14433.350499227456, 14438.350274237579, 14441.422343106367, 14666.19335936523, 15084.773728394082, 15261.542153735405, 15311.846881531153, 15398.461053863173, 12001.759964800742, 12057.698557536132, 12161.51353945841, 12312.81530777039, 12340.876591234062, 3940.389239667856, 3942.625450582219, 3969.3450580654157, 4009.6190861868367, 4011.618896204885, 75484.0, 75830.0, 76092.61953690251, 77021.0, 78260.99999999943, 11699.181057326075, 11947.283163010246, 11951.103667224992, 11959.461824217931, 11971.52113915451, 22497.100115995177, 22546.887265563895, 22559.88720056389, 22563.09747610077, 22627.66058509124, 8841.292696584387, 8856.512891790884, 8905.955470222607, 8991.145841145211, 9069.183773460289, 4809.278608208797, 4836.613070954315, 4850.078485087822, 4912.828051018198, 4951.257311403247, 3648.689861361761, 3757.8684746034305, 3762.887113386603, 3768.340540405473, 3779.3575092234387, 626.5175814622716, 640.9200497162296, 641.2113100885937, 646.1309538670481, 660.2934859700171, 723.0816862584488, 739.2792027772879, 767.6622286194057, 771.4329967473902, 794.7814351053506, 9717.805643887083, 9977.0, 10156.238282128723, 10305.793884122275, 10427.270091093551, 648.4002297874447, 667.746256422566, 718.0736849464237, 750.2834792772888, 764.957927313992, 4834.927476087862, 4971.428285747185, 4971.776270067783, 4975.726335051534, 4999.500049994971, 91011.54494227486, 95099.0, 95327.52336238413, 109430.0, 119595.0, 109001.45499272611, 110602.44698776616, 111230.0, 111309.0, 111774.0, 54763.45236547663, 56746.71626641841, 56761.71619141878, 56850.43149568534, 57353.71323143441, 10265.178785696977, 10619.415932123808, 10707.571697132027, 10905.672829815117, 11065.502052407823, 50890.74554627203, 51804.22293665673, 51825.48174518206, 53203.0, 53296.73351633217, 71811.28188718254, 79820.0, 80448.59775701084, 81736.59131704303, 83967.0, 13527.661808454868, 13758.518451854137, 13765.518206862711, 13965.301734913417, 14357.856421435652, 15424.691506169589, 15443.150626715638, 16071.919640401724, 16384.508464746075, 16575.0, 14648.780268295772, 15041.774373384189, 15218.847811521742, 15403.229838508254, 16115.274812633694, 14802.481913132988, 14857.47998820036, 14885.181315027778, 15743.606409839846, 15839.604009899846, 14604.196769177797, 14738.2630868454, 14880.925595371953, 15030.774538381715, 15409.84590154084, 12125.575604853788, 12455.875441245471, 12561.309127998047, 12904.16122952005, 12991.740165196832, 12026.458809353775, 12473.605654754361, 12659.620211393672, 12682.244659115588, 12931.935340323238], "value": 7767.6733424730355, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 113.0, 112.0, 113.0, 111.0, 111.0, 110.0, 111.0, 110.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 160.0, 177.0, 128.0, 159.0, 162.0, 130.0, 184.0, 128.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 164.0, 175.0, 161.0, 162.0, 161.0, 164.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 164.0, 76.0, 74.0, 75.0, 75.0, 171.0, 75.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 140.0, 88.0, 85.0, 88.0, 143.0, 85.0, 85.0, 142.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 149.0, 147.0, 148.0, 147.0, 149.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 98.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 58.0, 58.0, 56.0, 57.0, 60.0, 57.0, 57.0, 59.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 63.0, 62.0, 63.0, 62.0, 62.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 81.0, 81.0, 80.0, 81.0, 80.0, 113.0, 85.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 126.0, 124.0, 121.0, 125.0, 129.0, 144.0, 129.0, 133.0, 127.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 158.0, 167.0, 162.0, 163.0, 163.0, 162.0, 160.0, 159.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 65.0, 65.0, 63.0, 63.0, 62.0, 64.0, 63.0, 62.0, 66.0], "value": 64.6, "unit": "score"}]}]} 05:36:05 INFO - Return code: 0 05:36:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:36:05 ERROR - # TBPL SUCCESS # 05:36:05 INFO - Running post-action listener: _resource_record_post_action 05:36:05 INFO - ##### 05:36:05 INFO - ##### Finished run-tests step (success) 05:36:05 INFO - ##### 05:36:05 INFO - Running post-run listener: _resource_record_post_run 05:36:05 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7831552; Write bytes: 522895360; Read time: 1816; Write time: 427616 05:36:05 INFO - TinderboxPrint: CPU usage
13.5% 05:36:05 INFO - TinderboxPrint: I/O read bytes / time
7,831,552 / 1,816 05:36:05 INFO - TinderboxPrint: I/O write bytes / time
522,895,360 / 427,616 05:36:05 INFO - TinderboxPrint: CPU idle
8,239.5 (86.5%) 05:36:05 INFO - TinderboxPrint: CPU user
1,222.5 (12.8%) 05:36:05 INFO - TinderboxPrint: Swap in / out
0 / 0 05:36:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 79888384; Read time: 0; Write time: 49804 05:36:05 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 6070272; Write bytes: 443006976; Read time: 1740; Write time: 377812 05:36:05 INFO - Running post-run listener: _upload_blobber_files 05:36:05 INFO - Blob upload gear active. 05:36:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:36:05 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:36:05 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:36:05 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:36:06 INFO - (blobuploader) - INFO - Open directory for files ... 05:36:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:36:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:36:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:09 INFO - (blobuploader) - INFO - Done attempting. 05:36:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:36:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:36:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:10 INFO - (blobuploader) - INFO - Done attempting. 05:36:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:36:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:36:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:11 INFO - (blobuploader) - INFO - Done attempting. 05:36:11 INFO - (blobuploader) - INFO - Iteration through files over. 05:36:11 INFO - Return code: 0 05:36:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:36:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:36:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa5ccf4c720d08dab6d26c382c73cd71dcfd0230641ad2c96d99797909923d0fcaf2660b5864671bbd596716153ea094d69e6adc6be4ee30e67c17a14da9d2d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f58df7d520f50f34338d51cf8221fbca6abaf0f742bd3030a53a1db5508b01766b6367a846440bfc2087d3068a41f007d2172533035ef87fc0a145d7a72b49f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03787373b96eba5d69490a9c9cae5498ede87da247ebe4de2f8ae4207d18e2e50fe65640a2fd1af980d54afcb209796654f6e4f5adcee66eee842aa7934ff64a"} 05:36:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:36:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:36:11 INFO - Contents: 05:36:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa5ccf4c720d08dab6d26c382c73cd71dcfd0230641ad2c96d99797909923d0fcaf2660b5864671bbd596716153ea094d69e6adc6be4ee30e67c17a14da9d2d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f58df7d520f50f34338d51cf8221fbca6abaf0f742bd3030a53a1db5508b01766b6367a846440bfc2087d3068a41f007d2172533035ef87fc0a145d7a72b49f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03787373b96eba5d69490a9c9cae5498ede87da247ebe4de2f8ae4207d18e2e50fe65640a2fd1af980d54afcb209796654f6e4f5adcee66eee842aa7934ff64a"} 05:36:11 INFO - Running post-run listener: copy_logs_to_upload_dir 05:36:11 INFO - Copying logs to upload dir... 05:36:11 INFO - mkdir: /builds/slave/test/build/upload/logs 05:36:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.709317 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-17 05:36:11.608161) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 05:36:11.611961) ========= 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=232498196343f89f466a4a9a000001c8-1466165099.349357-309396154 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/aa5ccf4c720d08dab6d26c382c73cd71dcfd0230641ad2c96d99797909923d0fcaf2660b5864671bbd596716153ea094d69e6adc6be4ee30e67c17a14da9d2d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f58df7d520f50f34338d51cf8221fbca6abaf0f742bd3030a53a1db5508b01766b6367a846440bfc2087d3068a41f007d2172533035ef87fc0a145d7a72b49f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03787373b96eba5d69490a9c9cae5498ede87da247ebe4de2f8ae4207d18e2e50fe65640a2fd1af980d54afcb209796654f6e4f5adcee66eee842aa7934ff64a"} build_url:https://queue.taskcluster.net/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/FLzwKnF1RhimQR5WI8FYNg/artifacts/public/build/firefox-50.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/aa5ccf4c720d08dab6d26c382c73cd71dcfd0230641ad2c96d99797909923d0fcaf2660b5864671bbd596716153ea094d69e6adc6be4ee30e67c17a14da9d2d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f58df7d520f50f34338d51cf8221fbca6abaf0f742bd3030a53a1db5508b01766b6367a846440bfc2087d3068a41f007d2172533035ef87fc0a145d7a72b49f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03787373b96eba5d69490a9c9cae5498ede87da247ebe4de2f8ae4207d18e2e50fe65640a2fd1af980d54afcb209796654f6e4f5adcee66eee842aa7934ff64a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 05:36:11.637107) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 05:36:11.637433) ========= 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=232498196343f89f466a4a9a000001c8-1466165099.349357-309396154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004301 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 05:36:11.721625) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 05:36:11.721940) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 05:36:11.722268) ========= ========= Total master_lag: 0.17 =========