builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1468665120.17 results: success (0) buildid: 20160716005451 builduid: 0fe9a1aa1adb4562ad44f560f82d81a1 revision: 9538d7587ec9ccb4b80ff33bf63b4699eb63298a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 03:32:00.175298) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 03:32:00.177216) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 03:32:00.177523) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 03:32:00.214570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:32:00.214937) ========= 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=d2a8c569965ab8367867b893000001a1-1468663859.659187-87942823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 03:32:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.4M=0s 2016-07-16 03:32:00 (50.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168176 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:32:00.427788) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:32:00.428295) ========= 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=d2a8c569965ab8367867b893000001a1-1468663859.659187-87942823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.075112 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:32:00.516988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:32:00.517524) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9538d7587ec9ccb4b80ff33bf63b4699eb63298a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9538d7587ec9ccb4b80ff33bf63b4699eb63298a --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=d2a8c569965ab8367867b893000001a1-1468663859.659187-87942823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 03:32:00,593 truncating revision to first 12 chars 2016-07-16 03:32:00,593 Setting DEBUG logging. 2016-07-16 03:32:00,593 attempt 1/10 2016-07-16 03:32:00,593 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9538d7587ec9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 03:32:00,904 unpacking tar archive at: mozilla-aurora-9538d7587ec9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681074 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:32:01.212686) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 03:32:01.213001) ========= script_repo_revision: 9538d7587ec9ccb4b80ff33bf63b4699eb63298a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 03:32:01.213412) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 03:32:01.213675) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 03:32:01.224800) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-16 03:32:01.225179) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=d2a8c569965ab8367867b893000001a1-1468663859.659187-87942823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:32:01 INFO - MultiFileLogger online at 20160716 03:32:01 in /builds/slave/test 03:32:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:32:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:01 INFO - {'append_to_log': False, 03:32:01 INFO - 'base_work_dir': '/builds/slave/test', 03:32:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:32:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:01 INFO - 'branch': 'Mozilla-Aurora', 03:32:01 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:01 INFO - 'config_files': ('talos/linux_config.py',), 03:32:01 INFO - 'default_actions': ('clobber', 03:32:01 INFO - 'read-buildbot-config', 03:32:01 INFO - 'download-and-extract', 03:32:01 INFO - 'populate-webroot', 03:32:01 INFO - 'create-virtualenv', 03:32:01 INFO - 'install', 03:32:01 INFO - 'run-tests'), 03:32:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:01 INFO - 'download_minidump_stackwalk': True, 03:32:01 INFO - 'download_symbols': 'ondemand', 03:32:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:01 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:01 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:01 INFO - 'installer_path': 'installer.exe', 03:32:01 INFO - 'log_level': 'info', 03:32:01 INFO - 'log_name': 'talos', 03:32:01 INFO - 'log_to_console': True, 03:32:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:32:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:32:01 INFO - 'opt_config_files': (), 03:32:01 INFO - 'pip_index': False, 03:32:01 INFO - 'sps_profile': False, 03:32:01 INFO - 'sps_profile_interval': 0, 03:32:01 INFO - 'suite': 'dromaeojs-e10s', 03:32:01 INFO - 'system_bits': '32', 03:32:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:01 INFO - 'title': 'talos-linux64-ix-043', 03:32:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:01 INFO - 'use_talos_json': True, 03:32:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:01 INFO - 'work_dir': 'build'} 03:32:01 INFO - ##### 03:32:01 INFO - ##### Running clobber step. 03:32:01 INFO - ##### 03:32:01 INFO - Running pre-action listener: _resource_record_pre_action 03:32:01 INFO - Running main action method: clobber 03:32:01 INFO - rmtree: /builds/slave/test/build 03:32:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:06 INFO - Running post-action listener: _resource_record_post_action 03:32:06 INFO - ##### 03:32:06 INFO - ##### Finished clobber step (success) 03:32:06 INFO - ##### 03:32:06 INFO - ##### 03:32:06 INFO - ##### Running read-buildbot-config step. 03:32:06 INFO - ##### 03:32:06 INFO - Running pre-action listener: _resource_record_pre_action 03:32:06 INFO - Running main action method: read_buildbot_config 03:32:06 INFO - Using buildbot properties: 03:32:06 INFO - { 03:32:06 INFO - "project": "", 03:32:06 INFO - "product": "firefox", 03:32:06 INFO - "script_repo_revision": "production", 03:32:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:32:06 INFO - "repository": "", 03:32:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:32:06 INFO - "buildid": "20160716005451", 03:32:06 INFO - "pgo_build": "True", 03:32:06 INFO - "basedir": "/builds/slave/test", 03:32:06 INFO - "buildnumber": 425, 03:32:06 INFO - "slavename": "talos-linux64-ix-043", 03:32:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:32:06 INFO - "platform": "ubuntu64_hw", 03:32:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:32:06 INFO - "branch": "mozilla-aurora", 03:32:06 INFO - "repo_path": "releases/mozilla-aurora", 03:32:06 INFO - "revision": "9538d7587ec9ccb4b80ff33bf63b4699eb63298a", 03:32:06 INFO - "stage_platform": "linux64-pgo", 03:32:06 INFO - "builduid": "0fe9a1aa1adb4562ad44f560f82d81a1", 03:32:06 INFO - "slavebuilddir": "test" 03:32:06 INFO - } 03:32:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:32:06 INFO - Running post-action listener: _resource_record_post_action 03:32:06 INFO - ##### 03:32:06 INFO - ##### Finished read-buildbot-config step (success) 03:32:06 INFO - ##### 03:32:06 INFO - ##### 03:32:06 INFO - ##### Running download-and-extract step. 03:32:06 INFO - ##### 03:32:06 INFO - Running pre-action listener: _resource_record_pre_action 03:32:06 INFO - Running main action method: download_and_extract 03:32:06 INFO - mkdir: /builds/slave/test/build/tests 03:32: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')]} 03:32:06 INFO - https://queue.taskcluster.net/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:32:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:32:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:32:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:32:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:32:07 INFO - Downloaded 1361 bytes. 03:32:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:32:07 INFO - Using the following test package requirements: 03:32:07 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:32:07 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:32:07 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:32:07 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:07 INFO - u'jsshell-linux-x86_64.zip'], 03:32:07 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:32:07 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:32:07 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:32:07 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:32:07 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:32:07 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:32:07 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:32: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')]} 03:32:07 INFO - https://queue.taskcluster.net/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:32:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:32:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:32:13 INFO - Downloaded 24490025 bytes. 03:32:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:32:14 INFO - Return code: 0 03:32:14 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:14 INFO - https://queue.taskcluster.net/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:32:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:32:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:32:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:32:16 INFO - Downloaded 24490025 bytes. 03:32:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:32:17 INFO - Return code: 0 03:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:17 INFO - https://queue.taskcluster.net/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:32:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:32:18 INFO - Downloaded 10833369 bytes. 03:32:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:32:19 INFO - Return code: 0 03:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:19 INFO - https://queue.taskcluster.net/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:32:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:32:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:32:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:32:20 INFO - Downloaded 63636828 bytes. 03:32:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:32:20 INFO - mkdir: /builds/slave/test/properties 03:32:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:32:20 INFO - Writing to file /builds/slave/test/properties/build_url 03:32:20 INFO - Contents: 03:32:20 INFO - build_url:https://queue.taskcluster.net/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:32:21 INFO - Running post-action listener: _resource_record_post_action 03:32:21 INFO - Running post-action listener: set_extra_try_arguments 03:32:21 INFO - ##### 03:32:21 INFO - ##### Finished download-and-extract step (success) 03:32:21 INFO - ##### 03:32:21 INFO - ##### 03:32:21 INFO - ##### Running populate-webroot step. 03:32:21 INFO - ##### 03:32:21 INFO - Running pre-action listener: _resource_record_pre_action 03:32:21 INFO - Running main action method: populate_webroot 03:32:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:32:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:32:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:32:21 INFO - '--tppagecycles', 03:32:21 INFO - '7'], 03:32:21 INFO - 'tests': ['tsvgm']}}, 03:32:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:32:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:32:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:32:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:32:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:32:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:32:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:21 INFO - 'talos_options': ['--disable-e10s'], 03:32:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:21 INFO - 'talos_options': ['--disable-e10s'], 03:32:21 INFO - 'tests': ['damp', 'tps']}, 03:32:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:21 INFO - 'tests': ['damp', 'tps']}, 03:32:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:32:21 INFO - 'tests': ['dromaeo_dom']}, 03:32:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:32:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:32:21 INFO - 'tests': ['a11yr', 03:32:21 INFO - 'ts_paint', 03:32:21 INFO - 'tpaint', 03:32:21 INFO - 'sessionrestore', 03:32:21 INFO - 'sessionrestore_no_auto_restore', 03:32:21 INFO - 'tabpaint']}, 03:32:21 INFO - 'other-e10s': {'tests': ['a11yr', 03:32:21 INFO - 'ts_paint', 03:32:21 INFO - 'tpaint', 03:32:21 INFO - 'sessionrestore', 03:32:21 INFO - 'sessionrestore_no_auto_restore', 03:32:21 INFO - 'tabpaint']}, 03:32:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:32:21 INFO - 'ts_paint', 03:32:21 INFO - 'tpaint', 03:32:21 INFO - 'sessionrestore', 03:32:21 INFO - 'sessionrestore_no_auto_restore', 03:32:21 INFO - 'tabpaint']}, 03:32:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:32:21 INFO - 'ts_paint', 03:32:21 INFO - 'tpaint', 03:32:21 INFO - 'sessionrestore', 03:32:21 INFO - 'sessionrestore_no_auto_restore', 03:32:21 INFO - 'tabpaint']}, 03:32:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:32:21 INFO - 'tests': ['a11yr', 03:32:21 INFO - 'ts_paint', 03:32:21 INFO - 'tpaint', 03:32:21 INFO - 'sessionrestore', 03:32:21 INFO - 'sessionrestore_no_auto_restore', 03:32:21 INFO - 'tabpaint']}, 03:32:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:32:21 INFO - 'tests': ['a11yr', 03:32:21 INFO - 'ts_paint', 03:32:21 INFO - 'tpaint', 03:32:21 INFO - 'sessionrestore', 03:32:21 INFO - 'sessionrestore_no_auto_restore', 03:32:21 INFO - 'tabpaint']}, 03:32:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:32:21 INFO - 'tests': ['tsvgx', 03:32:21 INFO - 'tsvgr_opacity', 03:32:21 INFO - 'tart', 03:32:21 INFO - 'tscrollx', 03:32:21 INFO - 'cart']}, 03:32:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:32:21 INFO - 'tsvgr_opacity', 03:32:21 INFO - 'tart', 03:32:21 INFO - 'tscrollx', 03:32:21 INFO - 'cart']}, 03:32:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:21 INFO - 'talos_options': ['--disable-e10s'], 03:32:21 INFO - 'tests': ['tp5o']}, 03:32:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:21 INFO - 'tests': ['tp5o']}, 03:32:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:21 INFO - 'talos_options': ['--disable-e10s', 03:32:21 INFO - '--xperf_path', 03:32:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:21 INFO - 'tests': ['tp5n']}, 03:32:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:21 INFO - 'talos_options': ['--xperf_path', 03:32:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:21 INFO - 'tests': ['tp5n']}}, 03:32:21 INFO - 'talos.zip': {'path': '', 03:32:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:32:21 INFO - Running post-action listener: _resource_record_post_action 03:32:21 INFO - ##### 03:32:21 INFO - ##### Finished populate-webroot step (success) 03:32:21 INFO - ##### 03:32:21 INFO - ##### 03:32:21 INFO - ##### Running create-virtualenv step. 03:32:21 INFO - ##### 03:32:21 INFO - Running pre-action listener: _resource_record_pre_action 03:32:21 INFO - Running main action method: create_virtualenv 03:32:21 INFO - Creating virtualenv /builds/slave/test/build/venv 03:32:21 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 03:32:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:32:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:32:22 INFO - Using real prefix '/usr' 03:32:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:32:23 INFO - Installing distribute.............................................................................................................................................................................................done. 03:32:25 INFO - Installing pip.................done. 03:32:25 INFO - Return code: 0 03:32:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:32:25 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')]} 03:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:25 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')]} 03:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:25 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 0x7f5a7247cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2990>, '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 0x183e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', '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 03:32:25 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 03:32:25 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 03:32:25 INFO - Using env: {'DISPLAY': ':0', 03:32:25 INFO - 'HOME': '/home/cltbld', 03:32:25 INFO - 'LANG': 'en_US.UTF-8', 03:32:25 INFO - 'LANGUAGE': 'en_US:en', 03:32:25 INFO - 'LOGNAME': 'cltbld', 03:32:25 INFO - 'MAIL': '/var/mail/cltbld', 03:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:25 INFO - 'MOZ_NO_REMOTE': '1', 03:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:25 INFO - 'NO_EM_RESTART': '1', 03:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:25 INFO - 'PWD': '/builds/slave/test', 03:32:25 INFO - 'SHELL': '/bin/bash', 03:32:25 INFO - 'SHLVL': '1', 03:32:25 INFO - 'TERM': 'linux', 03:32:25 INFO - 'TMOUT': '86400', 03:32:25 INFO - 'USER': 'cltbld', 03:32:25 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', 03:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:25 INFO - '_': '/tools/buildbot/bin/python'} 03:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:25 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 03:32:25 INFO - Cleaning up... 03:32:25 INFO - Return code: 0 03:32:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:32:25 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')]} 03:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:25 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')]} 03:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:25 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 0x7f5a7247cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2990>, '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 0x183e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', '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 03:32:25 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 03:32:25 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 03:32:25 INFO - Using env: {'DISPLAY': ':0', 03:32:25 INFO - 'HOME': '/home/cltbld', 03:32:25 INFO - 'LANG': 'en_US.UTF-8', 03:32:25 INFO - 'LANGUAGE': 'en_US:en', 03:32:25 INFO - 'LOGNAME': 'cltbld', 03:32:25 INFO - 'MAIL': '/var/mail/cltbld', 03:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:25 INFO - 'MOZ_NO_REMOTE': '1', 03:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:25 INFO - 'NO_EM_RESTART': '1', 03:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:25 INFO - 'PWD': '/builds/slave/test', 03:32:25 INFO - 'SHELL': '/bin/bash', 03:32:25 INFO - 'SHLVL': '1', 03:32:25 INFO - 'TERM': 'linux', 03:32:25 INFO - 'TMOUT': '86400', 03:32:25 INFO - 'USER': 'cltbld', 03:32:25 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', 03:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:25 INFO - '_': '/tools/buildbot/bin/python'} 03:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:25 INFO - Downloading/unpacking psutil>=3.1.1 03:32:25 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 03:32:25 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 03:32:25 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 03:32:25 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 03:32:25 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 03:32:25 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 03:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:32:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:28 INFO - Installing collected packages: psutil 03:32:28 INFO - Running setup.py install for psutil 03:32:28 INFO - building 'psutil._psutil_linux' extension 03:32:28 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 03:32:29 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 03:32:29 INFO - building 'psutil._psutil_posix' extension 03:32:29 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 03:32:29 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 03:32:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:30 INFO - Successfully installed psutil 03:32:30 INFO - Cleaning up... 03:32:30 INFO - Return code: 0 03:32:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5a7247cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2990>, '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 0x183e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', '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 03:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:32:30 INFO - Using env: {'DISPLAY': ':0', 03:32:30 INFO - 'HOME': '/home/cltbld', 03:32:30 INFO - 'LANG': 'en_US.UTF-8', 03:32:30 INFO - 'LANGUAGE': 'en_US:en', 03:32:30 INFO - 'LOGNAME': 'cltbld', 03:32:30 INFO - 'MAIL': '/var/mail/cltbld', 03:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:30 INFO - 'MOZ_NO_REMOTE': '1', 03:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:30 INFO - 'NO_EM_RESTART': '1', 03:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:30 INFO - 'PWD': '/builds/slave/test', 03:32:30 INFO - 'SHELL': '/bin/bash', 03:32:30 INFO - 'SHLVL': '1', 03:32:30 INFO - 'TERM': 'linux', 03:32:30 INFO - 'TMOUT': '86400', 03:32:30 INFO - 'USER': 'cltbld', 03:32:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', 03:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:30 INFO - '_': '/tools/buildbot/bin/python'} 03:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:32:32 INFO - Installing collected packages: mozsystemmonitor 03:32:32 INFO - Running setup.py install for mozsystemmonitor 03:32:32 INFO - Successfully installed mozsystemmonitor 03:32:32 INFO - Cleaning up... 03:32:32 INFO - Return code: 0 03:32:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:32: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')]} 03:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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')]} 03:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:32 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 0x7f5a7247cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2990>, '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 0x183e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', '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 03:32:32 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 03:32:32 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 03:32:32 INFO - Using env: {'DISPLAY': ':0', 03:32:32 INFO - 'HOME': '/home/cltbld', 03:32:32 INFO - 'LANG': 'en_US.UTF-8', 03:32:32 INFO - 'LANGUAGE': 'en_US:en', 03:32:32 INFO - 'LOGNAME': 'cltbld', 03:32:32 INFO - 'MAIL': '/var/mail/cltbld', 03:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:32 INFO - 'MOZ_NO_REMOTE': '1', 03:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:32 INFO - 'NO_EM_RESTART': '1', 03:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:32 INFO - 'PWD': '/builds/slave/test', 03:32:32 INFO - 'SHELL': '/bin/bash', 03:32:32 INFO - 'SHLVL': '1', 03:32:32 INFO - 'TERM': 'linux', 03:32:32 INFO - 'TMOUT': '86400', 03:32:32 INFO - 'USER': 'cltbld', 03:32:32 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', 03:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:32 INFO - '_': '/tools/buildbot/bin/python'} 03:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:32 INFO - Downloading/unpacking jsonschema==2.5.1 03:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:32:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:32:34 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 03:32:34 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 03:32:34 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 03:32:34 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 03:32:34 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 03:32:34 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 03:32:34 INFO - Downloading functools32-3.2.3-2.tar.gz 03:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:32:34 INFO - warning: no files found matching '*.txt' 03:32:34 INFO - no previously-included directories found matching 'build' 03:32:34 INFO - no previously-included directories found matching 'dist' 03:32:34 INFO - no previously-included directories found matching '.git*' 03:32:34 INFO - Installing collected packages: jsonschema, functools32 03:32:34 INFO - Running setup.py install for functools32 03:32:34 INFO - warning: no files found matching '*.txt' 03:32:34 INFO - no previously-included directories found matching 'build' 03:32:34 INFO - no previously-included directories found matching 'dist' 03:32:34 INFO - no previously-included directories found matching '.git*' 03:32:34 INFO - Successfully installed jsonschema functools32 03:32:34 INFO - Cleaning up... 03:32:34 INFO - Return code: 0 03:32:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:34 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 0x7f5a7247cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2990>, '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 0x183e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', '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 03:32:34 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 03:32:34 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 03:32:34 INFO - Using env: {'DISPLAY': ':0', 03:32:34 INFO - 'HOME': '/home/cltbld', 03:32:34 INFO - 'LANG': 'en_US.UTF-8', 03:32:34 INFO - 'LANGUAGE': 'en_US:en', 03:32:34 INFO - 'LOGNAME': 'cltbld', 03:32:34 INFO - 'MAIL': '/var/mail/cltbld', 03:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:34 INFO - 'MOZ_NO_REMOTE': '1', 03:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:35 INFO - 'NO_EM_RESTART': '1', 03:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:35 INFO - 'PWD': '/builds/slave/test', 03:32:35 INFO - 'SHELL': '/bin/bash', 03:32:35 INFO - 'SHLVL': '1', 03:32:35 INFO - 'TERM': 'linux', 03:32:35 INFO - 'TMOUT': '86400', 03:32:35 INFO - 'USER': 'cltbld', 03:32:35 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', 03:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:35 INFO - '_': '/tools/buildbot/bin/python'} 03:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:35 INFO - Downloading/unpacking blobuploader==1.2.4 03:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:37 INFO - Downloading blobuploader-1.2.4.tar.gz 03:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:32:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:32:37 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 03:32:37 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 03:32:37 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 03:32:37 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 03:32:37 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 03:32:37 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 03:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:32:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:32:37 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 03:32:37 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 03:32:37 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 03:32:37 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 03:32:37 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 03:32:37 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 03:32:37 INFO - Downloading docopt-0.6.1.tar.gz 03:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:32:37 INFO - Installing collected packages: blobuploader, requests, docopt 03:32:37 INFO - Running setup.py install for blobuploader 03:32:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:32:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:32:38 INFO - Running setup.py install for requests 03:32:38 INFO - Running setup.py install for docopt 03:32:38 INFO - Successfully installed blobuploader requests docopt 03:32:38 INFO - Cleaning up... 03:32:38 INFO - Return code: 0 03:32:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:38 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 0x7f5a7247cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2990>, '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 0x183e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', '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 03:32:38 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 03:32:38 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 03:32:38 INFO - Using env: {'DISPLAY': ':0', 03:32:38 INFO - 'HOME': '/home/cltbld', 03:32:38 INFO - 'LANG': 'en_US.UTF-8', 03:32:38 INFO - 'LANGUAGE': 'en_US:en', 03:32:38 INFO - 'LOGNAME': 'cltbld', 03:32:38 INFO - 'MAIL': '/var/mail/cltbld', 03:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:38 INFO - 'MOZ_NO_REMOTE': '1', 03:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:38 INFO - 'NO_EM_RESTART': '1', 03:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:38 INFO - 'PWD': '/builds/slave/test', 03:32:38 INFO - 'SHELL': '/bin/bash', 03:32:38 INFO - 'SHLVL': '1', 03:32:38 INFO - 'TERM': 'linux', 03:32:38 INFO - 'TMOUT': '86400', 03:32:38 INFO - 'USER': 'cltbld', 03:32:38 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', 03:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:38 INFO - '_': '/tools/buildbot/bin/python'} 03:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:38 INFO - Running setup.py (path:/tmp/pip-mSgOF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:38 INFO - Running setup.py (path:/tmp/pip-S7IRn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:38 INFO - Running setup.py (path:/tmp/pip-qTSlE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:39 INFO - Running setup.py (path:/tmp/pip-rzTS7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:39 INFO - Running setup.py (path:/tmp/pip-iWAMC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:39 INFO - Running setup.py (path:/tmp/pip-LgJvs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:39 INFO - Running setup.py (path:/tmp/pip-H_dmz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:39 INFO - Running setup.py (path:/tmp/pip-zpmk1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:39 INFO - Running setup.py (path:/tmp/pip-Rt9fZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:39 INFO - Running setup.py (path:/tmp/pip-GWWqk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:39 INFO - Running setup.py (path:/tmp/pip-DMgEmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:39 INFO - Running setup.py (path:/tmp/pip-TRIVf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:39 INFO - Running setup.py (path:/tmp/pip-U8HEmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:39 INFO - Running setup.py (path:/tmp/pip-87KKCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:39 INFO - Running setup.py (path:/tmp/pip-Lz57Pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:39 INFO - Running setup.py (path:/tmp/pip-8c1TL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:39 INFO - Running setup.py (path:/tmp/pip-SZBlIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:32:40 INFO - Running setup.py install for manifestparser 03:32:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:32:40 INFO - Running setup.py install for mozcrash 03:32:40 INFO - Running setup.py install for mozdebug 03:32:40 INFO - Running setup.py install for mozdevice 03:32:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:32:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:32:40 INFO - Running setup.py install for mozfile 03:32:40 INFO - Running setup.py install for mozhttpd 03:32:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:32:40 INFO - Running setup.py install for mozinfo 03:32:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:32:40 INFO - Running setup.py install for mozInstall 03:32:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:32:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:32:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:32:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:32:40 INFO - Running setup.py install for mozleak 03:32:40 INFO - Running setup.py install for mozlog 03:32:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:32:41 INFO - Running setup.py install for moznetwork 03:32:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:32:41 INFO - Running setup.py install for mozprocess 03:32:41 INFO - Running setup.py install for mozprofile 03:32:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:32:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:32:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:32:41 INFO - Running setup.py install for mozrunner 03:32:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:32:41 INFO - Running setup.py install for mozscreenshot 03:32:41 INFO - Running setup.py install for moztest 03:32:41 INFO - Running setup.py install for mozversion 03:32:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:32:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:32:41 INFO - Cleaning up... 03:32:41 INFO - Return code: 0 03:32:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:41 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 0x7f5a7247cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2990>, '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 0x183e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', '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 03:32:41 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 03:32:41 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 03:32:41 INFO - Using env: {'DISPLAY': ':0', 03:32:41 INFO - 'HOME': '/home/cltbld', 03:32:41 INFO - 'LANG': 'en_US.UTF-8', 03:32:41 INFO - 'LANGUAGE': 'en_US:en', 03:32:41 INFO - 'LOGNAME': 'cltbld', 03:32:41 INFO - 'MAIL': '/var/mail/cltbld', 03:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:41 INFO - 'MOZ_NO_REMOTE': '1', 03:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:41 INFO - 'NO_EM_RESTART': '1', 03:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:41 INFO - 'PWD': '/builds/slave/test', 03:32:41 INFO - 'SHELL': '/bin/bash', 03:32:41 INFO - 'SHLVL': '1', 03:32:41 INFO - 'TERM': 'linux', 03:32:41 INFO - 'TMOUT': '86400', 03:32:41 INFO - 'USER': 'cltbld', 03:32:41 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', 03:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:41 INFO - '_': '/tools/buildbot/bin/python'} 03:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:42 INFO - Running setup.py (path:/tmp/pip-70WwKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:42 INFO - Running setup.py (path:/tmp/pip-WYDnx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:42 INFO - Running setup.py (path:/tmp/pip-KANsPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:42 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)) 03:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:42 INFO - Running setup.py (path:/tmp/pip-nGmoyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:42 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)) 03:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:42 INFO - Running setup.py (path:/tmp/pip-lb2iMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:42 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)) 03:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:42 INFO - Running setup.py (path:/tmp/pip-vOnrez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:42 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)) 03:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:42 INFO - Running setup.py (path:/tmp/pip-zFLHd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:42 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)) 03:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:42 INFO - Running setup.py (path:/tmp/pip-LE5gqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:42 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)) 03:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:42 INFO - Running setup.py (path:/tmp/pip-L1jZpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:42 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)) 03:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:42 INFO - Running setup.py (path:/tmp/pip-_FoKHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:42 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)) 03:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:42 INFO - Running setup.py (path:/tmp/pip-1yDxgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:42 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)) 03:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:42 INFO - Running setup.py (path:/tmp/pip-DvM_gD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:42 INFO - Running setup.py (path:/tmp/pip-JvJREc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:42 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)) 03:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:42 INFO - Running setup.py (path:/tmp/pip-Q19OBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:43 INFO - Running setup.py (path:/tmp/pip-he1Z4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:43 INFO - Running setup.py (path:/tmp/pip-AFhkqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:43 INFO - Running setup.py (path:/tmp/pip-RTMFXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:43 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)) 03:32:43 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)) 03:32:43 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)) 03:32:43 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)) 03:32:43 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)) 03:32:43 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)) 03:32:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32:43 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 03:32:43 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 03:32:43 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 03:32:43 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 03:32:43 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 03:32:43 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 03:32:45 INFO - Downloading blessings-1.6.tar.gz 03:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:32:45 INFO - Installing collected packages: blessings 03:32:45 INFO - Running setup.py install for blessings 03:32:45 INFO - Successfully installed blessings 03:32:45 INFO - Cleaning up... 03:32:45 INFO - Return code: 0 03:32:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:45 INFO - Reading from file tmpfile_stdout 03:32:45 INFO - Current package versions: 03:32:45 INFO - argparse == 1.2.1 03:32:45 INFO - blessings == 1.6 03:32:45 INFO - blobuploader == 1.2.4 03:32:45 INFO - docopt == 0.6.1 03:32:45 INFO - functools32 == 3.2.3-2 03:32:45 INFO - jsonschema == 2.5.1 03:32:45 INFO - manifestparser == 1.1 03:32:45 INFO - mozInstall == 1.12 03:32:45 INFO - mozcrash == 0.17 03:32:45 INFO - mozdebug == 0.1 03:32:45 INFO - mozdevice == 0.48 03:32:45 INFO - mozfile == 1.2 03:32:45 INFO - mozhttpd == 0.7 03:32:45 INFO - mozinfo == 0.9 03:32:45 INFO - mozleak == 0.1 03:32:45 INFO - mozlog == 3.2 03:32:45 INFO - moznetwork == 0.27 03:32:45 INFO - mozprocess == 0.23 03:32:45 INFO - mozprofile == 0.28 03:32:45 INFO - mozrunner == 6.12 03:32:45 INFO - mozscreenshot == 0.1 03:32:45 INFO - mozsystemmonitor == 0.3 03:32:45 INFO - moztest == 0.7 03:32:45 INFO - mozversion == 1.4 03:32:45 INFO - psutil == 3.1.1 03:32:45 INFO - requests == 1.2.3 03:32:45 INFO - wsgiref == 0.1.2 03:32:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:45 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 0x7f5a7247cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2990>, '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 0x183e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', '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 03:32:45 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 03:32:45 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 03:32:45 INFO - Using env: {'DISPLAY': ':0', 03:32:45 INFO - 'HOME': '/home/cltbld', 03:32:45 INFO - 'LANG': 'en_US.UTF-8', 03:32:45 INFO - 'LANGUAGE': 'en_US:en', 03:32:45 INFO - 'LOGNAME': 'cltbld', 03:32:45 INFO - 'MAIL': '/var/mail/cltbld', 03:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:45 INFO - 'MOZ_NO_REMOTE': '1', 03:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:45 INFO - 'NO_EM_RESTART': '1', 03:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:45 INFO - 'PWD': '/builds/slave/test', 03:32:45 INFO - 'SHELL': '/bin/bash', 03:32:45 INFO - 'SHLVL': '1', 03:32:45 INFO - 'TERM': 'linux', 03:32:45 INFO - 'TMOUT': '86400', 03:32:45 INFO - 'USER': 'cltbld', 03:32:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', 03:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:45 INFO - '_': '/tools/buildbot/bin/python'} 03:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:45 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)) 03:32:45 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)) 03:32:45 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)) 03:32:45 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)) 03:32:45 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)) 03:32:45 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)) 03:32:45 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)) 03:32:45 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)) 03:32:45 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)) 03:32:45 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)) 03:32:45 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)) 03:32:45 INFO - Cleaning up... 03:32:45 INFO - Return code: 0 03:32:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:45 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 0x7f5a7247cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2990>, '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 0x183e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', '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 03:32:45 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 03:32:45 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 03:32:45 INFO - Using env: {'DISPLAY': ':0', 03:32:45 INFO - 'HOME': '/home/cltbld', 03:32:45 INFO - 'LANG': 'en_US.UTF-8', 03:32:45 INFO - 'LANGUAGE': 'en_US:en', 03:32:45 INFO - 'LOGNAME': 'cltbld', 03:32:45 INFO - 'MAIL': '/var/mail/cltbld', 03:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:45 INFO - 'MOZ_NO_REMOTE': '1', 03:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:45 INFO - 'NO_EM_RESTART': '1', 03:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:45 INFO - 'PWD': '/builds/slave/test', 03:32:45 INFO - 'SHELL': '/bin/bash', 03:32:45 INFO - 'SHLVL': '1', 03:32:45 INFO - 'TERM': 'linux', 03:32:45 INFO - 'TMOUT': '86400', 03:32:45 INFO - 'USER': 'cltbld', 03:32:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', 03:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:45 INFO - '_': '/tools/buildbot/bin/python'} 03:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:32:46 INFO - Cleaning up... 03:32:46 INFO - Return code: 0 03:32:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5a7247cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18403b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2990>, '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 0x183e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', '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 03:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:32:46 INFO - Using env: {'DISPLAY': ':0', 03:32:46 INFO - 'HOME': '/home/cltbld', 03:32:46 INFO - 'LANG': 'en_US.UTF-8', 03:32:46 INFO - 'LANGUAGE': 'en_US:en', 03:32:46 INFO - 'LOGNAME': 'cltbld', 03:32:46 INFO - 'MAIL': '/var/mail/cltbld', 03:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:46 INFO - 'MOZ_NO_REMOTE': '1', 03:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:46 INFO - 'NO_EM_RESTART': '1', 03:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:46 INFO - 'PWD': '/builds/slave/test', 03:32:46 INFO - 'SHELL': '/bin/bash', 03:32:46 INFO - 'SHLVL': '1', 03:32:46 INFO - 'TERM': 'linux', 03:32:46 INFO - 'TMOUT': '86400', 03:32:46 INFO - 'USER': 'cltbld', 03:32:46 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', 03:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:46 INFO - '_': '/tools/buildbot/bin/python'} 03:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:46 INFO - Downloading/unpacking flake8 03:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:32:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:32:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:48 INFO - no previously-included directories found matching 'docs/_build' 03:32:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:32:48 INFO - Running setup.py install for pep8 03:32:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:49 INFO - no previously-included directories found matching 'docs/_build' 03:32:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:32:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:32:49 INFO - Cleaning up... 03:32:49 INFO - Return code: 0 03:32:49 INFO - Running post-action listener: _resource_record_post_action 03:32:49 INFO - Running post-action listener: _start_resource_monitoring 03:32:49 INFO - Starting resource monitoring. 03:32:49 INFO - ##### 03:32:49 INFO - ##### Finished create-virtualenv step (success) 03:32:49 INFO - ##### 03:32:49 INFO - ##### 03:32:49 INFO - ##### Running install step. 03:32:49 INFO - ##### 03:32:49 INFO - Running pre-action listener: _resource_record_pre_action 03:32:49 INFO - Running main action method: install 03:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:49 INFO - Reading from file tmpfile_stdout 03:32:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:32:49 INFO - Reading from file tmpfile_stdout 03:32:49 INFO - Output received: 03:32:49 INFO - Usage: mozinstall [options] installer 03:32:49 INFO - Options: 03:32:49 INFO - -h, --help show this help message and exit 03:32:49 INFO - -d DEST, --destination=DEST 03:32:49 INFO - Directory to install application into. [default: 03:32:49 INFO - "/builds/slave/test"] 03:32:49 INFO - --app=APP Application being installed. [default: firefox] 03:32:49 INFO - mkdir: /builds/slave/test/build/application 03:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:33:05 INFO - Reading from file tmpfile_stdout 03:33:05 INFO - Output received: 03:33:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:05 INFO - Running post-action listener: _resource_record_post_action 03:33:05 INFO - ##### 03:33:05 INFO - ##### Finished install step (success) 03:33:05 INFO - ##### 03:33:05 INFO - ##### 03:33:05 INFO - ##### Running run-tests step. 03:33:05 INFO - ##### 03:33:05 INFO - Running pre-action listener: _resource_record_pre_action 03:33:05 INFO - Running main action method: run_tests 03:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:05 INFO - Python 2.7.3 03:33:05 INFO - Return code: 0 03:33:05 INFO - grabbing minidump binary from tooltool 03:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2990>, '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 0x183e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183e900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:33:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:33:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:33:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:05 INFO - Return code: 0 03:33:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:33:06 INFO - Return code: 0 03:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 03:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 03:33:06 INFO - Using env: {'DISPLAY': ':0', 03:33:06 INFO - 'HOME': '/home/cltbld', 03:33:06 INFO - 'LANG': 'en_US.UTF-8', 03:33:06 INFO - 'LANGUAGE': 'en_US:en', 03:33:06 INFO - 'LOGNAME': 'cltbld', 03:33:06 INFO - 'MAIL': '/var/mail/cltbld', 03:33:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:06 INFO - 'MOZ_NO_REMOTE': '1', 03:33:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:06 INFO - 'NO_EM_RESTART': '1', 03:33:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:06 INFO - 'PWD': '/builds/slave/test', 03:33:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:06 INFO - 'SHELL': '/bin/bash', 03:33:06 INFO - 'SHLVL': '1', 03:33:06 INFO - 'TERM': 'linux', 03:33:06 INFO - 'TMOUT': '86400', 03:33:06 INFO - 'USER': 'cltbld', 03:33:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468663859.659187-87942823', 03:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:06 INFO - '_': '/tools/buildbot/bin/python'} 03:33:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 03:33:06 INFO - mozversion application_buildid: 20160716005451 03:33:06 INFO - mozversion application_changeset: 9538d7587ec9ccb4b80ff33bf63b4699eb63298a 03:33:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:33:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:06 INFO - mozversion application_name: Firefox 03:33:06 INFO - mozversion application_remotingname: firefox-dev 03:33:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:06 INFO - mozversion application_vendor: Mozilla 03:33:06 INFO - mozversion application_version: 49.0a2 03:33:06 INFO - mozversion platform_buildid: 20160716005451 03:33:06 INFO - mozversion platform_changeset: 9538d7587ec9ccb4b80ff33bf63b4699eb63298a 03:33:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:06 INFO - mozversion platform_version: 49.0a2 03:33:06 INFO - using testdate: 1468665186 03:33:06 INFO - actual date: 1468665186 03:33:06 INFO - starting webserver on 'localhost:35658' 03:33:06 INFO - SUITE-START | Running 2 tests 03:33:06 INFO - TEST-START | dromaeo_css 03:33:06 INFO - operating with platform_type : linux_ 03:33:06 INFO - Initialising browser for dromaeo_css test... 03:33:06 INFO - TEST-INFO | started process 3347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32N25m/profile http://localhost:35658/getInfo.html) 03:33:12 INFO - PROCESS | 3347 | __metrics Screen width/height:1600/1200 03:33:12 INFO - PROCESS | 3347 | colorDepth:24 03:33:12 INFO - PROCESS | 3347 | Browser inner width/height: 1024/697 03:33:12 INFO - PROCESS | 3347 | __metrics 03:33:13 ERROR - PROCESS | 3347 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:33:14 INFO - TEST-INFO | 3347: exit 0 03:33:14 INFO - Browser initialized. 03:33:14 INFO - Running cycle 1/1 for dromaeo_css test... 03:33:14 INFO - TEST-INFO | started process 3475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32N25m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:26 INFO - PROCESS | 3475 | RSS: Main: 156635136 03:33:26 INFO - PROCESS | 3475 | 03:34:16 INFO - PROCESS | 3475 | 1468665256026 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] 03:36:23 INFO - PROCESS | 3475 | Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35658/tests/dromaeo/cssquery-ext.html) 03:36:24 INFO - PROCESS | 3475 | RSS: Main: 160694272 03:36:24 INFO - PROCESS | 3475 | 03:39:26 INFO - PROCESS | 3475 | Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-ext.html (next: http://localhost:35658/tests/dromaeo/cssquery-jquery.html) 03:39:27 INFO - PROCESS | 3475 | RSS: Main: 158052352 03:39:27 INFO - PROCESS | 3475 | 03:42:29 INFO - PROCESS | 3475 | Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35658/tests/dromaeo/cssquery-mootools.html) 03:42:29 INFO - PROCESS | 3475 | RSS: Main: 158285824 03:42:29 INFO - PROCESS | 3475 | 03:45:31 INFO - PROCESS | 3475 | Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35658/tests/dromaeo/cssquery-prototype.html) 03:45:31 INFO - PROCESS | 3475 | RSS: Main: 157794304 03:45:31 INFO - PROCESS | 3475 | 03:48:34 INFO - PROCESS | 3475 | Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35658/tests/dromaeo/cssquery-yui.html) 03:48:35 INFO - PROCESS | 3475 | RSS: Main: 158887936 03:48:35 INFO - PROCESS | 3475 | 03:51:37 INFO - PROCESS | 3475 | Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-yui.html (next: http://localhost:35658/tests/dromaeo/cssquery-dojo.html) 03:51:37 INFO - PROCESS | 3475 | RSS: Main: 159387648 03:51:37 INFO - PROCESS | 3475 | 03:51:37 INFO - PROCESS | 3475 | __start_tp_report 03:51:37 INFO - PROCESS | 3475 | _x_x_mozilla_page_load 03:51:37 INFO - PROCESS | 3475 | _x_x_mozilla_page_load_details 03:51:37 INFO - PROCESS | 3475 | |i|pagename|runs| 03:51:37 INFO - PROCESS | 3475 | |0;dojo.html;3308.751843611729;3346.33073385323;3356.009977056768;3386.119608901686;3387.441072223083;5566.359868615105;5608.130739735338;5622.212890195366;5637.689927054015;5700.486956173943;5637.4644408781205;5665.490105890469;5693.800716974907;5701.34434540028;5702.629329093606;5163.535281824635;5237.214417837316;5250.4487028861995;5266.8419947401635;5301;5102.081625307444;5122.92315615266;5275.657082289658;5293.364796224459;5300.390455097655;5207.3490813648295;5208.322918020671;5213.895722085556;5217.530422261995;5242.711650859202;5168.819091331804;5175.094358487268;5238.109521381374;5248.527632513054;5261.657992230531;5114.744262786846;5175.689458632494;5217.634765566412;5224.738763061831;5260.289860868772;5455.290812194389;5508;5554.055810512182;5559.138333558305;5611.13027480737;6028.909566356509;6082.178905847698;6094.9390506094815;6097.024476083805;6105.358937311607;5931.436513531207;6122.785702500391;6141.201643786324;6148.200733904609;6155.322914479404;5636.85907852307;5687.857803554903;5718.799842005551;5761.769529218826;5770.163326317703;6280.780172693934;6287.748490060438;6289.937100629027;6302.527310451735;6303.842403939938;5786.537077033827;5914.319853216849;6034.24571928509;6045.969770151209;6046.09308603713;6007.789727359522;6084.300305464928;6129.8784197560135;6135.815925522242;6143.603994442082;5953.1070339449425;6065.8180254592435;6078.574499785061;6082.2701275847185;6107.816765496953;5880.117982302689;5989.790357337472;6016.368281330398;6080.483158931452;6093.11649810775;4633.9536604634195;4645.02454484562;4646.442426908725;4682.086993036325;4693.694909830919;4153.086321009373;4177.56135605757;4179.665626749853;4189.853355132555;4192.790360482025;5773.711314434261;5814.912776308359;5830.970845145747;5853.09277062056;5861;5890.52875769946;6078.878422431527;6132.601380910227;6150.846228844225;6153.815385538441;5797.043487824546;5799.2750906136735;5802.042662960649;5818.156367326714;5822.1266809978;5110.437851836295;5158.200478925773;5162.535371816554;5184.818531351385;5194.27280180775;6113.4372296094125;6115.328140165785;6123.404636889863;6132.280335668016;6140.723667434976;6108.677166059225;6122.337166850004;6125.11336343068;6136.035599594403;6139.614800607318;5833.79581714638;5991.161237426851;6005.579609427298;6045.969770151121;6134.473082415357;5898.528117750656;5932.466078052996;5934.9406505934385;5945.970270148621;5973.432523910222;6053.273607167168;6054.697265136638;6058.212432383762;6063.636181829104;6069.180660610761;5819.854503637443;5880.558958078247;5890.1164825276555;5915.467607915309;5952.851178720567;5871.060630299132;5918.822435326947;5934.762609495572;5946.821595352147;5949.940500594938;5685.658860468385;5789.957807594674;5843.883122337615;5851.063829787214;5859.326177489644;5852.502537284378;5867;5876.382979787232;5896.321922978912;5958.76164953397;5791.333996590446;5797.159411885169;5802.274715660543;5802.6808525531505;5824.271966004249 03:51:37 INFO - PROCESS | 3475 | |1;ext.html;642.5726891617074;650.6356440393383;653.8888388973877;659.0608383054148;677.8813707601169;38470;40311;43130.137397252074;43660.78169609155;43665.78167109168;44162.779186104024;44911.550884491146;44965.10069798602;45099.32351014738;45099.774501127446;8597.140285971383;8738.388312818106;8828.426152300111;8828.602712877935;8839.24866386358;8798.29613630908;8893.73318800437;8900.332475064364;8905;8940.910590894073;8774.73675789724;8837.779055523632;8854.690085846996;8855.645774169057;8901.777455563599;8833.779155521099;8852.070532594082;8879.822403551958;8887.111288871094;8917.598708058089;8715.997660269088;8736.956315218447;8736.956315218447;8795.032546419889;8824.911750882537;27535.86232068847;27549.17352479429;27621;27948.580771288445;27949.580756288673;3792.924141517182;3816.3512202925567;3909.4331321958157;4355.303151495746;4441.133978874121;33096.3380732384;33454;33640;33687.32625347479;33689.15777105592;4683.391159149289;4709.434867815884;4715.292706094079;4722.905541889178;4763.880902977418;322675;324044;325389;326734;327776.3611181953;61929;62669;62687.11938641848;62709.68645156745;62735.6863215681;40017;40776.59223407787;40955.1808963825;42681.146377072284;42770.35844462336;18825.05874706259;19061.428157155307;19129.52176195606;19133.617327653646;19151.521211969535;14598.41606335756;14660.486882959045;14710.190939498216;14737.778933316009;14749.77875331871;21460.463488412915;21519;21533.56932861334;21567.352979410643;21594.89202553977;7914.802129946682;8110.444345623267;8158.184181581913;8175.67297308101;8185.918140818635;1110.9277896936835;1151.7408583068743;1181.438816562126;1204.7771162334996;1204.9457774400173;33952.32095358079;34367;34529.44617492219;35003.4749478758;35223.59105635746;1095.2114477576133;1212.9757404851853;1217.6407959651924;1220.7436438347868;1311.4229738914846;16999.575010624587;17039.659206815795;17393.304267829397;17398.39105631297;17457.825421745874;620605;634159;635886;644114;1026460;61770.38229617736;62352.376476235564;62564.37435625677;62836.68581657154;62933.685331573965;1507.796447479598;1510.2750679673597;1511.4785399037535;1513.28119143406;1516.2494565190082;32123.072615643137;32300.35399292048;32852.50721239231;33139.66860331366;34175.14562135967;52966.20550691666;53041.7347913258;53188.46811531835;53292.4670753303;53678;438732;439049;439331;442356;444663;29875.701242987292;30255.69744302617;30422.239444014078;30692.539611906286;30966.380672386877;49678.751606241734;49902.750486247336;51724.74137629288;54388;58316.708416457644;44573.77713111414;44903.32645010393;45494.090118196786;46559;46593;44089.11821763611;44366.556334436245;45338.546614533436;45408.31887521624;45730;44307.11385772331;45342;45368.546314536434;45561.77219113883;45726.314105289115;38629;39430.21139577135;39630.40554391744;40751;40902.795486022376;29853.850730746206;30247;30748.077557673307;30816.84591577028;31024 03:51:37 INFO - PROCESS | 3475 | |2;jquery.html;411.15917947796754;411.6459844533701;417.28019166937054;422.72100413726946;439.9934000989984;19126.90436547817;20666.010285525786;21026.684599730997;21364.145434182614;21577.67633485499;20136.295229666965;20261.290854820047;20432.591348173028;20531.178752849868;20755.584888302226;5610.747516361753;5847.181394604738;5849.795257166;5850.268716410449;5866.941330586704;4321.052082246108;4470.173017991666;5710.543156547487;5756.856078598027;6420.967895160541;6439.58142720724;6495.025746138093;6508.837279068014;6557.901631475532;6578.079068930354;6302.46429053531;6390.392912673288;6403.199600050017;6410.070539771754;6416.230052393743;5524.06090964537;5559.305086864142;5576.804811831566;5624.043912534838;5649.689267090308;24566;24918.5016299673;25073;25127.120550780633;25372.49255014908;2631.644727961739;3016.5173572228337;3047.1467988962904;3246.3507298540385;3295.1103202135528;14644.41422343105;15101.848981510264;15338.463153789675;15457.149856757875;16048.518544443685;2054.239931225441;2071.8756874587575;2077.511784730587;2103.9474013149643;2133.5839511295303;87250;88975.11024889733;89408;90749;92034.07965920323;10363.430011349297;10445.791084178274;10737.570497180026;10796.946015269874;10818.567257309776;14445.92777036108;14547;14612.85387146115;14688.118712877262;14714.852851471562;8711.303095752324;8907.910920890838;8992;9014.63941442348;9108.18026377616;9051.683191088281;9073.13805188506;9168.26653867689;9247.630094796134;9259.629614815467;6884.931150688529;6924.93075069253;6998.4751143664425;7057.258987806309;7073.469489788286;1917.472695008856;1918.1305206069471;1921.2987259650126;1926.1717461491412;1947.7565304336958;995.7859060301925;1073.8121821114005;1115.8772535021142;1150.1603829204728;1205.3310412721023;20257.696134557995;20979.685304720442;21159.365219043455;21226;21299.46751331229;1019.1999280564721;1043.6451606453843;1075.1506310015156;1127.22784892349;1130.6551501791869;10917.257211298596;10947.099018760035;12105.273683579013;12230.143889927798;12349.3825308736;548662;567048;576709;579307;585853;64643.35356646468;91802;104605;105420;105578.47210763897;994.0655783563572;1004.1314263162458;1128.4019469681082;1158.8841115888513;1159.5767544846071;18507;18674.439766806474;18704.158312876225;18708.812911870707;18830.623387532447;45285.54714452945;45797.31304030509;47269;47640.761796192186;47959.28061079156;62394;64194.35805641884;65335.67332163309;66459.33540664725;66537.66731166313;8473.618687158969;8478.3641226907;8487.236148746642;8659.307255419677;8825.117488251124;13396.196228226338;13669.38487768033;14182.574522764333;14264.71470570562;14279.071860329046;11866.347350895783;12313.876861231272;12368.690782730504;12462.5014999399;12682.492700291885;11599.6520104397;11823.586174483851;11925.867042630936;12507.812382814083;12817.295048772034;12756.808647870104;12991.675208119872;13128.737425251633;13135.868641313464;13166.868331316564;8595.09751476111;8681.696140635047;8753.124687531195;8791.736247912573;8870.290376769972;12151.331676757509;12202.206856554296;12214.694632634255;12346.938265308616;12377.071719621244 03:51:37 INFO - PROCESS | 3475 | |3;mootools.html;1545.799046124004;1583.311259602073;1792.7131658934572;1893.7159426086093;1927.6722957097293;8350;9055.139761722627;9126.726198214055;9826.21390288778;9844.950775246123;9229.35394522382;9251.814963700723;9302.348835581512;9309.069093090688;9310.30172737044;2452.6566280720713;2500.9124680636182;2509.4855554611263;2514.421683012899;2517.144170981866;2312;2416.9516609667794;2426.4904370082304;2430.2466235466973;2431.9756802432016;2448.3511869354634;2452.791512721421;2454.6931633545805;2456.5823809952262;2457.0785955266774;2426.259990702835;2438.890249938757;2463.1255904154036;2464.963025554618;2468.9753102468926;2266.3427605994243;2287.9885600572056;2292.1862738727846;2299.9540009199723;2305.4812667149927;9355.4386736796;9394.295427842939;9425.811483770287;9429.90570094304;9465.90534094657;5250.396204436501;5324.041672498949;5353.03645343838;5354.812581559627;5510.862228444281;3342.7660063795543;3433.9828300858335;3484.756067075306;3504.299140171976;3611.043073585502;1223.853137623491;1248.6191711527981;1285.9164154330033;1311.5278499740086;1327.7610030194562;12418.75162496745;12426.440810163564;12469.501219951191;12478.376081195995;12506.624801255977;4835.202191638411;4879.243717223836;4903.632227582874;4944.728039957765;4993.450720420751;10624.575016999233;10633.946830265799;10669.83995240072;10718.624848130277;10731.785364292671;5561.4716601922755;5563.554915606742;5564.221009058735;5568;5588.497035266764;4508.233600287894;4956.10790057793;5058.949410505921;5073.239014147834;5099.158638824627;4330.588594083557;4374;4456.086502267028;4477.1269602427865;4509.143262780061;1378.81386012889;1416.6883285677134;1417.1992824054582;1419.524459306144;1427.6787722762294;942.533445944262;1009.848522721583;1103.442761405485;1109.0628418985943;1111.9777604447866;6621.536492445579;6672.566283191577;6751.56114852533;6769.424598909148;6854.554453960476;483.32576056401126;484.8230395905469;491.63373286901486;497.1647631978239;514.3210961530743;4621.214393553104;4646.326282688991;4676.415448068991;4679.415073115861;4715.056988602293;11576.47905844239;11970.700732481757;11984.580539681243;11986.220895641756;12015.038796896228;10909.454527273605;11315.83026254607;11322.32066076038;11330.943345283385;11895.345755983504;8523.872141917876;8726.999999999873;8747.912520874837;8763.474191548528;8773.38586298953;6410.551261411843;6594.406503414716;6762.594244345355;6778.42383397397;6816.727330906709;10281;10821;10850.0777433919;10927.398993055458;10968.23222374426;10966.780664386828;11074.39090850011;11188.608398706006;11199.048080912888;11327.433628318386;7904.565248911365;8705.825883482421;8828.470291782514;8837.425567338103;9061;9134.543272836465;9151.633934642807;9181.862272065791;9195.954020230123;9218.170364667212;7910.802229944297;8171.509709417454;8285.50286982783;8298.834023319621;8314.750557483285;8021.358291336563;8094.190580941859;8112.75661730149;8199.467034642728;8259.463134896212;7174.354308112086;7230.9638451807405;7248.0939882514685;7283.016792733125;7305.561666300039;5813.593048486566;5848.502877255481;5864.706764661835;5933.288005439203;5953.434423729739;5811.883762324815;5832.679202643895;5856.970715146397;5880.647161170173;5940.940590594038 03:51:37 INFO - PROCESS | 3475 | |4;prototype.html;350.5740525261808;363.0741608897311;363.963603639636;366.9082729317672;367.4616686554198;5576.498115169634;5608.915866262004;5660;5665.348484924235;5669.489745922866;5643.8024669136585;5676.120201368784;5688.886222275552;5706.1726049722765;5746.569007324447;4501.234790085677;4502.729836209822;4527.841525546606;4532.3201519771965;4553.317002449626;4437;4500.437445319335;4510.842120525782;4512.729236245819;4562.817487300504;4437.559342361688;4467.285234362503;4477.888052798674;4483.744551525578;4491.663125265602;4323.767726198019;4493.326001099828;4504.0407422771195;4508.842190523316;4517.480489743689;3937.803109844525;3939.153082087365;3941.940870886939;3942.763434193929;3946.092398748275;5519.889602207933;5523.143912693539;5526.756479792055;5533.944660553383;5540.972295138498;4901.534354236342;5082.119615742162;5092.261622064817;5093.592512599021;5161.528964245172;6041.607295525777;6045.576809623328;6071.901466510132;6078.179445774808;6093.177421048146;4237.4915010198665;4313.547077556874;4324.308110702273;4341.696081274312;4342.696011279212;6197.752089916398;6247.562670613059;6274.184356033732;6280.685965701697;6328.430441260309;4312.7627980461375;4393.626541743987;4403.581659742319;4421.248387774086;4439.178751930903;4496.685232033727;4502.054568540578;4502.887427814266;4511.3458548510935;4519.18654642161;4927.852164435073;5073.213651883964;5073.797048118034;5113.8721531962;5179.45615710345;5880.764769409176;6040.456358927718;6057.939420605826;6063;6079.361667024988;1526.8549487798641;1547.2341191110472;1548.2413617327654;1550.9302081406363;1551.7439622462393;961.3318743473359;965.4496936745987;977.4721650308895;983.3018556824592;994.8855881573712;5182.896342073137;5186.081149974533;5207.3751149862255;5207.3751149862255;5207.474374928157;5420.777481232676;5517.317218248473;5532.640378375473;5563.969151259761;5611.494965453129;4870.293807397908;5159.613029022838;5201.621570283878;5238.92141617876;5250.369955605275;2984.6716861145255;3009.7893147479904;3019.8188108713107;3025.8638361273797;3037.6202974628172;5511.9724401378535;5557;5602.327720673546;5633.352164501053;5644.322681278273;5833.591648584643;6358.650274234869;6370.299267080617;6379.904301435482;6391.360863913572;6235.345288744707;6294.339094395114;6307.211598550181;6310.432061114522;6335.289471842669;6088.934436473511;6229.719662615284;6248.218972628421;6254.8123556293385;6269.655168965751;6135.263768347827;6168.845778855385;6169.722362493609;6173.394917321439;6173.938260617516;6067;6271.874562508816;6286.8428289291305;6296.937030629635;6351.555391122762;4421.46942366918;4451.243288641003;4456.353828694886;4468.754218518013;4485.596296333346;6083.574149809471;6094.664793436404;6358;6362.491000719839;6376.649284289409;5960.374160713236;6031.577789554689;6048.455638992512;6064.393560644076;6109.663968481598;5959.1657167995645;6005.219321488354;6033.818985430444;6062.605930614496;6081.422264884829;5642.802501912413;5934.376890426443;5939.406059394026;5962.880742385041;5963.850903727442;6067.908981365372;6075.756969721162;6095.573309868267;6116.418940200674;6143.56995010345;5654.879420217419;5941.881162376641;5960.284765828128;6025.18659980897;6056.1824153740445 03:51:37 INFO - PROCESS | 3475 | |5;yui.html;780.7267456390264;814.6456291513192;855.0936007831699;857.3269983063301;868.6004437958538;16023.759643605355;16068;16103.516894493154;16184.514464566053;16235.756463653026;13687.657808554792;13693.794593081111;13710.794338084937;13723.245221512838;13736.244506552135;702.480164678137;845.0577605969362;867.0722327109995;868.6264906090379;869.0831173112364;852.5140669818206;858.1975852577829;860.9827803443927;868.7133246028795;869.5043825019741;909.6315992023241;909.7771046093683;912.5209265135791;913.853783394657;915.578833736482;910.0217266438572;910.6994691751706;910.8497097978892;911.544227886057;913.2420091324251;657.8486948001986;661.24287690594;661.6956200147938;664.40203816565;666.8099591616415;14406.135631862016;14472.782908256384;14480.275986200648;14518.637034074127;14552.781708274384;14688.853111468963;15847.841521584867;15902.681946361008;16397.91801040987;16743.413980510624;13741.450341986309;14083.295835208199;14234.928825355806;14613.26933653313;14658.486952956595;4745.311929770164;4752.144613969484;4832.057748738997;4977.228529577921;5008.273800298936;79240;79913.20086799115;82410;82993.58503207506;83728.16271837265;11948.223365481215;12062.396880155957;12445.439955202037;12514.436850341757;12541.686457838627;21482.677759833303;21638.567228655338;21893.452663683216;21943.67084493734;22279.331620051424;8453.327389355423;8535.487870727777;8597.398182127316;8608.655653773903;8812.471251724917;4756.310335001405;4761.238201887751;4771.093492236464;4787.2101103318255;4852.17513022787;3653.634636536325;3701.9259614808093;3744.588095309514;3744.6629803317833;3750.718696097804;699.5138378826666;727.5234721257585;729.8394353242385;731.5245090691093;765.1086484245902;799.8160423102719;817.1297568090084;832.3757182113415;842.9030661473886;844.5734903873505;11351.772964540663;11506.88493115075;11692;11727.88272117285;11863.228890122115;679.751890559942;745.7166276814776;748.9363404110711;821.8767184922309;843.9535825529532;5117.974410128;5257.290265814143;5315.3090098286975;5330.200469929541;5370.113931201308;128055.35972320079;129126;130537;136232;137846;75577.62211189019;85918;109382;110399;111461;82914.58542707248;96398;96941;99199.50400247953;100220;9545.0454954504;10243.692689219335;10324.122449591869;10691;10715.732106697395;58535.707321463124;59534;59845;59857.40142598518;60027;79159;81384.59307703424;90654.54672726594;91335;91335;12712.872871271169;12883.549075782303;13188.406521706354;13336.133151345131;13475.32623368808;13034.934825325812;13157.868421315665;13525.120867143603;13638.386272617954;14277.64305892361;12869.806952895528;13093.410796513988;13289.269090199745;13871.237081960186;14339.426422943383;14256.215908125152;14932.552023439313;15074.472393466176;15131.167785771888;15243.542693719206;10335.17318614524;12424.689382765142;14491.92754036223;14832;15039.624009399853;10878;11175.72060698489;11188.944055279671;11681.532738690357;12233.388330583257;11983.880161198626;12083.456244468844;12601.747965040464;12983.41574629125;12984.870151298745 03:51:37 INFO - PROCESS | 3475 | __end_tp_report 03:51:37 INFO - PROCESS | 3475 | __start_cc_report 03:51:37 INFO - PROCESS | 3475 | _x_x_mozilla_cycle_collect,342 03:51:37 INFO - PROCESS | 3475 | __end_cc_report 03:51:37 INFO - PROCESS | 3475 | __startTimestamp1468666297630__endTimestamp 03:51:37 INFO - PROCESS | 3475 | 03:51:37 INFO - PROCESS | 3475 | ------- Summary: start ------- 03:51:37 INFO - PROCESS | 3475 | Number of tests: 6 03:51:37 INFO - PROCESS | 3475 | 03:51:37 INFO - PROCESS | 3475 | [#0] dojo.html Cycles:165 Average:5633.54 Median:5833.80 stddev:614.14 (10.5%) stddev-sans-first:588.33 03:51:37 INFO - PROCESS | 3475 | Values: 3308.8 3346.3 3356.0 3386.1 3387.4 5566.4 5608.1 5622.2 5637.7 5700.5 5637.5 5665.5 5693.8 5701.3 5702.6 5163.5 5237.2 5250.4 5266.8 5301.0 5102.1 5122.9 5275.7 5293.4 5300.4 5207.3 5208.3 5213.9 5217.5 5242.7 5168.8 5175.1 5238.1 5248.5 5261.7 5114.7 5175.7 5217.6 5224.7 5260.3 5455.3 5508.0 5554.1 5559.1 5611.1 6028.9 6082.2 6094.9 6097.0 6105.4 5931.4 6122.8 6141.2 6148.2 6155.3 5636.9 5687.9 5718.8 5761.8 5770.2 6280.8 6287.7 6289.9 6302.5 6303.8 5786.5 5914.3 6034.2 6046.0 6046.1 6007.8 6084.3 6129.9 6135.8 6143.6 5953.1 6065.8 6078.6 6082.3 6107.8 5880.1 5989.8 6016.4 6080.5 6093.1 4634.0 4645.0 4646.4 4682.1 4693.7 4153.1 4177.6 4179.7 4189.9 4192.8 5773.7 5814.9 5831.0 5853.1 5861.0 5890.5 6078.9 6132.6 6150.8 6153.8 5797.0 5799.3 5802.0 5818.2 5822.1 5110.4 5158.2 5162.5 5184.8 5194.3 6113.4 6115.3 6123.4 6132.3 6140.7 6108.7 6122.3 6125.1 6136.0 6139.6 5833.8 5991.2 6005.6 6046.0 6134.5 5898.5 5932.5 5934.9 5946.0 5973.4 6053.3 6054.7 6058.2 6063.6 6069.2 5819.9 5880.6 5890.1 5915.5 5952.9 5871.1 5918.8 5934.8 5946.8 5949.9 5685.7 5790.0 5843.9 5851.1 5859.3 5852.5 5867.0 5876.4 5896.3 5958.8 5791.3 5797.2 5802.3 5802.7 5824.3 03:51:37 INFO - PROCESS | 3475 | 03:51:37 INFO - PROCESS | 3475 | [#1] ext.html Cycles:180 Average:65033.71 Median:438890.50 stddev:141273.33 (32.2%) stddev-sans-first:141586.92 03:51:37 INFO - PROCESS | 3475 | Values: 642.6 650.6 653.9 659.1 677.9 38470.0 40311.0 43130.1 43660.8 43665.8 44162.8 44911.6 44965.1 45099.3 45099.8 8597.1 8738.4 8828.4 8828.6 8839.2 8798.3 8893.7 8900.3 8905.0 8940.9 8774.7 8837.8 8854.7 8855.6 8901.8 8833.8 8852.1 8879.8 8887.1 8917.6 8716.0 8737.0 8737.0 8795.0 8824.9 27535.9 27549.2 27621.0 27948.6 27949.6 3792.9 3816.4 3909.4 4355.3 4441.1 33096.3 33454.0 33640.0 33687.3 33689.2 4683.4 4709.4 4715.3 4722.9 4763.9 322675.0 324044.0 325389.0 326734.0 327776.4 61929.0 62669.0 62687.1 62709.7 62735.7 40017.0 40776.6 40955.2 42681.1 42770.4 18825.1 19061.4 19129.5 19133.6 19151.5 14598.4 14660.5 14710.2 14737.8 14749.8 21460.5 21519.0 21533.6 21567.4 21594.9 7914.8 8110.4 8158.2 8175.7 8185.9 1110.9 1151.7 1181.4 1204.8 1204.9 33952.3 34367.0 34529.4 35003.5 35223.6 1095.2 1213.0 1217.6 1220.7 1311.4 16999.6 17039.7 17393.3 17398.4 17457.8 620605.0 634159.0 635886.0 644114.0 1026460.0 61770.4 62352.4 62564.4 62836.7 62933.7 1507.8 1510.3 1511.5 1513.3 1516.2 32123.1 32300.4 32852.5 33139.7 34175.1 52966.2 53041.7 53188.5 53292.5 53678.0 438732.0 439049.0 439331.0 442356.0 444663.0 29875.7 30255.7 30422.2 30692.5 30966.4 49678.8 49902.8 51724.7 54388.0 58316.7 44573.8 44903.3 45494.1 46559.0 46593.0 44089.1 44366.6 45338.5 45408.3 45730.0 44307.1 45342.0 45368.5 45561.8 45726.3 38629.0 39430.2 39630.4 40751.0 40902.8 29853.9 30247.0 30748.1 30816.8 31024.0 03:51:37 INFO - PROCESS | 3475 | 03:51:37 INFO - PROCESS | 3475 | [#2] jquery.html Cycles:180 Average:32556.47 Median:23071.84 stddev:94040.63 (407.6%) stddev-sans-first:94273.46 03:51:37 INFO - PROCESS | 3475 | Values: 411.2 411.6 417.3 422.7 440.0 19126.9 20666.0 21026.7 21364.1 21577.7 20136.3 20261.3 20432.6 20531.2 20755.6 5610.7 5847.2 5849.8 5850.3 5866.9 4321.1 4470.2 5710.5 5756.9 6421.0 6439.6 6495.0 6508.8 6557.9 6578.1 6302.5 6390.4 6403.2 6410.1 6416.2 5524.1 5559.3 5576.8 5624.0 5649.7 24566.0 24918.5 25073.0 25127.1 25372.5 2631.6 3016.5 3047.1 3246.4 3295.1 14644.4 15101.8 15338.5 15457.1 16048.5 2054.2 2071.9 2077.5 2103.9 2133.6 87250.0 88975.1 89408.0 90749.0 92034.1 10363.4 10445.8 10737.6 10796.9 10818.6 14445.9 14547.0 14612.9 14688.1 14714.9 8711.3 8907.9 8992.0 9014.6 9108.2 9051.7 9073.1 9168.3 9247.6 9259.6 6884.9 6924.9 6998.5 7057.3 7073.5 1917.5 1918.1 1921.3 1926.2 1947.8 995.8 1073.8 1115.9 1150.2 1205.3 20257.7 20979.7 21159.4 21226.0 21299.5 1019.2 1043.6 1075.2 1127.2 1130.7 10917.3 10947.1 12105.3 12230.1 12349.4 548662.0 567048.0 576709.0 579307.0 585853.0 64643.4 91802.0 104605.0 105420.0 105578.5 994.1 1004.1 1128.4 1158.9 1159.6 18507.0 18674.4 18704.2 18708.8 18830.6 45285.5 45797.3 47269.0 47640.8 47959.3 62394.0 64194.4 65335.7 66459.3 66537.7 8473.6 8478.4 8487.2 8659.3 8825.1 13396.2 13669.4 14182.6 14264.7 14279.1 11866.3 12313.9 12368.7 12462.5 12682.5 11599.7 11823.6 11925.9 12507.8 12817.3 12756.8 12991.7 13128.7 13135.9 13166.9 8595.1 8681.7 8753.1 8791.7 8870.3 12151.3 12202.2 12214.7 12346.9 12377.1 03:51:37 INFO - PROCESS | 3475 | 03:51:37 INFO - PROCESS | 3475 | [#3] mootools.html Cycles:180 Average:6193.88 Median:2659.26 stddev:3502.51 (131.7%) stddev-sans-first:3494.92 03:51:37 INFO - PROCESS | 3475 | Values: 1545.8 1583.3 1792.7 1893.7 1927.7 8350.0 9055.1 9126.7 9826.2 9845.0 9229.4 9251.8 9302.3 9309.1 9310.3 2452.7 2500.9 2509.5 2514.4 2517.1 2312.0 2417.0 2426.5 2430.2 2432.0 2448.4 2452.8 2454.7 2456.6 2457.1 2426.3 2438.9 2463.1 2465.0 2469.0 2266.3 2288.0 2292.2 2300.0 2305.5 9355.4 9394.3 9425.8 9429.9 9465.9 5250.4 5324.0 5353.0 5354.8 5510.9 3342.8 3434.0 3484.8 3504.3 3611.0 1223.9 1248.6 1285.9 1311.5 1327.8 12418.8 12426.4 12469.5 12478.4 12506.6 4835.2 4879.2 4903.6 4944.7 4993.5 10624.6 10633.9 10669.8 10718.6 10731.8 5561.5 5563.6 5564.2 5568.0 5588.5 4508.2 4956.1 5058.9 5073.2 5099.2 4330.6 4374.0 4456.1 4477.1 4509.1 1378.8 1416.7 1417.2 1419.5 1427.7 942.5 1009.8 1103.4 1109.1 1112.0 6621.5 6672.6 6751.6 6769.4 6854.6 483.3 484.8 491.6 497.2 514.3 4621.2 4646.3 4676.4 4679.4 4715.1 11576.5 11970.7 11984.6 11986.2 12015.0 10909.5 11315.8 11322.3 11330.9 11895.3 8523.9 8727.0 8747.9 8763.5 8773.4 6410.6 6594.4 6762.6 6778.4 6816.7 10281.0 10821.0 10850.1 10927.4 10968.2 10966.8 11074.4 11188.6 11199.0 11327.4 7904.6 8705.8 8828.5 8837.4 9061.0 9134.5 9151.6 9181.9 9196.0 9218.2 7910.8 8171.5 8285.5 8298.8 8314.8 8021.4 8094.2 8112.8 8199.5 8259.5 7174.4 7231.0 7248.1 7283.0 7305.6 5813.6 5848.5 5864.7 5933.3 5953.4 5811.9 5832.7 5857.0 5880.6 5940.9 03:51:37 INFO - PROCESS | 3475 | 03:51:37 INFO - PROCESS | 3475 | [#4] prototype.html Cycles:180 Average:4992.71 Median:5570.23 stddev:1468.63 (26.4%) stddev-sans-first:1430.82 03:51:37 INFO - PROCESS | 3475 | Values: 350.6 363.1 364.0 366.9 367.5 5576.5 5608.9 5660.0 5665.3 5669.5 5643.8 5676.1 5688.9 5706.2 5746.6 4501.2 4502.7 4527.8 4532.3 4553.3 4437.0 4500.4 4510.8 4512.7 4562.8 4437.6 4467.3 4477.9 4483.7 4491.7 4323.8 4493.3 4504.0 4508.8 4517.5 3937.8 3939.2 3941.9 3942.8 3946.1 5519.9 5523.1 5526.8 5533.9 5541.0 4901.5 5082.1 5092.3 5093.6 5161.5 6041.6 6045.6 6071.9 6078.2 6093.2 4237.5 4313.5 4324.3 4341.7 4342.7 6197.8 6247.6 6274.2 6280.7 6328.4 4312.8 4393.6 4403.6 4421.2 4439.2 4496.7 4502.1 4502.9 4511.3 4519.2 4927.9 5073.2 5073.8 5113.9 5179.5 5880.8 6040.5 6057.9 6063.0 6079.4 1526.9 1547.2 1548.2 1550.9 1551.7 961.3 965.4 977.5 983.3 994.9 5182.9 5186.1 5207.4 5207.4 5207.5 5420.8 5517.3 5532.6 5564.0 5611.5 4870.3 5159.6 5201.6 5238.9 5250.4 2984.7 3009.8 3019.8 3025.9 3037.6 5512.0 5557.0 5602.3 5633.4 5644.3 5833.6 6358.7 6370.3 6379.9 6391.4 6235.3 6294.3 6307.2 6310.4 6335.3 6088.9 6229.7 6248.2 6254.8 6269.7 6135.3 6168.8 6169.7 6173.4 6173.9 6067.0 6271.9 6286.8 6296.9 6351.6 4421.5 4451.2 4456.4 4468.8 4485.6 6083.6 6094.7 6358.0 6362.5 6376.6 5960.4 6031.6 6048.5 6064.4 6109.7 5959.2 6005.2 6033.8 6062.6 6081.4 5642.8 5934.4 5939.4 5962.9 5963.9 6067.9 6075.8 6095.6 6116.4 6143.6 5654.9 5941.9 5960.3 6025.2 6056.2 03:51:37 INFO - PROCESS | 3475 | 03:51:37 INFO - PROCESS | 3475 | [#5] yui.html Cycles:180 Average:22545.92 Median:3744.63 stddev:33183.93 (886.2%) stddev-sans-first:33236.78 03:51:37 INFO - PROCESS | 3475 | Values: 780.7 814.6 855.1 857.3 868.6 16023.8 16068.0 16103.5 16184.5 16235.8 13687.7 13693.8 13710.8 13723.2 13736.2 702.5 845.1 867.1 868.6 869.1 852.5 858.2 861.0 868.7 869.5 909.6 909.8 912.5 913.9 915.6 910.0 910.7 910.8 911.5 913.2 657.8 661.2 661.7 664.4 666.8 14406.1 14472.8 14480.3 14518.6 14552.8 14688.9 15847.8 15902.7 16397.9 16743.4 13741.5 14083.3 14234.9 14613.3 14658.5 4745.3 4752.1 4832.1 4977.2 5008.3 79240.0 79913.2 82410.0 82993.6 83728.2 11948.2 12062.4 12445.4 12514.4 12541.7 21482.7 21638.6 21893.5 21943.7 22279.3 8453.3 8535.5 8597.4 8608.7 8812.5 4756.3 4761.2 4771.1 4787.2 4852.2 3653.6 3701.9 3744.6 3744.7 3750.7 699.5 727.5 729.8 731.5 765.1 799.8 817.1 832.4 842.9 844.6 11351.8 11506.9 11692.0 11727.9 11863.2 679.8 745.7 748.9 821.9 844.0 5118.0 5257.3 5315.3 5330.2 5370.1 128055.4 129126.0 130537.0 136232.0 137846.0 75577.6 85918.0 109382.0 110399.0 111461.0 82914.6 96398.0 96941.0 99199.5 100220.0 9545.0 10243.7 10324.1 10691.0 10715.7 58535.7 59534.0 59845.0 59857.4 60027.0 79159.0 81384.6 90654.5 91335.0 91335.0 12712.9 12883.5 13188.4 13336.1 13475.3 13034.9 13157.9 13525.1 13638.4 14277.6 12869.8 13093.4 13289.3 13871.2 14339.4 14256.2 14932.6 15074.5 15131.2 15243.5 10335.2 12424.7 14491.9 14832.0 15039.6 10878.0 11175.7 11188.9 11681.5 12233.4 11983.9 12083.5 12601.7 12983.4 12984.9 03:51:37 INFO - PROCESS | 3475 | -------- Summary: end -------- 03:51:37 INFO - PROCESS | 3475 | 03:51:38 INFO - TEST-INFO | 3475: exit 0 03:51:38 INFO - TEST-OK | dromaeo_css | took 1111658ms 03:51:38 INFO - TEST-START | kraken 03:51:38 INFO - operating with platform_type : linux_ 03:51:38 INFO - Initialising browser for kraken test... 03:51:38 INFO - TEST-INFO | started process 3713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRUy0SL/profile http://localhost:35658/getInfo.html) 03:51:42 INFO - PROCESS | 3713 | __metrics Screen width/height:1600/1200 03:51:42 INFO - PROCESS | 3713 | colorDepth:24 03:51:42 INFO - PROCESS | 3713 | Browser inner width/height: 1024/697 03:51:42 INFO - PROCESS | 3713 | __metrics 03:51:43 ERROR - PROCESS | 3713 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:51:43 INFO - TEST-INFO | 3713: exit 0 03:51:43 INFO - Browser initialized. 03:51:43 INFO - Running cycle 1/1 for kraken test... 03:51:43 INFO - TEST-INFO | started process 3841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRUy0SL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:55 INFO - PROCESS | 3841 | RSS: Main: 156528640 03:51:55 INFO - PROCESS | 3841 | 03:51:58 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35658/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:59 INFO - PROCESS | 3841 | RSS: Main: 161665024 03:51:59 INFO - PROCESS | 3841 | 03:52:01 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35658/tests/kraken/driver.html?testName=audio-dft) 03:52:02 INFO - PROCESS | 3841 | RSS: Main: 161132544 03:52:02 INFO - PROCESS | 3841 | 03:52:05 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35658/tests/kraken/driver.html?testName=audio-fft) 03:52:05 INFO - PROCESS | 3841 | RSS: Main: 161419264 03:52:05 INFO - PROCESS | 3841 | 03:52:07 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35658/tests/kraken/driver.html?testName=audio-oscillator) 03:52:08 INFO - PROCESS | 3841 | RSS: Main: 161243136 03:52:08 INFO - PROCESS | 3841 | 03:52:10 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35658/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:52:11 INFO - PROCESS | 3841 | RSS: Main: 161366016 03:52:11 INFO - PROCESS | 3841 | 03:52:14 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35658/tests/kraken/driver.html?testName=imaging-darkroom) 03:52:15 INFO - PROCESS | 3841 | RSS: Main: 161382400 03:52:15 INFO - PROCESS | 3841 | 03:52:18 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35658/tests/kraken/driver.html?testName=imaging-desaturate) 03:52:19 INFO - PROCESS | 3841 | RSS: Main: 162033664 03:52:19 INFO - PROCESS | 3841 | 03:52:21 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35658/tests/kraken/driver.html?testName=json-parse-financial) 03:52:22 INFO - PROCESS | 3841 | RSS: Main: 161005568 03:52:22 INFO - PROCESS | 3841 | 03:52:24 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35658/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:52:24 INFO - PROCESS | 3841 | RSS: Main: 161107968 03:52:24 INFO - PROCESS | 3841 | 03:52:26 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:52:27 INFO - PROCESS | 3841 | RSS: Main: 161075200 03:52:27 INFO - PROCESS | 3841 | 03:52:29 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:52:30 INFO - PROCESS | 3841 | RSS: Main: 162099200 03:52:30 INFO - PROCESS | 3841 | 03:52:32 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:52:33 INFO - PROCESS | 3841 | RSS: Main: 161853440 03:52:33 INFO - PROCESS | 3841 | 03:52:36 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:52:36 INFO - PROCESS | 3841 | RSS: Main: 161746944 03:52:36 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35658/tests/kraken/driver.html?testName=ai-astar) 03:52:38 INFO - PROCESS | 3841 | RSS: Main: 162316288 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | __start_tp_report 03:52:38 INFO - PROCESS | 3841 | _x_x_mozilla_page_load 03:52:38 INFO - PROCESS | 3841 | _x_x_mozilla_page_load_details 03:52:38 INFO - PROCESS | 3841 | |i|pagename|runs| 03:52:38 INFO - PROCESS | 3841 | |0;ai-astar;113;103;111;111;112;112;111;110;110;109 03:52:38 INFO - PROCESS | 3841 | |1;audio-beat-detection;164;127;152;179;129;157;151;127;177;125 03:52:38 INFO - PROCESS | 3841 | |2;audio-dft;163;160;160;161;163;163;162;161;161;161 03:52:38 INFO - PROCESS | 3841 | |3;audio-fft;75;74;76;167;75;77;75;74;163;76 03:52:38 INFO - PROCESS | 3841 | |4;audio-oscillator;88;84;141;85;85;84;135;86;89;148 03:52:38 INFO - PROCESS | 3841 | |5;imaging-gaussian-blur;118;116;117;118;117;118;118;117;117;118 03:52:38 INFO - PROCESS | 3841 | |6;imaging-darkroom;146;148;149;147;146;148;147;148;147;146 03:52:38 INFO - PROCESS | 3841 | |7;imaging-desaturate;95;95;97;96;96;95;95;95;95;95 03:52:38 INFO - PROCESS | 3841 | |8;json-parse-financial;54;55;51;52;55;53;53;62;51;54 03:52:38 INFO - PROCESS | 3841 | |9;json-stringify-tinderbox;59;59;59;59;59;60;58;59;60;59 03:52:38 INFO - PROCESS | 3841 | |10;stanford-crypto-aes;81;83;83;76;76;77;76;80;100;82 03:52:38 INFO - PROCESS | 3841 | |11;stanford-crypto-ccm;124;124;140;130;132;124;126;124;131;121 03:52:38 INFO - PROCESS | 3841 | |12;stanford-crypto-pbkdf2;154;156;160;153;151;157;156;154;153;153 03:52:38 INFO - PROCESS | 3841 | |13;stanford-crypto-sha256-iterative;64;64;64;61;61;60;61;61;61;60 03:52:38 INFO - PROCESS | 3841 | __end_tp_report 03:52:38 INFO - PROCESS | 3841 | __start_cc_report 03:52:38 INFO - PROCESS | 3841 | _x_x_mozilla_cycle_collect,876 03:52:38 INFO - PROCESS | 3841 | __end_cc_report 03:52:38 INFO - PROCESS | 3841 | __startTimestamp1468666358480__endTimestamp 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | ------- Summary: start ------- 03:52:38 INFO - PROCESS | 3841 | Number of tests: 14 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.78 (2.5%) stddev-sans-first:2.76 03:52:38 INFO - PROCESS | 3841 | Values: 113.0 103.0 111.0 111.0 112.0 112.0 111.0 110.0 110.0 109.0 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:154.50 stddev:20.90 (13.5%) stddev-sans-first:21.43 03:52:38 INFO - PROCESS | 3841 | Values: 164.0 127.0 152.0 179.0 129.0 157.0 151.0 127.0 177.0 125.0 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.18 (0.7%) stddev-sans-first:1.12 03:52:38 INFO - PROCESS | 3841 | Values: 163.0 160.0 160.0 161.0 163.0 163.0 162.0 161.0 161.0 161.0 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:37.86 (50.5%) stddev-sans-first:39.58 03:52:38 INFO - PROCESS | 3841 | Values: 75.0 74.0 76.0 167.0 75.0 77.0 75.0 74.0 163.0 76.0 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:85.00 stddev:27.02 (31.8%) stddev-sans-first:28.14 03:52:38 INFO - PROCESS | 3841 | Values: 88.0 84.0 141.0 85.0 85.0 84.0 135.0 86.0 89.0 148.0 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 03:52:38 INFO - PROCESS | 3841 | Values: 118.0 116.0 117.0 118.0 117.0 118.0 118.0 117.0 117.0 118.0 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:1.03 (0.7%) stddev-sans-first:1.00 03:52:38 INFO - PROCESS | 3841 | Values: 146.0 148.0 149.0 147.0 146.0 148.0 147.0 148.0 147.0 146.0 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 03:52:38 INFO - PROCESS | 3841 | Values: 95.0 95.0 97.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:3.16 (5.9%) stddev-sans-first:3.35 03:52:38 INFO - PROCESS | 3841 | Values: 54.0 55.0 51.0 52.0 55.0 53.0 53.0 62.0 51.0 54.0 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 03:52:38 INFO - PROCESS | 3841 | Values: 59.0 59.0 59.0 59.0 59.0 60.0 58.0 59.0 60.0 59.0 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:80.50 stddev:7.15 (8.9%) stddev-sans-first:7.58 03:52:38 INFO - PROCESS | 3841 | Values: 81.0 83.0 83.0 76.0 76.0 77.0 76.0 80.0 100.0 82.0 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:128.00 stddev:5.66 (4.4%) stddev-sans-first:5.85 03:52:38 INFO - PROCESS | 3841 | Values: 124.0 124.0 140.0 130.0 132.0 124.0 126.0 124.0 131.0 121.0 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:155.00 stddev:2.58 (1.7%) stddev-sans-first:2.73 03:52:38 INFO - PROCESS | 3841 | Values: 154.0 156.0 160.0 153.0 151.0 157.0 156.0 154.0 153.0 153.0 03:52:38 INFO - PROCESS | 3841 | 03:52:38 INFO - PROCESS | 3841 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:61.00 stddev:1.64 (2.7%) stddev-sans-first:1.51 03:52:38 INFO - PROCESS | 3841 | Values: 64.0 64.0 64.0 61.0 61.0 60.0 61.0 61.0 61.0 60.0 03:52:38 INFO - PROCESS | 3841 | -------- Summary: end -------- 03:52:38 INFO - PROCESS | 3841 | 03:52:39 INFO - TEST-INFO | 3841: exit 0 03:52:39 INFO - TEST-OK | kraken | took 61100ms 03:52:39 INFO - SUITE-END | took 1172s 03:52:39 INFO - Completed test suite (00:19:32) 03:52:39 INFO - javascript benchmark 03:52:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7718.2639521314595, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3308.751843611729, 3346.33073385323, 3356.009977056768, 3386.119608901686, 3387.441072223083, 5566.359868615105, 5608.130739735338, 5622.212890195366, 5637.689927054015, 5700.486956173943, 5637.4644408781205, 5665.490105890469, 5693.800716974907, 5701.34434540028, 5702.629329093606, 5163.535281824635, 5237.214417837316, 5250.4487028861995, 5266.8419947401635, 5301.0, 5102.081625307444, 5122.92315615266, 5275.657082289658, 5293.364796224459, 5300.390455097655, 5207.3490813648295, 5208.322918020671, 5213.895722085556, 5217.530422261995, 5242.711650859202, 5168.819091331804, 5175.094358487268, 5238.109521381374, 5248.527632513054, 5261.657992230531, 5114.744262786846, 5175.689458632494, 5217.634765566412, 5224.738763061831, 5260.289860868772, 5455.290812194389, 5508.0, 5554.055810512182, 5559.138333558305, 5611.13027480737, 6028.909566356509, 6082.178905847698, 6094.9390506094815, 6097.024476083805, 6105.358937311607, 5931.436513531207, 6122.785702500391, 6141.201643786324, 6148.200733904609, 6155.322914479404, 5636.85907852307, 5687.857803554903, 5718.799842005551, 5761.769529218826, 5770.163326317703, 6280.780172693934, 6287.748490060438, 6289.937100629027, 6302.527310451735, 6303.842403939938, 5786.537077033827, 5914.319853216849, 6034.24571928509, 6045.969770151209, 6046.09308603713, 6007.789727359522, 6084.300305464928, 6129.8784197560135, 6135.815925522242, 6143.603994442082, 5953.1070339449425, 6065.8180254592435, 6078.574499785061, 6082.2701275847185, 6107.816765496953, 5880.117982302689, 5989.790357337472, 6016.368281330398, 6080.483158931452, 6093.11649810775, 4633.9536604634195, 4645.02454484562, 4646.442426908725, 4682.086993036325, 4693.694909830919, 4153.086321009373, 4177.56135605757, 4179.665626749853, 4189.853355132555, 4192.790360482025, 5773.711314434261, 5814.912776308359, 5830.970845145747, 5853.09277062056, 5861.0, 5890.52875769946, 6078.878422431527, 6132.601380910227, 6150.846228844225, 6153.815385538441, 5797.043487824546, 5799.2750906136735, 5802.042662960649, 5818.156367326714, 5822.1266809978, 5110.437851836295, 5158.200478925773, 5162.535371816554, 5184.818531351385, 5194.27280180775, 6113.4372296094125, 6115.328140165785, 6123.404636889863, 6132.280335668016, 6140.723667434976, 6108.677166059225, 6122.337166850004, 6125.11336343068, 6136.035599594403, 6139.614800607318, 5833.79581714638, 5991.161237426851, 6005.579609427298, 6045.969770151121, 6134.473082415357, 5898.528117750656, 5932.466078052996, 5934.9406505934385, 5945.970270148621, 5973.432523910222, 6053.273607167168, 6054.697265136638, 6058.212432383762, 6063.636181829104, 6069.180660610761, 5819.854503637443, 5880.558958078247, 5890.1164825276555, 5915.467607915309, 5952.851178720567, 5871.060630299132, 5918.822435326947, 5934.762609495572, 5946.821595352147, 5949.940500594938, 5685.658860468385, 5789.957807594674, 5843.883122337615, 5851.063829787214, 5859.326177489644, 5852.502537284378, 5867.0, 5876.382979787232, 5896.321922978912, 5958.76164953397, 5791.333996590446, 5797.159411885169, 5802.274715660543, 5802.6808525531505, 5824.271966004249], "value": 5593.8713816904765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.5726891617074, 650.6356440393383, 653.8888388973877, 659.0608383054148, 677.8813707601169, 38470.0, 40311.0, 43130.137397252074, 43660.78169609155, 43665.78167109168, 44162.779186104024, 44911.550884491146, 44965.10069798602, 45099.32351014738, 45099.774501127446, 8597.140285971383, 8738.388312818106, 8828.426152300111, 8828.602712877935, 8839.24866386358, 8798.29613630908, 8893.73318800437, 8900.332475064364, 8905.0, 8940.910590894073, 8774.73675789724, 8837.779055523632, 8854.690085846996, 8855.645774169057, 8901.777455563599, 8833.779155521099, 8852.070532594082, 8879.822403551958, 8887.111288871094, 8917.598708058089, 8715.997660269088, 8736.956315218447, 8736.956315218447, 8795.032546419889, 8824.911750882537, 27535.86232068847, 27549.17352479429, 27621.0, 27948.580771288445, 27949.580756288673, 3792.924141517182, 3816.3512202925567, 3909.4331321958157, 4355.303151495746, 4441.133978874121, 33096.3380732384, 33454.0, 33640.0, 33687.32625347479, 33689.15777105592, 4683.391159149289, 4709.434867815884, 4715.292706094079, 4722.905541889178, 4763.880902977418, 322675.0, 324044.0, 325389.0, 326734.0, 327776.3611181953, 61929.0, 62669.0, 62687.11938641848, 62709.68645156745, 62735.6863215681, 40017.0, 40776.59223407787, 40955.1808963825, 42681.146377072284, 42770.35844462336, 18825.05874706259, 19061.428157155307, 19129.52176195606, 19133.617327653646, 19151.521211969535, 14598.41606335756, 14660.486882959045, 14710.190939498216, 14737.778933316009, 14749.77875331871, 21460.463488412915, 21519.0, 21533.56932861334, 21567.352979410643, 21594.89202553977, 7914.802129946682, 8110.444345623267, 8158.184181581913, 8175.67297308101, 8185.918140818635, 1110.9277896936835, 1151.7408583068743, 1181.438816562126, 1204.7771162334996, 1204.9457774400173, 33952.32095358079, 34367.0, 34529.44617492219, 35003.4749478758, 35223.59105635746, 1095.2114477576133, 1212.9757404851853, 1217.6407959651924, 1220.7436438347868, 1311.4229738914846, 16999.575010624587, 17039.659206815795, 17393.304267829397, 17398.39105631297, 17457.825421745874, 620605.0, 634159.0, 635886.0, 644114.0, 1026460.0, 61770.38229617736, 62352.376476235564, 62564.37435625677, 62836.68581657154, 62933.685331573965, 1507.796447479598, 1510.2750679673597, 1511.4785399037535, 1513.28119143406, 1516.2494565190082, 32123.072615643137, 32300.35399292048, 32852.50721239231, 33139.66860331366, 34175.14562135967, 52966.20550691666, 53041.7347913258, 53188.46811531835, 53292.4670753303, 53678.0, 438732.0, 439049.0, 439331.0, 442356.0, 444663.0, 29875.701242987292, 30255.69744302617, 30422.239444014078, 30692.539611906286, 30966.380672386877, 49678.751606241734, 49902.750486247336, 51724.74137629288, 54388.0, 58316.708416457644, 44573.77713111414, 44903.32645010393, 45494.090118196786, 46559.0, 46593.0, 44089.11821763611, 44366.556334436245, 45338.546614533436, 45408.31887521624, 45730.0, 44307.11385772331, 45342.0, 45368.546314536434, 45561.77219113883, 45726.314105289115, 38629.0, 39430.21139577135, 39630.40554391744, 40751.0, 40902.795486022376, 29853.850730746206, 30247.0, 30748.077557673307, 30816.84591577028, 31024.0], "value": 20988.160361558887, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.15917947796754, 411.6459844533701, 417.28019166937054, 422.72100413726946, 439.9934000989984, 19126.90436547817, 20666.010285525786, 21026.684599730997, 21364.145434182614, 21577.67633485499, 20136.295229666965, 20261.290854820047, 20432.591348173028, 20531.178752849868, 20755.584888302226, 5610.747516361753, 5847.181394604738, 5849.795257166, 5850.268716410449, 5866.941330586704, 4321.052082246108, 4470.173017991666, 5710.543156547487, 5756.856078598027, 6420.967895160541, 6439.58142720724, 6495.025746138093, 6508.837279068014, 6557.901631475532, 6578.079068930354, 6302.46429053531, 6390.392912673288, 6403.199600050017, 6410.070539771754, 6416.230052393743, 5524.06090964537, 5559.305086864142, 5576.804811831566, 5624.043912534838, 5649.689267090308, 24566.0, 24918.5016299673, 25073.0, 25127.120550780633, 25372.49255014908, 2631.644727961739, 3016.5173572228337, 3047.1467988962904, 3246.3507298540385, 3295.1103202135528, 14644.41422343105, 15101.848981510264, 15338.463153789675, 15457.149856757875, 16048.518544443685, 2054.239931225441, 2071.8756874587575, 2077.511784730587, 2103.9474013149643, 2133.5839511295303, 87250.0, 88975.11024889733, 89408.0, 90749.0, 92034.07965920323, 10363.430011349297, 10445.791084178274, 10737.570497180026, 10796.946015269874, 10818.567257309776, 14445.92777036108, 14547.0, 14612.85387146115, 14688.118712877262, 14714.852851471562, 8711.303095752324, 8907.910920890838, 8992.0, 9014.63941442348, 9108.18026377616, 9051.683191088281, 9073.13805188506, 9168.26653867689, 9247.630094796134, 9259.629614815467, 6884.931150688529, 6924.93075069253, 6998.4751143664425, 7057.258987806309, 7073.469489788286, 1917.472695008856, 1918.1305206069471, 1921.2987259650126, 1926.1717461491412, 1947.7565304336958, 995.7859060301925, 1073.8121821114005, 1115.8772535021142, 1150.1603829204728, 1205.3310412721023, 20257.696134557995, 20979.685304720442, 21159.365219043455, 21226.0, 21299.46751331229, 1019.1999280564721, 1043.6451606453843, 1075.1506310015156, 1127.22784892349, 1130.6551501791869, 10917.257211298596, 10947.099018760035, 12105.273683579013, 12230.143889927798, 12349.3825308736, 548662.0, 567048.0, 576709.0, 579307.0, 585853.0, 64643.35356646468, 91802.0, 104605.0, 105420.0, 105578.47210763897, 994.0655783563572, 1004.1314263162458, 1128.4019469681082, 1158.8841115888513, 1159.5767544846071, 18507.0, 18674.439766806474, 18704.158312876225, 18708.812911870707, 18830.623387532447, 45285.54714452945, 45797.31304030509, 47269.0, 47640.761796192186, 47959.28061079156, 62394.0, 64194.35805641884, 65335.67332163309, 66459.33540664725, 66537.66731166313, 8473.618687158969, 8478.3641226907, 8487.236148746642, 8659.307255419677, 8825.117488251124, 13396.196228226338, 13669.38487768033, 14182.574522764333, 14264.71470570562, 14279.071860329046, 11866.347350895783, 12313.876861231272, 12368.690782730504, 12462.5014999399, 12682.492700291885, 11599.6520104397, 11823.586174483851, 11925.867042630936, 12507.812382814083, 12817.295048772034, 12756.808647870104, 12991.675208119872, 13128.737425251633, 13135.868641313464, 13166.868331316564, 8595.09751476111, 8681.696140635047, 8753.124687531195, 8791.736247912573, 8870.290376769972, 12151.331676757509, 12202.206856554296, 12214.694632634255, 12346.938265308616, 12377.071719621244], "value": 10047.806880291886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1545.799046124004, 1583.311259602073, 1792.7131658934572, 1893.7159426086093, 1927.6722957097293, 8350.0, 9055.139761722627, 9126.726198214055, 9826.21390288778, 9844.950775246123, 9229.35394522382, 9251.814963700723, 9302.348835581512, 9309.069093090688, 9310.30172737044, 2452.6566280720713, 2500.9124680636182, 2509.4855554611263, 2514.421683012899, 2517.144170981866, 2312.0, 2416.9516609667794, 2426.4904370082304, 2430.2466235466973, 2431.9756802432016, 2448.3511869354634, 2452.791512721421, 2454.6931633545805, 2456.5823809952262, 2457.0785955266774, 2426.259990702835, 2438.890249938757, 2463.1255904154036, 2464.963025554618, 2468.9753102468926, 2266.3427605994243, 2287.9885600572056, 2292.1862738727846, 2299.9540009199723, 2305.4812667149927, 9355.4386736796, 9394.295427842939, 9425.811483770287, 9429.90570094304, 9465.90534094657, 5250.396204436501, 5324.041672498949, 5353.03645343838, 5354.812581559627, 5510.862228444281, 3342.7660063795543, 3433.9828300858335, 3484.756067075306, 3504.299140171976, 3611.043073585502, 1223.853137623491, 1248.6191711527981, 1285.9164154330033, 1311.5278499740086, 1327.7610030194562, 12418.75162496745, 12426.440810163564, 12469.501219951191, 12478.376081195995, 12506.624801255977, 4835.202191638411, 4879.243717223836, 4903.632227582874, 4944.728039957765, 4993.450720420751, 10624.575016999233, 10633.946830265799, 10669.83995240072, 10718.624848130277, 10731.785364292671, 5561.4716601922755, 5563.554915606742, 5564.221009058735, 5568.0, 5588.497035266764, 4508.233600287894, 4956.10790057793, 5058.949410505921, 5073.239014147834, 5099.158638824627, 4330.588594083557, 4374.0, 4456.086502267028, 4477.1269602427865, 4509.143262780061, 1378.81386012889, 1416.6883285677134, 1417.1992824054582, 1419.524459306144, 1427.6787722762294, 942.533445944262, 1009.848522721583, 1103.442761405485, 1109.0628418985943, 1111.9777604447866, 6621.536492445579, 6672.566283191577, 6751.56114852533, 6769.424598909148, 6854.554453960476, 483.32576056401126, 484.8230395905469, 491.63373286901486, 497.1647631978239, 514.3210961530743, 4621.214393553104, 4646.326282688991, 4676.415448068991, 4679.415073115861, 4715.056988602293, 11576.47905844239, 11970.700732481757, 11984.580539681243, 11986.220895641756, 12015.038796896228, 10909.454527273605, 11315.83026254607, 11322.32066076038, 11330.943345283385, 11895.345755983504, 8523.872141917876, 8726.999999999873, 8747.912520874837, 8763.474191548528, 8773.38586298953, 6410.551261411843, 6594.406503414716, 6762.594244345355, 6778.42383397397, 6816.727330906709, 10281.0, 10821.0, 10850.0777433919, 10927.398993055458, 10968.23222374426, 10966.780664386828, 11074.39090850011, 11188.608398706006, 11199.048080912888, 11327.433628318386, 7904.565248911365, 8705.825883482421, 8828.470291782514, 8837.425567338103, 9061.0, 9134.543272836465, 9151.633934642807, 9181.862272065791, 9195.954020230123, 9218.170364667212, 7910.802229944297, 8171.509709417454, 8285.50286982783, 8298.834023319621, 8314.750557483285, 8021.358291336563, 8094.190580941859, 8112.75661730149, 8199.467034642728, 8259.463134896212, 7174.354308112086, 7230.9638451807405, 7248.0939882514685, 7283.016792733125, 7305.561666300039, 5813.593048486566, 5848.502877255481, 5864.706764661835, 5933.288005439203, 5953.434423729739, 5811.883762324815, 5832.679202643895, 5856.970715146397, 5880.647161170173, 5940.940590594038], "value": 4888.137596035428, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.5740525261808, 363.0741608897311, 363.963603639636, 366.9082729317672, 367.4616686554198, 5576.498115169634, 5608.915866262004, 5660.0, 5665.348484924235, 5669.489745922866, 5643.8024669136585, 5676.120201368784, 5688.886222275552, 5706.1726049722765, 5746.569007324447, 4501.234790085677, 4502.729836209822, 4527.841525546606, 4532.3201519771965, 4553.317002449626, 4437.0, 4500.437445319335, 4510.842120525782, 4512.729236245819, 4562.817487300504, 4437.559342361688, 4467.285234362503, 4477.888052798674, 4483.744551525578, 4491.663125265602, 4323.767726198019, 4493.326001099828, 4504.0407422771195, 4508.842190523316, 4517.480489743689, 3937.803109844525, 3939.153082087365, 3941.940870886939, 3942.763434193929, 3946.092398748275, 5519.889602207933, 5523.143912693539, 5526.756479792055, 5533.944660553383, 5540.972295138498, 4901.534354236342, 5082.119615742162, 5092.261622064817, 5093.592512599021, 5161.528964245172, 6041.607295525777, 6045.576809623328, 6071.901466510132, 6078.179445774808, 6093.177421048146, 4237.4915010198665, 4313.547077556874, 4324.308110702273, 4341.696081274312, 4342.696011279212, 6197.752089916398, 6247.562670613059, 6274.184356033732, 6280.685965701697, 6328.430441260309, 4312.7627980461375, 4393.626541743987, 4403.581659742319, 4421.248387774086, 4439.178751930903, 4496.685232033727, 4502.054568540578, 4502.887427814266, 4511.3458548510935, 4519.18654642161, 4927.852164435073, 5073.213651883964, 5073.797048118034, 5113.8721531962, 5179.45615710345, 5880.764769409176, 6040.456358927718, 6057.939420605826, 6063.0, 6079.361667024988, 1526.8549487798641, 1547.2341191110472, 1548.2413617327654, 1550.9302081406363, 1551.7439622462393, 961.3318743473359, 965.4496936745987, 977.4721650308895, 983.3018556824592, 994.8855881573712, 5182.896342073137, 5186.081149974533, 5207.3751149862255, 5207.3751149862255, 5207.474374928157, 5420.777481232676, 5517.317218248473, 5532.640378375473, 5563.969151259761, 5611.494965453129, 4870.293807397908, 5159.613029022838, 5201.621570283878, 5238.92141617876, 5250.369955605275, 2984.6716861145255, 3009.7893147479904, 3019.8188108713107, 3025.8638361273797, 3037.6202974628172, 5511.9724401378535, 5557.0, 5602.327720673546, 5633.352164501053, 5644.322681278273, 5833.591648584643, 6358.650274234869, 6370.299267080617, 6379.904301435482, 6391.360863913572, 6235.345288744707, 6294.339094395114, 6307.211598550181, 6310.432061114522, 6335.289471842669, 6088.934436473511, 6229.719662615284, 6248.218972628421, 6254.8123556293385, 6269.655168965751, 6135.263768347827, 6168.845778855385, 6169.722362493609, 6173.394917321439, 6173.938260617516, 6067.0, 6271.874562508816, 6286.8428289291305, 6296.937030629635, 6351.555391122762, 4421.46942366918, 4451.243288641003, 4456.353828694886, 4468.754218518013, 4485.596296333346, 6083.574149809471, 6094.664793436404, 6358.0, 6362.491000719839, 6376.649284289409, 5960.374160713236, 6031.577789554689, 6048.455638992512, 6064.393560644076, 6109.663968481598, 5959.1657167995645, 6005.219321488354, 6033.818985430444, 6062.605930614496, 6081.422264884829, 5642.802501912413, 5934.376890426443, 5939.406059394026, 5962.880742385041, 5963.850903727442, 6067.908981365372, 6075.756969721162, 6095.573309868267, 6116.418940200674, 6143.56995010345, 5654.879420217419, 5941.881162376641, 5960.284765828128, 6025.18659980897, 6056.1824153740445], "value": 4524.9308151213445, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.7267456390264, 814.6456291513192, 855.0936007831699, 857.3269983063301, 868.6004437958538, 16023.759643605355, 16068.0, 16103.516894493154, 16184.514464566053, 16235.756463653026, 13687.657808554792, 13693.794593081111, 13710.794338084937, 13723.245221512838, 13736.244506552135, 702.480164678137, 845.0577605969362, 867.0722327109995, 868.6264906090379, 869.0831173112364, 852.5140669818206, 858.1975852577829, 860.9827803443927, 868.7133246028795, 869.5043825019741, 909.6315992023241, 909.7771046093683, 912.5209265135791, 913.853783394657, 915.578833736482, 910.0217266438572, 910.6994691751706, 910.8497097978892, 911.544227886057, 913.2420091324251, 657.8486948001986, 661.24287690594, 661.6956200147938, 664.40203816565, 666.8099591616415, 14406.135631862016, 14472.782908256384, 14480.275986200648, 14518.637034074127, 14552.781708274384, 14688.853111468963, 15847.841521584867, 15902.681946361008, 16397.91801040987, 16743.413980510624, 13741.450341986309, 14083.295835208199, 14234.928825355806, 14613.26933653313, 14658.486952956595, 4745.311929770164, 4752.144613969484, 4832.057748738997, 4977.228529577921, 5008.273800298936, 79240.0, 79913.20086799115, 82410.0, 82993.58503207506, 83728.16271837265, 11948.223365481215, 12062.396880155957, 12445.439955202037, 12514.436850341757, 12541.686457838627, 21482.677759833303, 21638.567228655338, 21893.452663683216, 21943.67084493734, 22279.331620051424, 8453.327389355423, 8535.487870727777, 8597.398182127316, 8608.655653773903, 8812.471251724917, 4756.310335001405, 4761.238201887751, 4771.093492236464, 4787.2101103318255, 4852.17513022787, 3653.634636536325, 3701.9259614808093, 3744.588095309514, 3744.6629803317833, 3750.718696097804, 699.5138378826666, 727.5234721257585, 729.8394353242385, 731.5245090691093, 765.1086484245902, 799.8160423102719, 817.1297568090084, 832.3757182113415, 842.9030661473886, 844.5734903873505, 11351.772964540663, 11506.88493115075, 11692.0, 11727.88272117285, 11863.228890122115, 679.751890559942, 745.7166276814776, 748.9363404110711, 821.8767184922309, 843.9535825529532, 5117.974410128, 5257.290265814143, 5315.3090098286975, 5330.200469929541, 5370.113931201308, 128055.35972320079, 129126.0, 130537.0, 136232.0, 137846.0, 75577.62211189019, 85918.0, 109382.0, 110399.0, 111461.0, 82914.58542707248, 96398.0, 96941.0, 99199.50400247953, 100220.0, 9545.0454954504, 10243.692689219335, 10324.122449591869, 10691.0, 10715.732106697395, 58535.707321463124, 59534.0, 59845.0, 59857.40142598518, 60027.0, 79159.0, 81384.59307703424, 90654.54672726594, 91335.0, 91335.0, 12712.872871271169, 12883.549075782303, 13188.406521706354, 13336.133151345131, 13475.32623368808, 13034.934825325812, 13157.868421315665, 13525.120867143603, 13638.386272617954, 14277.64305892361, 12869.806952895528, 13093.410796513988, 13289.269090199745, 13871.237081960186, 14339.426422943383, 14256.215908125152, 14932.552023439313, 15074.472393466176, 15131.167785771888, 15243.542693719206, 10335.17318614524, 12424.689382765142, 14491.92754036223, 14832.0, 15039.624009399853, 10878.0, 11175.72060698489, 11188.944055279671, 11681.532738690357, 12233.388330583257, 11983.880161198626, 12083.456244468844, 12601.747965040464, 12983.41574629125, 12984.870151298745], "value": 8101.43405470901, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 103.0, 111.0, 111.0, 112.0, 112.0, 111.0, 110.0, 110.0, 109.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 127.0, 152.0, 179.0, 129.0, 157.0, 151.0, 127.0, 177.0, 125.0], "value": 148.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 161.0, 163.0, 163.0, 162.0, 161.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 167.0, 75.0, 77.0, 75.0, 74.0, 163.0, 76.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 141.0, 85.0, 85.0, 84.0, 135.0, 86.0, 89.0, 148.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 149.0, 147.0, 146.0, 148.0, 147.0, 148.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 51.0, 52.0, 55.0, 53.0, 53.0, 62.0, 51.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 58.0, 59.0, 60.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 83.0, 76.0, 76.0, 77.0, 76.0, 80.0, 100.0, 82.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 140.0, 130.0, 132.0, 124.0, 126.0, 124.0, 131.0, 121.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 160.0, 153.0, 151.0, 157.0, 156.0, 154.0, 153.0, 153.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0], "value": 61.7, "unit": "score"}]}]} 03:52:39 INFO - Return code: 0 03:52:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:52:39 ERROR - # TBPL SUCCESS # 03:52:39 INFO - Running post-action listener: _resource_record_post_action 03:52:39 INFO - ##### 03:52:39 INFO - ##### Finished run-tests step (success) 03:52:39 INFO - ##### 03:52:39 INFO - Running post-run listener: _resource_record_post_run 03:52:39 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8060928; Write bytes: 391864320; Read time: 1508; Write time: 300292 03:52:39 INFO - TinderboxPrint: CPU usage
13.4% 03:52:39 INFO - TinderboxPrint: I/O read bytes / time
8,060,928 / 1,508 03:52:39 INFO - TinderboxPrint: I/O write bytes / time
391,864,320 / 300,292 03:52:39 INFO - TinderboxPrint: CPU idle
8,222.5 (86.6%) 03:52:39 INFO - TinderboxPrint: CPU user
1,213.2 (12.8%) 03:52:39 INFO - TinderboxPrint: Swap in / out
0 / 0 03:52:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15679488; Read time: 0; Write time: 2668 03:52:39 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 6168576; Write bytes: 376184832; Read time: 1268; Write time: 297624 03:52:40 INFO - Running post-run listener: _upload_blobber_files 03:52:40 INFO - Blob upload gear active. 03:52:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:52:40 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 03:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:52:40 INFO - (blobuploader) - INFO - Open directory for files ... 03:52:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:52:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:52:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:41 INFO - (blobuploader) - INFO - Done attempting. 03:52:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:52:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:52:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:45 INFO - (blobuploader) - INFO - Done attempting. 03:52:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:52:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:52:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:46 INFO - (blobuploader) - INFO - Done attempting. 03:52:46 INFO - (blobuploader) - INFO - Iteration through files over. 03:52:46 INFO - Return code: 0 03:52:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:52:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:52:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db97c793db553678efa2aa68c432b65826acff67a1e7b082bc75dd1b02df93aa532299a92fa1e090a1c866750f84cb1d088137e9a359f2f34fad95e8164750d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/685dea551fa184b0947d4ed293da833108bd922672a97645fbe83d83e104b91517c9513b11f5cd155b9400950656e72f9877815c118f2198b935694d74c85e6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5f53b31b84e7abf44f585bf0c8d2b254b37da3ac5079e662e9fca0d8a0d111bc1df0cb426810de94fc9f81275fbc0879e61e963beeee5f606a91dbd44aa8d6c"} 03:52:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:52:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:52:46 INFO - Contents: 03:52:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db97c793db553678efa2aa68c432b65826acff67a1e7b082bc75dd1b02df93aa532299a92fa1e090a1c866750f84cb1d088137e9a359f2f34fad95e8164750d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/685dea551fa184b0947d4ed293da833108bd922672a97645fbe83d83e104b91517c9513b11f5cd155b9400950656e72f9877815c118f2198b935694d74c85e6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5f53b31b84e7abf44f585bf0c8d2b254b37da3ac5079e662e9fca0d8a0d111bc1df0cb426810de94fc9f81275fbc0879e61e963beeee5f606a91dbd44aa8d6c"} 03:52:46 INFO - Running post-run listener: copy_logs_to_upload_dir 03:52:46 INFO - Copying logs to upload dir... 03:52:46 INFO - mkdir: /builds/slave/test/build/upload/logs 03:52:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.584133 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-16 03:52:46.823406) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 03:52:46.826718) ========= 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=d2a8c569965ab8367867b893000001a1-1468663859.659187-87942823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db97c793db553678efa2aa68c432b65826acff67a1e7b082bc75dd1b02df93aa532299a92fa1e090a1c866750f84cb1d088137e9a359f2f34fad95e8164750d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/685dea551fa184b0947d4ed293da833108bd922672a97645fbe83d83e104b91517c9513b11f5cd155b9400950656e72f9877815c118f2198b935694d74c85e6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5f53b31b84e7abf44f585bf0c8d2b254b37da3ac5079e662e9fca0d8a0d111bc1df0cb426810de94fc9f81275fbc0879e61e963beeee5f606a91dbd44aa8d6c"} build_url:https://queue.taskcluster.net/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/I-p95xQwSlmebYH2xCgUcw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db97c793db553678efa2aa68c432b65826acff67a1e7b082bc75dd1b02df93aa532299a92fa1e090a1c866750f84cb1d088137e9a359f2f34fad95e8164750d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/685dea551fa184b0947d4ed293da833108bd922672a97645fbe83d83e104b91517c9513b11f5cd155b9400950656e72f9877815c118f2198b935694d74c85e6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5f53b31b84e7abf44f585bf0c8d2b254b37da3ac5079e662e9fca0d8a0d111bc1df0cb426810de94fc9f81275fbc0879e61e963beeee5f606a91dbd44aa8d6c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 03:52:46.853732) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:52:46.854251) ========= 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=d2a8c569965ab8367867b893000001a1-1468663859.659187-87942823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004386 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:52:46.937645) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 03:52:46.938030) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 03:52:46.938447) ========= ========= Total master_lag: 0.18 =========