builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1466996725.82 results: success (0) buildid: 20160626173008 builduid: 1048c84d6b4745c3b323e55cfdf449ed revision: 110c7ad7d399d16b9c77940f766a26df5d90f881 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:25.816372) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:25.817380) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:25.818090) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:25.941336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:25.941654) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-26 20:05:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.3M=0s 2016-06-26 20:05:27 (35.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087134 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:26.049148) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:26.049895) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018352 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:26.110417) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-26 20:05:26.111229) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 110c7ad7d399d16b9c77940f766a26df5d90f881 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 110c7ad7d399d16b9c77940f766a26df5d90f881 --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=e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-26 20:05:27,439 truncating revision to first 12 chars 2016-06-26 20:05:27,439 Setting DEBUG logging. 2016-06-26 20:05:27,439 attempt 1/10 2016-06-26 20:05:27,439 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/110c7ad7d399?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-26 20:05:27,928 unpacking tar archive at: fx-team-110c7ad7d399/testing/mozharness/ program finished with exit code 0 elapsedTime=1.076911 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-26 20:05:27.207592) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:27.208068) ========= script_repo_revision: 110c7ad7d399d16b9c77940f766a26df5d90f881 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:27.208696) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:27.209546) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:27.220529) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-26 20:05:27.220978) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:05:28 INFO - MultiFileLogger online at 20160626 20:05:28 in /builds/slave/test 20:05:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:05:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:05:28 INFO - {'append_to_log': False, 20:05:28 INFO - 'base_work_dir': '/builds/slave/test', 20:05:28 INFO - 'blob_upload_branch': 'Fx-Team', 20:05:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:05:28 INFO - 'branch': 'Fx-Team', 20:05:28 INFO - 'buildbot_json_path': 'buildprops.json', 20:05:28 INFO - 'config_files': ('talos/linux_config.py',), 20:05:28 INFO - 'default_actions': ('clobber', 20:05:28 INFO - 'read-buildbot-config', 20:05:28 INFO - 'download-and-extract', 20:05:28 INFO - 'populate-webroot', 20:05:28 INFO - 'create-virtualenv', 20:05:28 INFO - 'install', 20:05:28 INFO - 'run-tests'), 20:05:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:05:28 INFO - 'download_minidump_stackwalk': True, 20:05:28 INFO - 'download_symbols': 'ondemand', 20:05:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:05:28 INFO - 'tooltool.py': '/tools/tooltool.py', 20:05:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:05:28 INFO - '/tools/misc-python/virtualenv.py')}, 20:05:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:05:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:05:28 INFO - 'installer_path': 'installer.exe', 20:05:28 INFO - 'log_level': 'info', 20:05:28 INFO - 'log_name': 'talos', 20:05:28 INFO - 'log_to_console': True, 20:05:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:05:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:05:28 INFO - 'opt_config_files': (), 20:05:28 INFO - 'pip_index': False, 20:05:28 INFO - 'sps_profile': False, 20:05:28 INFO - 'sps_profile_interval': 0, 20:05:28 INFO - 'suite': 'dromaeojs-e10s', 20:05:28 INFO - 'system_bits': '32', 20:05:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:05:28 INFO - 'title': 'talos-linux64-ix-006', 20:05:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:05:28 INFO - 'use_talos_json': True, 20:05:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:05:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:05:28 INFO - 'work_dir': 'build'} 20:05:28 INFO - ##### 20:05:28 INFO - ##### Running clobber step. 20:05:28 INFO - ##### 20:05:28 INFO - Running pre-action listener: _resource_record_pre_action 20:05:28 INFO - Running main action method: clobber 20:05:28 INFO - rmtree: /builds/slave/test/build 20:05:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:05:29 INFO - Running post-action listener: _resource_record_post_action 20:05:29 INFO - ##### 20:05:29 INFO - ##### Finished clobber step (success) 20:05:29 INFO - ##### 20:05:29 INFO - ##### 20:05:29 INFO - ##### Running read-buildbot-config step. 20:05:29 INFO - ##### 20:05:29 INFO - Running pre-action listener: _resource_record_pre_action 20:05:29 INFO - Running main action method: read_buildbot_config 20:05:29 INFO - Using buildbot properties: 20:05:29 INFO - { 20:05:29 INFO - "project": "", 20:05:29 INFO - "product": "firefox", 20:05:29 INFO - "script_repo_revision": "production", 20:05:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:05:29 INFO - "repository": "", 20:05:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:05:29 INFO - "buildid": "20160626173008", 20:05:29 INFO - "pgo_build": "True", 20:05:29 INFO - "basedir": "/builds/slave/test", 20:05:29 INFO - "buildnumber": 506, 20:05:29 INFO - "slavename": "talos-linux64-ix-006", 20:05:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:05:29 INFO - "platform": "ubuntu64_hw", 20:05:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:05:29 INFO - "branch": "fx-team", 20:05:29 INFO - "repo_path": "integration/fx-team", 20:05:29 INFO - "revision": "110c7ad7d399d16b9c77940f766a26df5d90f881", 20:05:29 INFO - "stage_platform": "linux64-pgo", 20:05:29 INFO - "builduid": "1048c84d6b4745c3b323e55cfdf449ed", 20:05:29 INFO - "slavebuilddir": "test" 20:05:29 INFO - } 20:05:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:05:29 INFO - Running post-action listener: _resource_record_post_action 20:05:29 INFO - ##### 20:05:29 INFO - ##### Finished read-buildbot-config step (success) 20:05:29 INFO - ##### 20:05:29 INFO - ##### 20:05:29 INFO - ##### Running download-and-extract step. 20:05:29 INFO - ##### 20:05:29 INFO - Running pre-action listener: _resource_record_pre_action 20:05:29 INFO - Running main action method: download_and_extract 20:05:29 INFO - mkdir: /builds/slave/test/build/tests 20:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:29 INFO - https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:05:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:05:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:05:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:05:35 INFO - Downloaded 1361 bytes. 20:05:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:05:35 INFO - Using the following test package requirements: 20:05:35 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:05:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:05:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:05:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:35 INFO - u'jsshell-linux-x86_64.zip'], 20:05:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:05:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:05:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:05:35 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:05:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:05:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:05:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:35 INFO - https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:05:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:05:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:05:37 INFO - Downloaded 24279422 bytes. 20:05:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:05:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:05:39 INFO - Return code: 0 20:05:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:39 INFO - https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:05:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:05:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:05:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:05:42 INFO - Downloaded 24279422 bytes. 20:05:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:05:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:05:44 INFO - Return code: 0 20:05:44 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')]} 20:05:44 INFO - https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:05:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:05:45 INFO - Downloaded 14405240 bytes. 20:05:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:05:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:05:45 INFO - Return code: 0 20:05: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')]} 20:05:45 INFO - https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:05:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:05:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:05:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:05:47 INFO - Downloaded 60158240 bytes. 20:05:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:05:47 INFO - mkdir: /builds/slave/test/properties 20:05:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:05:47 INFO - Writing to file /builds/slave/test/properties/build_url 20:05:47 INFO - Contents: 20:05:47 INFO - build_url:https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:05:48 INFO - Running post-action listener: _resource_record_post_action 20:05:48 INFO - Running post-action listener: set_extra_try_arguments 20:05:48 INFO - ##### 20:05:48 INFO - ##### Finished download-and-extract step (success) 20:05:48 INFO - ##### 20:05:48 INFO - ##### 20:05:48 INFO - ##### Running populate-webroot step. 20:05:48 INFO - ##### 20:05:48 INFO - Running pre-action listener: _resource_record_pre_action 20:05:48 INFO - Running main action method: populate_webroot 20:05:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:05:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:05:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:05:48 INFO - '--tppagecycles', 20:05:48 INFO - '7'], 20:05:48 INFO - 'tests': ['tsvgm']}}, 20:05:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:05:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:05:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:05:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:05:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:05:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:05:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:48 INFO - 'talos_options': ['--disable-e10s'], 20:05:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:48 INFO - 'talos_options': ['--disable-e10s'], 20:05:48 INFO - 'tests': ['damp', 'tps']}, 20:05:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:48 INFO - 'tests': ['damp', 'tps']}, 20:05:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:05:48 INFO - 'tests': ['dromaeo_dom']}, 20:05:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:05:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:05:48 INFO - 'tests': ['basic_compositor_video']}, 20:05:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:05:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:05:48 INFO - 'tests': ['a11yr', 20:05:48 INFO - 'ts_paint', 20:05:48 INFO - 'tpaint', 20:05:48 INFO - 'sessionrestore', 20:05:48 INFO - 'sessionrestore_no_auto_restore', 20:05:48 INFO - 'tabpaint']}, 20:05:48 INFO - 'other-e10s': {'tests': ['a11yr', 20:05:48 INFO - 'ts_paint', 20:05:48 INFO - 'tpaint', 20:05:48 INFO - 'sessionrestore', 20:05:48 INFO - 'sessionrestore_no_auto_restore', 20:05:48 INFO - 'tabpaint']}, 20:05:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:05:48 INFO - 'ts_paint', 20:05:48 INFO - 'tpaint', 20:05:48 INFO - 'sessionrestore', 20:05:48 INFO - 'sessionrestore_no_auto_restore', 20:05:48 INFO - 'tabpaint']}, 20:05:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:05:48 INFO - 'ts_paint', 20:05:48 INFO - 'tpaint', 20:05:48 INFO - 'sessionrestore', 20:05:48 INFO - 'sessionrestore_no_auto_restore', 20:05:48 INFO - 'tabpaint']}, 20:05:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:05:48 INFO - 'tests': ['a11yr', 20:05:48 INFO - 'ts_paint', 20:05:48 INFO - 'tpaint', 20:05:48 INFO - 'sessionrestore', 20:05:48 INFO - 'sessionrestore_no_auto_restore', 20:05:48 INFO - 'tabpaint']}, 20:05:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:05:48 INFO - 'tests': ['a11yr', 20:05:48 INFO - 'ts_paint', 20:05:48 INFO - 'tpaint', 20:05:48 INFO - 'sessionrestore', 20:05:48 INFO - 'sessionrestore_no_auto_restore', 20:05:48 INFO - 'tabpaint']}, 20:05:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:05:48 INFO - 'tests': ['tsvgx', 20:05:48 INFO - 'tsvgr_opacity', 20:05:48 INFO - 'tart', 20:05:48 INFO - 'tscrollx', 20:05:48 INFO - 'cart']}, 20:05:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:05:48 INFO - 'tsvgr_opacity', 20:05:48 INFO - 'tart', 20:05:48 INFO - 'tscrollx', 20:05:48 INFO - 'cart']}, 20:05:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:48 INFO - 'talos_options': ['--disable-e10s'], 20:05:48 INFO - 'tests': ['tp5o']}, 20:05:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:48 INFO - 'tests': ['tp5o']}, 20:05:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:48 INFO - 'talos_options': ['--disable-e10s', 20:05:48 INFO - '--xperf_path', 20:05:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:48 INFO - 'tests': ['tp5n']}, 20:05:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:48 INFO - 'talos_options': ['--xperf_path', 20:05:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:48 INFO - 'tests': ['tp5n']}}, 20:05:48 INFO - 'talos.zip': {'path': '', 20:05:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:05:48 INFO - Running post-action listener: _resource_record_post_action 20:05:48 INFO - ##### 20:05:48 INFO - ##### Finished populate-webroot step (success) 20:05:48 INFO - ##### 20:05:48 INFO - ##### 20:05:48 INFO - ##### Running create-virtualenv step. 20:05:48 INFO - ##### 20:05:48 INFO - Running pre-action listener: _resource_record_pre_action 20:05:48 INFO - Running main action method: create_virtualenv 20:05:48 INFO - Creating virtualenv /builds/slave/test/build/venv 20:05:48 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 20:05:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:05:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:05:48 INFO - Using real prefix '/usr' 20:05:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:05:48 INFO - Installing distribute.............................................................................................................................................................................................done. 20:05:50 INFO - Installing pip.................done. 20:05:50 INFO - Return code: 0 20:05:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:05:50 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')]} 20:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:50 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')]} 20:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:50 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 0x7f8bd3c91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a6f0>, '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 0x206b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206baa0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', '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 20:05:50 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 20:05:50 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 20:05:50 INFO - Using env: {'DISPLAY': ':0', 20:05:50 INFO - 'HOME': '/home/cltbld', 20:05:50 INFO - 'LANG': 'en_US.UTF-8', 20:05:50 INFO - 'LANGUAGE': 'en_US:en', 20:05:50 INFO - 'LOGNAME': 'cltbld', 20:05:50 INFO - 'MAIL': '/var/mail/cltbld', 20:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:50 INFO - 'MOZ_NO_REMOTE': '1', 20:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:50 INFO - 'NO_EM_RESTART': '1', 20:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:50 INFO - 'PWD': '/builds/slave/test', 20:05:50 INFO - 'SHELL': '/bin/bash', 20:05:50 INFO - 'SHLVL': '1', 20:05:50 INFO - 'TERM': 'linux', 20:05:50 INFO - 'TMOUT': '86400', 20:05:50 INFO - 'USER': 'cltbld', 20:05:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', 20:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:50 INFO - '_': '/tools/buildbot/bin/python'} 20:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:50 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 20:05:50 INFO - Cleaning up... 20:05:51 INFO - Return code: 0 20:05:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8bd3c91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a6f0>, '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 0x206b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206baa0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', '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 20:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:05:51 INFO - Using env: {'DISPLAY': ':0', 20:05:51 INFO - 'HOME': '/home/cltbld', 20:05:51 INFO - 'LANG': 'en_US.UTF-8', 20:05:51 INFO - 'LANGUAGE': 'en_US:en', 20:05:51 INFO - 'LOGNAME': 'cltbld', 20:05:51 INFO - 'MAIL': '/var/mail/cltbld', 20:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:51 INFO - 'MOZ_NO_REMOTE': '1', 20:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:51 INFO - 'NO_EM_RESTART': '1', 20:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:51 INFO - 'PWD': '/builds/slave/test', 20:05:51 INFO - 'SHELL': '/bin/bash', 20:05:51 INFO - 'SHLVL': '1', 20:05:51 INFO - 'TERM': 'linux', 20:05:51 INFO - 'TMOUT': '86400', 20:05:51 INFO - 'USER': 'cltbld', 20:05:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', 20:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:51 INFO - '_': '/tools/buildbot/bin/python'} 20:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:51 INFO - Downloading/unpacking psutil>=3.1.1 20:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:05:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:53 INFO - Installing collected packages: psutil 20:05:53 INFO - Running setup.py install for psutil 20:05:53 INFO - building 'psutil._psutil_linux' extension 20:05:53 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 20:05:53 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 20:05:53 INFO - building 'psutil._psutil_posix' extension 20:05:53 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 20:05:53 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 20:05:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:53 INFO - Successfully installed psutil 20:05:53 INFO - Cleaning up... 20:05:53 INFO - Return code: 0 20:05:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bd3c91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a6f0>, '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 0x206b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206baa0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', '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 20:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:05:53 INFO - Using env: {'DISPLAY': ':0', 20:05:53 INFO - 'HOME': '/home/cltbld', 20:05:53 INFO - 'LANG': 'en_US.UTF-8', 20:05:53 INFO - 'LANGUAGE': 'en_US:en', 20:05:53 INFO - 'LOGNAME': 'cltbld', 20:05:53 INFO - 'MAIL': '/var/mail/cltbld', 20:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:53 INFO - 'MOZ_NO_REMOTE': '1', 20:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:53 INFO - 'NO_EM_RESTART': '1', 20:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:53 INFO - 'PWD': '/builds/slave/test', 20:05:53 INFO - 'SHELL': '/bin/bash', 20:05:53 INFO - 'SHLVL': '1', 20:05:53 INFO - 'TERM': 'linux', 20:05:53 INFO - 'TMOUT': '86400', 20:05:53 INFO - 'USER': 'cltbld', 20:05:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', 20:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:53 INFO - '_': '/tools/buildbot/bin/python'} 20:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:05:56 INFO - Installing collected packages: mozsystemmonitor 20:05:56 INFO - Running setup.py install for mozsystemmonitor 20:05:56 INFO - Successfully installed mozsystemmonitor 20:05:56 INFO - Cleaning up... 20:05:56 INFO - Return code: 0 20:05:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8bd3c91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a6f0>, '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 0x206b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206baa0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', '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 20:05:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:05:56 INFO - Using env: {'DISPLAY': ':0', 20:05:56 INFO - 'HOME': '/home/cltbld', 20:05:56 INFO - 'LANG': 'en_US.UTF-8', 20:05:56 INFO - 'LANGUAGE': 'en_US:en', 20:05:56 INFO - 'LOGNAME': 'cltbld', 20:05:56 INFO - 'MAIL': '/var/mail/cltbld', 20:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:56 INFO - 'MOZ_NO_REMOTE': '1', 20:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:56 INFO - 'NO_EM_RESTART': '1', 20:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:56 INFO - 'PWD': '/builds/slave/test', 20:05:56 INFO - 'SHELL': '/bin/bash', 20:05:56 INFO - 'SHLVL': '1', 20:05:56 INFO - 'TERM': 'linux', 20:05:56 INFO - 'TMOUT': '86400', 20:05:56 INFO - 'USER': 'cltbld', 20:05:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', 20:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:56 INFO - '_': '/tools/buildbot/bin/python'} 20:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:56 INFO - Downloading/unpacking jsonschema==2.5.1 20:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:05:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:58 INFO - Downloading functools32-3.2.3-2.tar.gz 20:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:05:58 INFO - warning: no files found matching '*.txt' 20:05:58 INFO - no previously-included directories found matching 'build' 20:05:58 INFO - no previously-included directories found matching 'dist' 20:05:58 INFO - no previously-included directories found matching '.git*' 20:05:58 INFO - Installing collected packages: jsonschema, functools32 20:05:58 INFO - Running setup.py install for functools32 20:05:58 INFO - warning: no files found matching '*.txt' 20:05:58 INFO - no previously-included directories found matching 'build' 20:05:58 INFO - no previously-included directories found matching 'dist' 20:05:58 INFO - no previously-included directories found matching '.git*' 20:05:58 INFO - Successfully installed jsonschema functools32 20:05:58 INFO - Cleaning up... 20:05:58 INFO - Return code: 0 20:05:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:05:58 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')]} 20:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:58 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')]} 20:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:58 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 0x7f8bd3c91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a6f0>, '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 0x206b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206baa0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', '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 20:05:58 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 20:05:58 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 20:05:58 INFO - Using env: {'DISPLAY': ':0', 20:05:58 INFO - 'HOME': '/home/cltbld', 20:05:58 INFO - 'LANG': 'en_US.UTF-8', 20:05:58 INFO - 'LANGUAGE': 'en_US:en', 20:05:58 INFO - 'LOGNAME': 'cltbld', 20:05:58 INFO - 'MAIL': '/var/mail/cltbld', 20:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:58 INFO - 'MOZ_NO_REMOTE': '1', 20:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:58 INFO - 'NO_EM_RESTART': '1', 20:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:58 INFO - 'PWD': '/builds/slave/test', 20:05:58 INFO - 'SHELL': '/bin/bash', 20:05:58 INFO - 'SHLVL': '1', 20:05:58 INFO - 'TERM': 'linux', 20:05:58 INFO - 'TMOUT': '86400', 20:05:58 INFO - 'USER': 'cltbld', 20:05:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', 20:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:58 INFO - '_': '/tools/buildbot/bin/python'} 20:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:58 INFO - Downloading/unpacking blobuploader==1.2.4 20:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:00 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06:01 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 20:06:01 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 20:06:01 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 20:06:01 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 20:06:01 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 20:06:01 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 20:06:01 INFO - Downloading docopt-0.6.1.tar.gz 20:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:01 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:01 INFO - Running setup.py install for blobuploader 20:06:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:01 INFO - Running setup.py install for requests 20:06:02 INFO - Running setup.py install for docopt 20:06:02 INFO - Successfully installed blobuploader requests docopt 20:06:02 INFO - Cleaning up... 20:06:02 INFO - Return code: 0 20:06:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:02 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')]} 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:02 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')]} 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:02 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 0x7f8bd3c91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a6f0>, '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 0x206b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206baa0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', '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 20:06:02 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 20:06:02 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 20:06:02 INFO - Using env: {'DISPLAY': ':0', 20:06:02 INFO - 'HOME': '/home/cltbld', 20:06:02 INFO - 'LANG': 'en_US.UTF-8', 20:06:02 INFO - 'LANGUAGE': 'en_US:en', 20:06:02 INFO - 'LOGNAME': 'cltbld', 20:06:02 INFO - 'MAIL': '/var/mail/cltbld', 20:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:02 INFO - 'MOZ_NO_REMOTE': '1', 20:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:02 INFO - 'NO_EM_RESTART': '1', 20:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:02 INFO - 'PWD': '/builds/slave/test', 20:06:02 INFO - 'SHELL': '/bin/bash', 20:06:02 INFO - 'SHLVL': '1', 20:06:02 INFO - 'TERM': 'linux', 20:06:02 INFO - 'TMOUT': '86400', 20:06:02 INFO - 'USER': 'cltbld', 20:06:02 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', 20:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:02 INFO - '_': '/tools/buildbot/bin/python'} 20:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:02 INFO - Running setup.py (path:/tmp/pip-BQRlkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:02 INFO - Running setup.py (path:/tmp/pip-CWwLlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:02 INFO - Running setup.py (path:/tmp/pip-xYlTXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:02 INFO - Running setup.py (path:/tmp/pip-uGzQWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:02 INFO - Running setup.py (path:/tmp/pip-z74TRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:02 INFO - Running setup.py (path:/tmp/pip-156yy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:02 INFO - Running setup.py (path:/tmp/pip-vViBPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:02 INFO - Running setup.py (path:/tmp/pip-xmnm1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:03 INFO - Running setup.py (path:/tmp/pip-2sLDI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:03 INFO - Running setup.py (path:/tmp/pip-aEI1AF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:03 INFO - Running setup.py (path:/tmp/pip-15EjeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:03 INFO - Running setup.py (path:/tmp/pip-udhyrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:03 INFO - Running setup.py (path:/tmp/pip-PpRC8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:03 INFO - Running setup.py (path:/tmp/pip-HoWI1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:03 INFO - Running setup.py (path:/tmp/pip-FEJxIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:03 INFO - Running setup.py (path:/tmp/pip-50ttXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:03 INFO - Running setup.py (path:/tmp/pip-222d8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:03 INFO - Running setup.py install for manifestparser 20:06:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:03 INFO - Running setup.py install for mozcrash 20:06:03 INFO - Running setup.py install for mozdebug 20:06:04 INFO - Running setup.py install for mozdevice 20:06:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:06:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:04 INFO - Running setup.py install for mozfile 20:06:04 INFO - Running setup.py install for mozhttpd 20:06:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:04 INFO - Running setup.py install for mozinfo 20:06:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:04 INFO - Running setup.py install for mozInstall 20:06:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:04 INFO - Running setup.py install for mozleak 20:06:04 INFO - Running setup.py install for mozlog 20:06:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:04 INFO - Running setup.py install for moznetwork 20:06:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:04 INFO - Running setup.py install for mozprocess 20:06:04 INFO - Running setup.py install for mozprofile 20:06:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Running setup.py install for mozrunner 20:06:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Running setup.py install for mozscreenshot 20:06:05 INFO - Running setup.py install for moztest 20:06:05 INFO - Running setup.py install for mozversion 20:06:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:05 INFO - Cleaning up... 20:06:05 INFO - Return code: 0 20:06:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:05 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 0x7f8bd3c91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a6f0>, '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 0x206b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206baa0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', '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 20:06:05 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 20:06:05 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 20:06:05 INFO - Using env: {'DISPLAY': ':0', 20:06:05 INFO - 'HOME': '/home/cltbld', 20:06:05 INFO - 'LANG': 'en_US.UTF-8', 20:06:05 INFO - 'LANGUAGE': 'en_US:en', 20:06:05 INFO - 'LOGNAME': 'cltbld', 20:06:05 INFO - 'MAIL': '/var/mail/cltbld', 20:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:05 INFO - 'MOZ_NO_REMOTE': '1', 20:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:05 INFO - 'NO_EM_RESTART': '1', 20:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:05 INFO - 'PWD': '/builds/slave/test', 20:06:05 INFO - 'SHELL': '/bin/bash', 20:06:05 INFO - 'SHLVL': '1', 20:06:05 INFO - 'TERM': 'linux', 20:06:05 INFO - 'TMOUT': '86400', 20:06:05 INFO - 'USER': 'cltbld', 20:06:05 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', 20:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:05 INFO - '_': '/tools/buildbot/bin/python'} 20:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:05 INFO - Running setup.py (path:/tmp/pip-GFwiwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:05 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)) 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:05 INFO - Running setup.py (path:/tmp/pip-z3nnoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:05 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)) 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:05 INFO - Running setup.py (path:/tmp/pip-Q4EOVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:05 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)) 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:05 INFO - Running setup.py (path:/tmp/pip-_Bweoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:06 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)) 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:06 INFO - Running setup.py (path:/tmp/pip-RQjqBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:06 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)) 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:06 INFO - Running setup.py (path:/tmp/pip-kIKmUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:06 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)) 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:06 INFO - Running setup.py (path:/tmp/pip-9yctyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:06 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)) 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:06 INFO - Running setup.py (path:/tmp/pip-EqJN11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:06 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)) 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:06 INFO - Running setup.py (path:/tmp/pip-47Aklq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:06 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)) 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:06 INFO - Running setup.py (path:/tmp/pip-_XAm3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:06 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)) 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:06 INFO - Running setup.py (path:/tmp/pip-9_RNu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:06 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)) 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:06 INFO - Running setup.py (path:/tmp/pip-e6SJqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:06 INFO - Running setup.py (path:/tmp/pip-qqYWzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:06 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)) 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:06 INFO - Running setup.py (path:/tmp/pip-mGWMGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:06 INFO - Running setup.py (path:/tmp/pip-COUHrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:06 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)) 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:06 INFO - Running setup.py (path:/tmp/pip-jbTgpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:06 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)) 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:06 INFO - Running setup.py (path:/tmp/pip-1E_yFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:06 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)) 20:06:06 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)) 20:06:06 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)) 20:06:06 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)) 20:06:06 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)) 20:06:06 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)) 20:06:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:06 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 20:06:06 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 20:06:06 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 20:06:06 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 20:06:06 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 20:06:06 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 20:06:08 INFO - Downloading blessings-1.6.tar.gz 20:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:08 INFO - Installing collected packages: blessings 20:06:08 INFO - Running setup.py install for blessings 20:06:09 INFO - Successfully installed blessings 20:06:09 INFO - Cleaning up... 20:06:09 INFO - Return code: 0 20:06:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:09 INFO - Reading from file tmpfile_stdout 20:06:09 INFO - Current package versions: 20:06:09 INFO - argparse == 1.2.1 20:06:09 INFO - blessings == 1.6 20:06:09 INFO - blobuploader == 1.2.4 20:06:09 INFO - docopt == 0.6.1 20:06:09 INFO - functools32 == 3.2.3-2 20:06:09 INFO - jsonschema == 2.5.1 20:06:09 INFO - manifestparser == 1.1 20:06:09 INFO - mozInstall == 1.12 20:06:09 INFO - mozcrash == 0.17 20:06:09 INFO - mozdebug == 0.1 20:06:09 INFO - mozdevice == 0.48 20:06:09 INFO - mozfile == 1.2 20:06:09 INFO - mozhttpd == 0.7 20:06:09 INFO - mozinfo == 0.9 20:06:09 INFO - mozleak == 0.1 20:06:09 INFO - mozlog == 3.2 20:06:09 INFO - moznetwork == 0.27 20:06:09 INFO - mozprocess == 0.22 20:06:09 INFO - mozprofile == 0.28 20:06:09 INFO - mozrunner == 6.11 20:06:09 INFO - mozscreenshot == 0.1 20:06:09 INFO - mozsystemmonitor == 0.3 20:06:09 INFO - moztest == 0.7 20:06:09 INFO - mozversion == 1.4 20:06:09 INFO - psutil == 3.1.1 20:06:09 INFO - requests == 1.2.3 20:06:09 INFO - wsgiref == 0.1.2 20:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:09 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')]} 20:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:09 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')]} 20:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:09 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 0x7f8bd3c91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a6f0>, '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 0x206b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206baa0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', '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 20:06:09 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 20:06:09 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 20:06:09 INFO - Using env: {'DISPLAY': ':0', 20:06:09 INFO - 'HOME': '/home/cltbld', 20:06:09 INFO - 'LANG': 'en_US.UTF-8', 20:06:09 INFO - 'LANGUAGE': 'en_US:en', 20:06:09 INFO - 'LOGNAME': 'cltbld', 20:06:09 INFO - 'MAIL': '/var/mail/cltbld', 20:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:09 INFO - 'MOZ_NO_REMOTE': '1', 20:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:09 INFO - 'NO_EM_RESTART': '1', 20:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:09 INFO - 'PWD': '/builds/slave/test', 20:06:09 INFO - 'SHELL': '/bin/bash', 20:06:09 INFO - 'SHLVL': '1', 20:06:09 INFO - 'TERM': 'linux', 20:06:09 INFO - 'TMOUT': '86400', 20:06:09 INFO - 'USER': 'cltbld', 20:06:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', 20:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:09 INFO - '_': '/tools/buildbot/bin/python'} 20:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:09 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)) 20:06:09 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)) 20:06:09 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)) 20:06:09 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)) 20:06:09 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)) 20:06:09 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)) 20:06:09 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)) 20:06:09 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)) 20:06:09 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)) 20:06:09 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)) 20:06:09 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)) 20:06:09 INFO - Cleaning up... 20:06:09 INFO - Return code: 0 20:06:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06:09 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')]} 20:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:09 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')]} 20:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:09 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 0x7f8bd3c91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a6f0>, '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 0x206b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206baa0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', '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 20:06:09 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 20:06:09 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 20:06:09 INFO - Using env: {'DISPLAY': ':0', 20:06:09 INFO - 'HOME': '/home/cltbld', 20:06:09 INFO - 'LANG': 'en_US.UTF-8', 20:06:09 INFO - 'LANGUAGE': 'en_US:en', 20:06:09 INFO - 'LOGNAME': 'cltbld', 20:06:09 INFO - 'MAIL': '/var/mail/cltbld', 20:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:09 INFO - 'MOZ_NO_REMOTE': '1', 20:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:09 INFO - 'NO_EM_RESTART': '1', 20:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:09 INFO - 'PWD': '/builds/slave/test', 20:06:09 INFO - 'SHELL': '/bin/bash', 20:06:09 INFO - 'SHLVL': '1', 20:06:09 INFO - 'TERM': 'linux', 20:06:09 INFO - 'TMOUT': '86400', 20:06:09 INFO - 'USER': 'cltbld', 20:06:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', 20:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:09 INFO - '_': '/tools/buildbot/bin/python'} 20:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:06:09 INFO - Cleaning up... 20:06:09 INFO - Return code: 0 20:06:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:06:09 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')]} 20:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:09 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')]} 20:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:09 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 0x7f8bd3c91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206a6f0>, '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 0x206b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206baa0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', '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 20:06:09 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 20:06:09 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 20:06:09 INFO - Using env: {'DISPLAY': ':0', 20:06:09 INFO - 'HOME': '/home/cltbld', 20:06:09 INFO - 'LANG': 'en_US.UTF-8', 20:06:09 INFO - 'LANGUAGE': 'en_US:en', 20:06:09 INFO - 'LOGNAME': 'cltbld', 20:06:09 INFO - 'MAIL': '/var/mail/cltbld', 20:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:09 INFO - 'MOZ_NO_REMOTE': '1', 20:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:09 INFO - 'NO_EM_RESTART': '1', 20:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:09 INFO - 'PWD': '/builds/slave/test', 20:06:09 INFO - 'SHELL': '/bin/bash', 20:06:09 INFO - 'SHLVL': '1', 20:06:09 INFO - 'TERM': 'linux', 20:06:09 INFO - 'TMOUT': '86400', 20:06:09 INFO - 'USER': 'cltbld', 20:06:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', 20:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:09 INFO - '_': '/tools/buildbot/bin/python'} 20:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:09 INFO - Downloading/unpacking flake8 20:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:06:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:06:11 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 20:06:11 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 20:06:11 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 20:06:11 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 20:06:11 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 20:06:11 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 20:06:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:06:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:06:12 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 20:06:12 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 20:06:12 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 20:06:12 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 20:06:12 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 20:06:12 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 20:06:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:06:12 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 20:06:12 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 20:06:12 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 20:06:12 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 20:06:12 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 20:06:12 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 20:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:06:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:12 INFO - no previously-included directories found matching 'docs/_build' 20:06:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:06:12 INFO - Running setup.py install for pep8 20:06:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:12 INFO - no previously-included directories found matching 'docs/_build' 20:06:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:06:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:06:12 INFO - Cleaning up... 20:06:12 INFO - Return code: 0 20:06:12 INFO - Running post-action listener: _resource_record_post_action 20:06:12 INFO - Running post-action listener: _start_resource_monitoring 20:06:12 INFO - Starting resource monitoring. 20:06:12 INFO - ##### 20:06:12 INFO - ##### Finished create-virtualenv step (success) 20:06:12 INFO - ##### 20:06:12 INFO - ##### 20:06:12 INFO - ##### Running install step. 20:06:12 INFO - ##### 20:06:12 INFO - Running pre-action listener: _resource_record_pre_action 20:06:12 INFO - Running main action method: install 20:06:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:13 INFO - Reading from file tmpfile_stdout 20:06:13 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:13 INFO - Reading from file tmpfile_stdout 20:06:13 INFO - Output received: 20:06:13 INFO - Usage: mozinstall [options] installer 20:06:13 INFO - Options: 20:06:13 INFO - -h, --help show this help message and exit 20:06:13 INFO - -d DEST, --destination=DEST 20:06:13 INFO - Directory to install application into. [default: 20:06:13 INFO - "/builds/slave/test"] 20:06:13 INFO - --app=APP Application being installed. [default: firefox] 20:06:13 INFO - mkdir: /builds/slave/test/build/application 20:06:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:06:30 INFO - Reading from file tmpfile_stdout 20:06:30 INFO - Output received: 20:06:30 INFO - /builds/slave/test/build/application/firefox/firefox 20:06:30 INFO - Running post-action listener: _resource_record_post_action 20:06:30 INFO - ##### 20:06:30 INFO - ##### Finished install step (success) 20:06:30 INFO - ##### 20:06:30 INFO - ##### 20:06:30 INFO - ##### Running run-tests step. 20:06:30 INFO - ##### 20:06:30 INFO - Running pre-action listener: _resource_record_pre_action 20:06:30 INFO - Running main action method: run_tests 20:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:06:30 INFO - Python 2.7.3 20:06:30 INFO - Return code: 0 20:06:30 INFO - grabbing minidump binary from tooltool 20:06: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')]} 20:06:30 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 0x206a6f0>, '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 0x206b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206baa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:06:30 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 20:06:30 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 20:06:30 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 20:06:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:06:30 INFO - Return code: 0 20:06:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:06:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:06:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:06:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:06:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:06:31 INFO - Return code: 0 20:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 20:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 20:06:31 INFO - Using env: {'DISPLAY': ':0', 20:06:31 INFO - 'HOME': '/home/cltbld', 20:06:31 INFO - 'LANG': 'en_US.UTF-8', 20:06:31 INFO - 'LANGUAGE': 'en_US:en', 20:06:31 INFO - 'LOGNAME': 'cltbld', 20:06:31 INFO - 'MAIL': '/var/mail/cltbld', 20:06:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:06:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:31 INFO - 'MOZ_NO_REMOTE': '1', 20:06:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:31 INFO - 'NO_EM_RESTART': '1', 20:06:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:31 INFO - 'PWD': '/builds/slave/test', 20:06:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:06:31 INFO - 'SHELL': '/bin/bash', 20:06:31 INFO - 'SHLVL': '1', 20:06:31 INFO - 'TERM': 'linux', 20:06:31 INFO - 'TMOUT': '86400', 20:06:31 INFO - 'USER': 'cltbld', 20:06:31 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240', 20:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:31 INFO - '_': '/tools/buildbot/bin/python'} 20:06:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 20:06:31 INFO - mozversion application_buildid: 20160626173008 20:06:31 INFO - mozversion application_changeset: 110c7ad7d399d16b9c77940f766a26df5d90f881 20:06:31 INFO - mozversion application_display_name: Nightly 20:06:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:06:31 INFO - mozversion application_name: Firefox 20:06:31 INFO - mozversion application_remotingname: firefox 20:06:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:06:31 INFO - mozversion application_vendor: Mozilla 20:06:31 INFO - mozversion application_version: 50.0a1 20:06:31 INFO - mozversion platform_buildid: 20160626173008 20:06:31 INFO - mozversion platform_changeset: 110c7ad7d399d16b9c77940f766a26df5d90f881 20:06:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:06:31 INFO - mozversion platform_version: 50.0a1 20:06:31 INFO - using testdate: 1466996791 20:06:31 INFO - actual date: 1466996791 20:06:31 INFO - starting webserver on 'localhost:56971' 20:06:31 INFO - SUITE-START | Running 2 tests 20:06:31 INFO - TEST-START | dromaeo_css 20:06:31 INFO - operating with platform_type : linux_ 20:06:31 INFO - Initialising browser for dromaeo_css test... 20:06:31 INFO - TEST-INFO | started process 31508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPjcneX/profile http://localhost:56971/getInfo.html) 20:06:36 INFO - PROCESS | 31508 | __metrics Screen width/height:1600/1200 20:06:36 INFO - PROCESS | 31508 | colorDepth:24 20:06:36 INFO - PROCESS | 31508 | Browser inner width/height: 1024/697 20:06:36 INFO - PROCESS | 31508 | __metrics 20:06:36 ERROR - PROCESS | 31508 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 20:06:37 INFO - TEST-INFO | 31508: exit 0 20:06:37 INFO - Browser initialized. 20:06:37 INFO - Running cycle 1/1 for dromaeo_css test... 20:06:37 INFO - TEST-INFO | started process 31626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPjcneX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:49 INFO - PROCESS | 31626 | RSS: Main: 185131008 20:06:49 INFO - PROCESS | 31626 | 20:07:39 INFO - PROCESS | 31626 | 1466996859235 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] 20:09:47 INFO - PROCESS | 31626 | Cycle 1(1): loaded http://localhost:56971/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56971/tests/dromaeo/cssquery-ext.html) 20:09:48 INFO - PROCESS | 31626 | RSS: Main: 189014016 20:09:48 INFO - PROCESS | 31626 | 20:12:50 INFO - PROCESS | 31626 | Cycle 1(1): loaded http://localhost:56971/tests/dromaeo/cssquery-ext.html (next: http://localhost:56971/tests/dromaeo/cssquery-jquery.html) 20:12:50 INFO - PROCESS | 31626 | RSS: Main: 187498496 20:12:50 INFO - PROCESS | 31626 | 20:15:52 INFO - PROCESS | 31626 | Cycle 1(1): loaded http://localhost:56971/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56971/tests/dromaeo/cssquery-mootools.html) 20:15:53 INFO - PROCESS | 31626 | RSS: Main: 189636608 20:15:53 INFO - PROCESS | 31626 | 20:18:55 INFO - PROCESS | 31626 | Cycle 1(1): loaded http://localhost:56971/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56971/tests/dromaeo/cssquery-prototype.html) 20:18:55 INFO - PROCESS | 31626 | RSS: Main: 186511360 20:18:55 INFO - PROCESS | 31626 | 20:21:58 INFO - PROCESS | 31626 | Cycle 1(1): loaded http://localhost:56971/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56971/tests/dromaeo/cssquery-yui.html) 20:21:58 INFO - PROCESS | 31626 | RSS: Main: 188362752 20:21:58 INFO - PROCESS | 31626 | 20:25:01 INFO - PROCESS | 31626 | Cycle 1(1): loaded http://localhost:56971/tests/dromaeo/cssquery-yui.html (next: http://localhost:56971/tests/dromaeo/cssquery-dojo.html) 20:25:01 INFO - PROCESS | 31626 | RSS: Main: 189595648 20:25:01 INFO - PROCESS | 31626 | 20:25:01 INFO - PROCESS | 31626 | __start_tp_report 20:25:01 INFO - PROCESS | 31626 | _x_x_mozilla_page_load 20:25:01 INFO - PROCESS | 31626 | _x_x_mozilla_page_load_details 20:25:01 INFO - PROCESS | 31626 | |i|pagename|runs| 20:25:01 INFO - PROCESS | 31626 | |0;dojo.html;3099.891503797367;3100.7829451938373;3121.079281611924;3136.85884135214;3139.827309497977;5424.701641409721;5426.538744206742;5492.47821456962;5504.559635229182;5603.915941260884;5337.5196232339085;5427.240186373911;5443.863903402407;5484.095124304495;5537.1140617501105;4907.975460122712;4927.236278376858;5023.572996295319;5078.39059312883;5134.127198376285;672.3273015647405;4887.511248875102;4896.045271172123;4983.103041452537;5032.6477146599755;4941.777620007108;4947.975260123694;4986.3767029121545;4992.45083040867;4996.300517927493;4991.825286115005;4996.1756310208775;5004.749762511896;5008.724520151391;5040.42035165957;4859.902801943977;4904.877378065541;4918.803247870081;4927.95072049282;4944.60443164546;5331.226972089025;5403.78384864605;5445.319335083114;5454.809081682122;5481.725913704338;5689.487946084831;5743.5118014968775;5828.795992140297;5830.096335068029;5834.008218602848;5833.037548804442;5894.58737888348;5923.674197919113;5966.403359663999;5966.522678185735;5480.588955828329;5522.502974732253;5535.889282214373;5535.972320138414;5537.501624853782;5832.88334233313;5937.643741375531;5953.910691339634;5966.254218222723;5971.134185543072;5759.913601295984;5765.221695071195;5770.221020162308;5798.449147330997;5831.067029275296;5851.122331650201;5852.795152169653;5854.970725146347;5855.092460668603;5857.15071314657;5709.885802284014;5775.682337471395;5812.912806307909;5824.5631577631;5867.823965281048;5807.5063619591965;5883.441073098049;5889.911651325234;5907.350191478934;5921.822345329647;4423.712458690175;4426.822927082881;4463.129689710475;4467.352233926127;4501.864944051684;3893.9610603894166;3909.58949310324;3929.9214015719526;3960.3069462843887;3991;5581.469760372758;5612.494875461147;5613.635113717595;5645.717714114277;5662.801801936995;5958.433948774946;5976.073708575178;5979.1629171915965;5980.192673989043;5986.07215881539;5478.424765399575;5529.502344788908;5579.860503487445;5581.6930068845795;5620.718964051781;5004.3494345734825;5021.59827213822;5049.772760225798;5051.621128415383;5084.898302034013;5808.912866307009;6069.484093852072;6079.665618391031;6081.57428979976;6098.176746139215;5891.3224979127945;5946.286445626552;5955.791547295824;6007.189029480965;6013.789517366871;6139.723712432862;6143.139960405636;6153.876922461436;6157.96921015392;6159.476444502267;5683.857903552444;5702.971485142548;5830.5627077968475;5839.766409343749;5847.830433913149;5831.970840145772;5897.056470964625;5902.203202567598;5902.940970590239;5962.4633782959745;5723.399043100581;5754;5768;5771.163181338767;5784.392638773036;5645.915311270416;5661.377248502744;5707.315122185364;5741.052726300114;5743.10981797822;5587.441255874543;5621.269234999424;5640.266765320482;5647.519960803378;5685.857853553694;5710.8001219957105;5724.914126288026;5751.223584816164;5766;5770.682612456355;5532.197831314517;5621.55027597783;5644.181593668813;5653.067243904709;5701.372848986691 20:25:01 INFO - PROCESS | 31626 | |1;ext.html;563.2593140020872;619.4486906653079;636.6466611030877;638.7764282501125;646.069659690046;38806.223875522504;42587;43173.78413107934;43201.78399108004;43269;43284.350734739004;43979;44154.337684934755;44221.115577688426;44293.55706442943;8950.104989501064;9083.863742043875;9111.362204645677;9123.817523649523;9127.26981841451;8944.284457243404;9010.954945225265;9018.323625728064;9029.503377314246;9057.682981095662;8993.370464067519;9010.459372437643;9035;9091.409058411215;9108.817823643556;9059.456432614064;9063.365564410495;9110.498922559256;9111;9117.544122793834;8879.778005549848;8948.194662480408;8956.059613740594;8973.955130224307;8978.326625503114;40900.38649420261;40918;41285.380719289235;41408.1718365631;41520.169596608204;3067.8466076696077;3451.3442445935443;3492.930141397158;3616.8191590420374;3641.7086633069557;30691.232719181975;30873.691263087305;31169.84415077933;33065;34109;4431.2466880630045;4437.2013037653205;4440.511543730187;4484.282514797649;4541.84103556374;361078;361999;362346;362875;363351.9999999974;61892;62310.37689623136;62761.68619156875;62820.371796282365;62856.37143628505;31118;31224.063278101694;31425.05724828259;33028.50457243143;63546.6822665893;17447.82552174462;17492;17531.474055778348;17545;17582.824171758373;13401.597952061455;13415.530456434173;13447.394867230998;13474.191548506926;13474.393652285671;18834.246630134916;19031.809681903003;19111.90444047771;19142.71285930712;19160.90419547893;7030.191527974246;7293.489455738153;7323.963380183065;7388.630568471555;7391.482596218213;994.7761753605525;1005.406809982114;1008.4100801031332;1035.0839507036328;1101.1631160318216;32155.839220803748;32682.67317326844;32743.67256327454;32898;32927;1119.462657924201;1146.3179408252076;1181.4447209811374;1204.801207800703;1207.9939600301943;16874.15629218534;16921.7461738074;16966.15169241533;17255.74116388255;17470.912645436692;622602;664147;676046;679141.4171716538;1024546;59582.70208648929;59868;60003.69998149981;60551.394486055455;60766.392336076955;1339.912905661129;1392.5752645443035;1393.5053056165118;1401.4884567132924;1414.4978532620978;31774;32837.50743738894;32891.34217315688;33151.502727458625;33317.83341083279;50989;51713;51720.48279517307;51792.741036294574;51856;522331;523971;532161;532514;534386;28541;28552.286192845346;28608.713912860603;28632.284192895346;28734;47478;47512.7624361876;48327.275090872965;48463.51536484731;48930.266046008626;40461.1907761849;40583.1883362337;40600.79699601483;41152.58847411488;41641.58358416377;39224.411633824944;39947;40937.79531102445;41118.383224252255;41388.1722365557;36355.818220908724;39912.80043599763;40285.798571006955;40319.79840100781;41249.79375103105;32154.35691286208;36211;39610.207795843344;39619.80190099031;39642.80178599204;28541.429171416872;29231.269218269714;29626.703732962393;29629.703702963558;29842.552361715025 20:25:01 INFO - PROCESS | 31626 | |2;jquery.html;379.65830752322904;380.7876239051112;386.6249737754378;396.27877263380657;403.0709215258831;18030.819691803095;19629.60740785187;19742.703859442085;19824.909629970345;19980.60038799227;18741.34405295815;18861.90569047153;19080.522986925334;19153.71269430956;19548.804511954913;5534.114541673343;5655.236543066695;5690;5762.193292938992;5770.9422905770825;5486.890262194754;5643.153526970967;5658.688772117532;5664.518515926151;5694.914576281359;5599.188117722928;5600.439956004408;5647.09646456567;5654.575906806986;5659.51894089003;5687.687177205273;5702.716888700009;5711.114777209539;5724.427557244284;5738.110592858114;5059.468755780626;5083.822066227701;5100.591952643779;5104.566111880495;5106.591472682214;22501.9874105664;22654.66018009731;22778.772212277832;22926.88536557323;23179.652305215433;2383.511380167062;2453.570625140593;2459.7417271186446;2561.2316305108393;2699.4736026474843;9851.408915465096;9903.207743380512;12296.569620063256;13054.804177937338;14659;1924.6728056230475;1941.2235105957589;1983.9206431742714;2070.223666125203;2096.9475763106043;75163;79461.60269198618;81857;81941.18058819395;83605.58197209035;10022.098011178883;10104.797904041878;10615.31000484966;10670.62652807148;10845.349279043125;13761.587152385444;13781;13801.102928309829;13871.167729936236;13964;7810.101838288556;8084.474509156886;8103.513789172551;8245.628946697412;8287.917120828715;8076.192380761877;8163.836723265502;8304.418690691715;8313.251807337369;8369.623366948503;4192.287311157111;4239.40648309237;4251.617354438115;4276.3799249109325;4284.91430171401;1779.1904683369037;1827.1869018287;1840.4110684580805;1848.7689038870142;1852.3609354772852;947.265868951568;963.9132478077007;988.8318985772436;1066.6053560182781;1115.4032592563103;18819.247230110916;19011.524711882314;19290.903545482182;19833.809971401763;19836.404907852786;987.5161171026289;989.2580564576567;996.2080146283722;1002.318423472046;1006.7885743993843;10587.629432969808;10855.837162442569;10866.782664346827;10875.374965912315;10884.442026345063;451093;458150;458782;466103;468511;73803.63098184475;93062.06937930534;95587.52206238924;95703.12890613293;96874.0312596865;992.7815880506278;1007.0684616729496;1016.9898301017043;1020.994895025535;1026.3892983674552;17092.57268568246;17211.006623437257;17283.481495555152;17623.647527049132;17799.73300400521;29557.556636650897;29813;40668.59331406648;40707;41165;56327.15509267446;56365.718171410525;57193.714031429576;57223;57906.420935790105;8301;8345.290650294794;8479.830403391774;8506.617202226038;8529.74410767678;12681.112322137362;13085.149465284727;13385.598432047054;13483.056186067273;13646.590602281947;11711.88288117108;11826.231294965799;11859;11885.989690876026;12143.817842732542;11707.063434925016;11804.114691398008;11955.581554645545;11995.340256285988;12062.577809776616;11634.76730465403;11935.641930742091;12176.147669663038;12325.260484370967;12415.130940834055;7110.680019399036;8469.491830489944;8636.26591739684;8682.175193356621;8716.259117975043;11160.497777599865;11176;11704.36138940566;11904.464299106388;12242.265464072185 20:25:01 INFO - PROCESS | 31626 | |3;mootools.html;1479.2751551739648;1493.1712899340864;1624.821269660337;1722.3369002933875;1752.3078384038297;8010.839783204332;8861.46831190129;8872.112788721133;9478;9496.145346918776;8909.465432074065;9145;9176.954115229415;9177.541122943843;9181.2654987601;2183.5087105401276;2228.4874478869788;2236.3067449090754;2238.183063181935;2239.1826983151195;2212.1814928476488;2243.091547923094;2267.6598510223516;2299.4711216420233;2300.620397634388;2259.2318611672026;2259.3560835161984;2278.3506700590333;2278.737945136314;2317.4322291038634;2173.8913054347217;2191.3973657244305;2192.342297310808;2213.712217411742;2225.8441909066373;2223.444138965259;2238.507528343778;2241.730992280937;2243.596152692515;2246.786555277246;9131.2238459731;9159;9186;9256;9259.166674999282;5349.144136938071;5472.562195024429;5483.259759932398;5484.040292948758;5485.588580856412;3381.340638575479;3422.144463884029;3536.3811333016874;3569.8929032129076;3584.1577229351083;1052.947352632373;1074.3661239868516;1079.0396547073112;1079.6599071292517;1087.8259478483483;12853.935730321382;12855.421506032251;12882.677933051655;12893.226406415644;12903.16129451592;4745.881352966204;4786.760661966888;4799.784009719571;4817.012512434942;4910.508949105132;10585.04734573892;10622;10626.096781773482;10641.946790266;10657.147428205724;5433.429489903582;5437.510624043855;5464.644798088191;5475.041867673221;5479;4505.977470112694;4923.433805112458;4940.530649588283;5069.290299358093;5104.923426148611;3967.7024223183375;3987.8803635890968;4018.5378681452007;4038.1519880825354;4087.346024636044;1258.6098309524077;1263.5514392390753;1266.3731452930858;1270.707737220426;1278.2905487454552;809.2756982500629;901.3870568013814;922.5341202692597;948.3361646847235;964.6189755046857;5905.141237899948;6020.909686354708;6090.756369745161;6130.2030736004035;6230.314665386803;916.6150216908915;974.3763991045737;994.0655783563427;1016.8525563793208;1064.0742553977934;3947.881563553098;4023.597640235953;4035.7982100894837;4042.8989275268355;4058.330375488011;10824.458777061272;11436.942815286036;11474.713132171762;11553.942230288794;11607.187496875307;11194.552217911192;11195.2723073;11206.83189752138;11239.438028098562;11282.94358528202;8509.446885952393;8535.999999999876;8564.61459234336;8655.826883462421;8715.694950676696;5637;5764.827055188351;5857.359939217026;5908.202392676933;6025.849353766191;10053.095221430107;10210.540525676213;10236.795264094826;10321.948390258001;10350.689479315633;10498.527566259383;10522;10527.631532896312;10740.516676749721;11146.108311334912;7716.305532502101;7943.126256111707;7996.080450748006;8006.07930088024;8049.476784009021;8691.869621955802;8695.826083478421;8697.130286971505;8702.782430439289;8768.60541275657;7714.575698336421;7791.961040194763;7792.688292468238;7825.960870195612;7939.701000823482;7703.653335599799;7748.845023099394;7847.254510821463;7946.483478573874;8010.198980102176;7297.744578939712;7308.8903666443985;7437.8140546486775;7479.252074792477;7523.210062943313;4973.104841128632;5027.673201241908;5039.798408063636;5075.543201111917;5101;5150.665206761549;5204.193350030751;5212.296339994053;5246.921296180637;5280.656757310762 20:25:01 INFO - PROCESS | 31626 | |4;prototype.html;307.5939759517438;317.2417921168407;322.5258869461891;324.8083630657911;324.91964218971924;5367.812126575571;5463.863403414916;5478.890627108562;5485.149801780721;5617.691026993509;5484.643498172616;5548.500634942854;5566.638168519044;5596.552275817935;5600.375890991618;4318.287482565389;4319.308910574308;4339.088791353819;4343.891402714941;4357.869263922072;4258.467691538558;4289.313709806432;4320.848770293041;4340.218760623086;4354.303311470166;4256.276433006381;4289.914201715964;4290.334998075287;4290.54949230331;4307.901485121305;4292.120115376356;4296.162248361571;4304.160688665712;4332.526940840098;4335.393044973706;3705.5182826232685;3733.51464309638;3817.3701339278987;3833.865814696472;3836.8081595920094;5288.576913846921;5387.730613469311;5396.352437707461;5406.972965135188;5421.349438067417;4804.25534042224;4818.807247710122;4843.75781210938;4852.053849499313;4880.414350277953;5497.890042199134;5827.708614569297;5868.911966320508;5897.7935772247765;5903.645781253095;4034.152827906143;4054.2499637567144;4056.71602987791;4060;4064.6138616831354;6017.232073246312;6037.245344331958;6054.636721796663;6069.878602427971;6088.295277322357;4049.0484736086996;4065.3698676705158;4105.794710264475;4108.137291168829;4132.607402296777;4156.91686166281;4165.167326376385;4172.228137794517;4202.516710578261;4202.642775364128;4852.951470485321;4861.173600487926;4876.463589005207;4878.82924097662;4891.437484689235;5489.313835770528;5822.7088645567555;5831.446012628793;5848.8537786554825;5870.412958704095;1429.2782145016909;1432.7349440353569;1436.8491308412674;1440.9495667651581;1451.8620731030535;896.2292428511475;900.8063266397756;921.3642586615214;927.4018258223408;933.3886304470583;5004.974975125101;5023.824166154167;5071.2139618359215;5084.542391184811;5097.7706003229205;5276.126974923924;5305.4164041955355;5307.548858347083;5312.946870531323;5343.732813359316;4976.825811096666;5000.849974500771;5028.572571331405;5291.100512912814;5775.942240577624;3213.6464988851208;3214.3249917517114;3216.6140063192565;3228.580284562992;3233.9676603233665;6028.889888538976;6179.196704428396;6229.937700622936;6232.501399888089;6233.812985610439;6109.358517355614;6109.969450152721;6112.572119951649;6133.846653833601;6170.382961703884;5994.272605964363;6128.3759803652065;6195.845103872349;6213.161223234805;6240.31356550779;5726.169705392778;5920.73356698941;5938.168656388023;5950.494207992196;5991.520678345809;5845.941540584539;5885.205497257986;5890.319904443553;5941.58408911372;6010.3088144863905;5947.197128387612;6154.846128846814;6170.734999325217;6205.162303089025;6232.906506402498;4121.289664789079;4132.442120313719;4136.958630413657;4140.254754144163;4155.127423241153;5808.6805225711305;5837.912431313619;5957.49361304294;5987.75459202799;5995;5816.662167701368;5834.15404766315;5837.883242335214;5846.152307915243;5851.61964472308;5765.913511297418;5829.417058294137;5840.328362238397;5850.5904586678525;5916.3492015877355;5499.865076906285;5742.7702891883855;5746.626469279484;5748.310202775694;5748.597598168088;5828.883422331445;5831.79588714393;5858.47273745365;5869.207656966255;5885.440883116097;5428.56571474289;5657.8019769307875;5668.489835914787;5699.062318811624;5730.684812335361 20:25:01 INFO - PROCESS | 31626 | |5;yui.html;770.6763159473022;770.8643129609643;811.1969150540964;823.2097186700771;834.8163404051114;14190;15464.922675386635;15489.535313940572;15508.302126404311;15547.533573992785;14971.401143954228;15011.549653510385;15109.84890151098;15120.924395378035;15176.241187940586;653.3074940563007;785.2069409895989;800.0519384529322;822.1778221778221;843.161054750521;814.8655471847138;820.5568992743941;821.3306155483292;825.5995842016617;827.871679889615;862.4523427623442;864.6238886084574;869.4696235296464;873.5108339329964;876.0582373948031;866.6403442571325;866.921977022071;867.4101610904582;867.4621734524603;867.483847110968;622.6793201501231;627.2817623820746;630.9274433440168;631.5074242091176;634.6890023888308;13295;13298.468061277537;13378.46486140563;13395.665108372368;13513.932430337883;14900;14906.329215185342;15005;15067.246637668073;15087.547373578811;12314.75370492594;12754.80867786984;12790.360481975957;12901.548445804352;13017.544385946541;3852.5954774748807;4498.707584007029;4521.570450807168;4563.06457176278;4789.137955168103;78161.60919195424;78688.60655696684;79131;79290.60354698189;79456.60271698663;10956.945215274032;11120.61077862271;11491.310521368745;11635.418229088511;11709;20449.18203271882;20683.79316206819;20693.379198624065;20754.273600424214;20906.268280610104;8397.6221070052;8601.411145658913;8633.611487483078;8645.3948223625;8796.692115775917;4800.207965685692;4851.902961940741;5012.874678133003;5182.144946083854;5200.479952004769;3679.632036796299;3802.315583194996;3829.6170382962036;3829.6170382962036;3841.5006049213425;632.9208848893888;638.52748965765;640.9391107844747;646.360103497534;648.5946283572767;601.4466690644617;634.4131678197649;670.5138774388529;688.9621070841151;762.0778857582387;8985.865212021825;9660.275479339078;10123.44321062334;10505.212109091695;10657.893421065844;705.6507029020565;738.5421038955882;742.5433358484601;746.488655271141;757.2351924556128;4597.770111494478;4618.261078227535;4796.736179510091;4841.3222148899185;4966.15575352191;104609;117150;117479.41260293814;119563;120406.39796801136;60159;90743.54628226817;98532.50733746286;98765;99364.5031774851;89046;90538.69944409706;90975;94397;94603.0539694608;9098.636054558008;9243.306751993761;9298.395604285699;9327.533623318672;9368.67209647659;51708.48291517037;52000.21999669932;52853.471465284856;53318;54664;69663;70233.29766702268;79815.60092199733;80630.19369806227;80774.59612701899;11981.880181198076;12112.21270617407;12312.569060083213;12553.686157846127;12713.11008229452;14493.492727754478;14820.18488983073;15034.699306014038;15354.30905609228;16295.18524073768;13765.449382024606;14383.640408989859;14483.782743259071;14539.709205816036;14616.342264597906;14134.363953622318;14421.351039203471;14682;15290.082595044332;15499.30253138634;13414.932925335312;14247.931405144449;15174.31715572824;15257.694846103237;15274.770878437055;11613.187076904536;11675.474603642686;11768.52925882955;12143.14997950135;12598;12273.570425035081;12331.50673973031;12366.19619724715;12380.938095309466;12614.747705045664 20:25:01 INFO - PROCESS | 31626 | __end_tp_report 20:25:01 INFO - PROCESS | 31626 | __start_cc_report 20:25:01 INFO - PROCESS | 31626 | _x_x_mozilla_cycle_collect,361 20:25:01 INFO - PROCESS | 31626 | __end_cc_report 20:25:01 INFO - PROCESS | 31626 | __startTimestamp1466997901849__endTimestamp 20:25:01 INFO - PROCESS | 31626 | 20:25:01 INFO - PROCESS | 31626 | ------- Summary: start ------- 20:25:01 INFO - PROCESS | 31626 | Number of tests: 6 20:25:01 INFO - PROCESS | 31626 | 20:25:01 INFO - PROCESS | 31626 | [#0] dojo.html Cycles:165 Average:5419.50 Median:5661.38 stddev:735.97 (13.0%) stddev-sans-first:715.38 20:25:01 INFO - PROCESS | 31626 | Values: 3099.9 3100.8 3121.1 3136.9 3139.8 5424.7 5426.5 5492.5 5504.6 5603.9 5337.5 5427.2 5443.9 5484.1 5537.1 4908.0 4927.2 5023.6 5078.4 5134.1 672.3 4887.5 4896.0 4983.1 5032.6 4941.8 4948.0 4986.4 4992.5 4996.3 4991.8 4996.2 5004.7 5008.7 5040.4 4859.9 4904.9 4918.8 4928.0 4944.6 5331.2 5403.8 5445.3 5454.8 5481.7 5689.5 5743.5 5828.8 5830.1 5834.0 5833.0 5894.6 5923.7 5966.4 5966.5 5480.6 5522.5 5535.9 5536.0 5537.5 5832.9 5937.6 5953.9 5966.3 5971.1 5759.9 5765.2 5770.2 5798.4 5831.1 5851.1 5852.8 5855.0 5855.1 5857.2 5709.9 5775.7 5812.9 5824.6 5867.8 5807.5 5883.4 5889.9 5907.4 5921.8 4423.7 4426.8 4463.1 4467.4 4501.9 3894.0 3909.6 3929.9 3960.3 3991.0 5581.5 5612.5 5613.6 5645.7 5662.8 5958.4 5976.1 5979.2 5980.2 5986.1 5478.4 5529.5 5579.9 5581.7 5620.7 5004.3 5021.6 5049.8 5051.6 5084.9 5808.9 6069.5 6079.7 6081.6 6098.2 5891.3 5946.3 5955.8 6007.2 6013.8 6139.7 6143.1 6153.9 6158.0 6159.5 5683.9 5703.0 5830.6 5839.8 5847.8 5832.0 5897.1 5902.2 5902.9 5962.5 5723.4 5754.0 5768.0 5771.2 5784.4 5645.9 5661.4 5707.3 5741.1 5743.1 5587.4 5621.3 5640.3 5647.5 5685.9 5710.8 5724.9 5751.2 5766.0 5770.7 5532.2 5621.6 5644.2 5653.1 5701.4 20:25:01 INFO - PROCESS | 31626 | 20:25:01 INFO - PROCESS | 31626 | [#1] ext.html Cycles:180 Average:68284.68 Median:40927.90 stddev:152725.12 (373.2%) stddev-sans-first:153068.92 20:25:01 INFO - PROCESS | 31626 | Values: 563.3 619.4 636.6 638.8 646.1 38806.2 42587.0 43173.8 43201.8 43269.0 43284.4 43979.0 44154.3 44221.1 44293.6 8950.1 9083.9 9111.4 9123.8 9127.3 8944.3 9011.0 9018.3 9029.5 9057.7 8993.4 9010.5 9035.0 9091.4 9108.8 9059.5 9063.4 9110.5 9111.0 9117.5 8879.8 8948.2 8956.1 8974.0 8978.3 40900.4 40918.0 41285.4 41408.2 41520.2 3067.8 3451.3 3492.9 3616.8 3641.7 30691.2 30873.7 31169.8 33065.0 34109.0 4431.2 4437.2 4440.5 4484.3 4541.8 361078.0 361999.0 362346.0 362875.0 363352.0 61892.0 62310.4 62761.7 62820.4 62856.4 31118.0 31224.1 31425.1 33028.5 63546.7 17447.8 17492.0 17531.5 17545.0 17582.8 13401.6 13415.5 13447.4 13474.2 13474.4 18834.2 19031.8 19111.9 19142.7 19160.9 7030.2 7293.5 7324.0 7388.6 7391.5 994.8 1005.4 1008.4 1035.1 1101.2 32155.8 32682.7 32743.7 32898.0 32927.0 1119.5 1146.3 1181.4 1204.8 1208.0 16874.2 16921.7 16966.2 17255.7 17470.9 622602.0 664147.0 676046.0 679141.4 1024546.0 59582.7 59868.0 60003.7 60551.4 60766.4 1339.9 1392.6 1393.5 1401.5 1414.5 31774.0 32837.5 32891.3 33151.5 33317.8 50989.0 51713.0 51720.5 51792.7 51856.0 522331.0 523971.0 532161.0 532514.0 534386.0 28541.0 28552.3 28608.7 28632.3 28734.0 47478.0 47512.8 48327.3 48463.5 48930.3 40461.2 40583.2 40600.8 41152.6 41641.6 39224.4 39947.0 40937.8 41118.4 41388.2 36355.8 39912.8 40285.8 40319.8 41249.8 32154.4 36211.0 39610.2 39619.8 39642.8 28541.4 29231.3 29626.7 29629.7 29842.6 20:25:01 INFO - PROCESS | 31626 | 20:25:01 INFO - PROCESS | 31626 | [#2] jquery.html Cycles:180 Average:27947.57 Median:16128.52 stddev:76067.80 (471.6%) stddev-sans-first:76253.03 20:25:01 INFO - PROCESS | 31626 | Values: 379.7 380.8 386.6 396.3 403.1 18030.8 19629.6 19742.7 19824.9 19980.6 18741.3 18861.9 19080.5 19153.7 19548.8 5534.1 5655.2 5690.0 5762.2 5770.9 5486.9 5643.2 5658.7 5664.5 5694.9 5599.2 5600.4 5647.1 5654.6 5659.5 5687.7 5702.7 5711.1 5724.4 5738.1 5059.5 5083.8 5100.6 5104.6 5106.6 22502.0 22654.7 22778.8 22926.9 23179.7 2383.5 2453.6 2459.7 2561.2 2699.5 9851.4 9903.2 12296.6 13054.8 14659.0 1924.7 1941.2 1983.9 2070.2 2096.9 75163.0 79461.6 81857.0 81941.2 83605.6 10022.1 10104.8 10615.3 10670.6 10845.3 13761.6 13781.0 13801.1 13871.2 13964.0 7810.1 8084.5 8103.5 8245.6 8287.9 8076.2 8163.8 8304.4 8313.3 8369.6 4192.3 4239.4 4251.6 4276.4 4284.9 1779.2 1827.2 1840.4 1848.8 1852.4 947.3 963.9 988.8 1066.6 1115.4 18819.2 19011.5 19290.9 19833.8 19836.4 987.5 989.3 996.2 1002.3 1006.8 10587.6 10855.8 10866.8 10875.4 10884.4 451093.0 458150.0 458782.0 466103.0 468511.0 73803.6 93062.1 95587.5 95703.1 96874.0 992.8 1007.1 1017.0 1021.0 1026.4 17092.6 17211.0 17283.5 17623.6 17799.7 29557.6 29813.0 40668.6 40707.0 41165.0 56327.2 56365.7 57193.7 57223.0 57906.4 8301.0 8345.3 8479.8 8506.6 8529.7 12681.1 13085.1 13385.6 13483.1 13646.6 11711.9 11826.2 11859.0 11886.0 12143.8 11707.1 11804.1 11955.6 11995.3 12062.6 11634.8 11935.6 12176.1 12325.3 12415.1 7110.7 8469.5 8636.3 8682.2 8716.3 11160.5 11176.0 11704.4 11904.5 12242.3 20:25:01 INFO - PROCESS | 31626 | 20:25:01 INFO - PROCESS | 31626 | [#3] mootools.html Cycles:180 Average:5945.24 Median:4808.40 stddev:3453.14 (71.8%) stddev-sans-first:3446.52 20:25:01 INFO - PROCESS | 31626 | Values: 1479.3 1493.2 1624.8 1722.3 1752.3 8010.8 8861.5 8872.1 9478.0 9496.1 8909.5 9145.0 9177.0 9177.5 9181.3 2183.5 2228.5 2236.3 2238.2 2239.2 2212.2 2243.1 2267.7 2299.5 2300.6 2259.2 2259.4 2278.4 2278.7 2317.4 2173.9 2191.4 2192.3 2213.7 2225.8 2223.4 2238.5 2241.7 2243.6 2246.8 9131.2 9159.0 9186.0 9256.0 9259.2 5349.1 5472.6 5483.3 5484.0 5485.6 3381.3 3422.1 3536.4 3569.9 3584.2 1052.9 1074.4 1079.0 1079.7 1087.8 12853.9 12855.4 12882.7 12893.2 12903.2 4745.9 4786.8 4799.8 4817.0 4910.5 10585.0 10622.0 10626.1 10641.9 10657.1 5433.4 5437.5 5464.6 5475.0 5479.0 4506.0 4923.4 4940.5 5069.3 5104.9 3967.7 3987.9 4018.5 4038.2 4087.3 1258.6 1263.6 1266.4 1270.7 1278.3 809.3 901.4 922.5 948.3 964.6 5905.1 6020.9 6090.8 6130.2 6230.3 916.6 974.4 994.1 1016.9 1064.1 3947.9 4023.6 4035.8 4042.9 4058.3 10824.5 11436.9 11474.7 11553.9 11607.2 11194.6 11195.3 11206.8 11239.4 11282.9 8509.4 8536.0 8564.6 8655.8 8715.7 5637.0 5764.8 5857.4 5908.2 6025.8 10053.1 10210.5 10236.8 10321.9 10350.7 10498.5 10522.0 10527.6 10740.5 11146.1 7716.3 7943.1 7996.1 8006.1 8049.5 8691.9 8695.8 8697.1 8702.8 8768.6 7714.6 7792.0 7792.7 7826.0 7939.7 7703.7 7748.8 7847.3 7946.5 8010.2 7297.7 7308.9 7437.8 7479.3 7523.2 4973.1 5027.7 5039.8 5075.5 5101.0 5150.7 5204.2 5212.3 5246.9 5280.7 20:25:01 INFO - PROCESS | 31626 | 20:25:01 INFO - PROCESS | 31626 | [#4] prototype.html Cycles:180 Average:4831.66 Median:5446.21 stddev:1439.65 (26.4%) stddev-sans-first:1403.07 20:25:01 INFO - PROCESS | 31626 | Values: 307.6 317.2 322.5 324.8 324.9 5367.8 5463.9 5478.9 5485.1 5617.7 5484.6 5548.5 5566.6 5596.6 5600.4 4318.3 4319.3 4339.1 4343.9 4357.9 4258.5 4289.3 4320.8 4340.2 4354.3 4256.3 4289.9 4290.3 4290.5 4307.9 4292.1 4296.2 4304.2 4332.5 4335.4 3705.5 3733.5 3817.4 3833.9 3836.8 5288.6 5387.7 5396.4 5407.0 5421.3 4804.3 4818.8 4843.8 4852.1 4880.4 5497.9 5827.7 5868.9 5897.8 5903.6 4034.2 4054.2 4056.7 4060.0 4064.6 6017.2 6037.2 6054.6 6069.9 6088.3 4049.0 4065.4 4105.8 4108.1 4132.6 4156.9 4165.2 4172.2 4202.5 4202.6 4853.0 4861.2 4876.5 4878.8 4891.4 5489.3 5822.7 5831.4 5848.9 5870.4 1429.3 1432.7 1436.8 1440.9 1451.9 896.2 900.8 921.4 927.4 933.4 5005.0 5023.8 5071.2 5084.5 5097.8 5276.1 5305.4 5307.5 5312.9 5343.7 4976.8 5000.8 5028.6 5291.1 5775.9 3213.6 3214.3 3216.6 3228.6 3234.0 6028.9 6179.2 6229.9 6232.5 6233.8 6109.4 6110.0 6112.6 6133.8 6170.4 5994.3 6128.4 6195.8 6213.2 6240.3 5726.2 5920.7 5938.2 5950.5 5991.5 5845.9 5885.2 5890.3 5941.6 6010.3 5947.2 6154.8 6170.7 6205.2 6232.9 4121.3 4132.4 4137.0 4140.3 4155.1 5808.7 5837.9 5957.5 5987.8 5995.0 5816.7 5834.2 5837.9 5846.2 5851.6 5765.9 5829.4 5840.3 5850.6 5916.3 5499.9 5742.8 5746.6 5748.3 5748.6 5828.9 5831.8 5858.5 5869.2 5885.4 5428.6 5657.8 5668.5 5699.1 5730.7 20:25:01 INFO - PROCESS | 31626 | 20:25:01 INFO - PROCESS | 31626 | [#5] yui.html Cycles:180 Average:21036.05 Median:4798.47 stddev:30053.92 (626.3%) stddev-sans-first:30099.71 20:25:01 INFO - PROCESS | 31626 | Values: 770.7 770.9 811.2 823.2 834.8 14190.0 15464.9 15489.5 15508.3 15547.5 14971.4 15011.5 15109.8 15120.9 15176.2 653.3 785.2 800.1 822.2 843.2 814.9 820.6 821.3 825.6 827.9 862.5 864.6 869.5 873.5 876.1 866.6 866.9 867.4 867.5 867.5 622.7 627.3 630.9 631.5 634.7 13295.0 13298.5 13378.5 13395.7 13513.9 14900.0 14906.3 15005.0 15067.2 15087.5 12314.8 12754.8 12790.4 12901.5 13017.5 3852.6 4498.7 4521.6 4563.1 4789.1 78161.6 78688.6 79131.0 79290.6 79456.6 10956.9 11120.6 11491.3 11635.4 11709.0 20449.2 20683.8 20693.4 20754.3 20906.3 8397.6 8601.4 8633.6 8645.4 8796.7 4800.2 4851.9 5012.9 5182.1 5200.5 3679.6 3802.3 3829.6 3829.6 3841.5 632.9 638.5 640.9 646.4 648.6 601.4 634.4 670.5 689.0 762.1 8985.9 9660.3 10123.4 10505.2 10657.9 705.7 738.5 742.5 746.5 757.2 4597.8 4618.3 4796.7 4841.3 4966.2 104609.0 117150.0 117479.4 119563.0 120406.4 60159.0 90743.5 98532.5 98765.0 99364.5 89046.0 90538.7 90975.0 94397.0 94603.1 9098.6 9243.3 9298.4 9327.5 9368.7 51708.5 52000.2 52853.5 53318.0 54664.0 69663.0 70233.3 79815.6 80630.2 80774.6 11981.9 12112.2 12312.6 12553.7 12713.1 14493.5 14820.2 15034.7 15354.3 16295.2 13765.4 14383.6 14483.8 14539.7 14616.3 14134.4 14421.4 14682.0 15290.1 15499.3 13414.9 14247.9 15174.3 15257.7 15274.8 11613.2 11675.5 11768.5 12143.1 12598.0 12273.6 12331.5 12366.2 12380.9 12614.7 20:25:01 INFO - PROCESS | 31626 | -------- Summary: end -------- 20:25:01 INFO - PROCESS | 31626 | 20:25:02 INFO - TEST-INFO | 31626: exit 0 20:25:02 INFO - TEST-OK | dromaeo_css | took 1111074ms 20:25:02 INFO - TEST-START | kraken 20:25:02 INFO - operating with platform_type : linux_ 20:25:02 INFO - Initialising browser for kraken test... 20:25:02 INFO - TEST-INFO | started process 31868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpld0bfY/profile http://localhost:56971/getInfo.html) 20:25:07 INFO - PROCESS | 31868 | __metrics Screen width/height:1600/1200 20:25:07 INFO - PROCESS | 31868 | colorDepth:24 20:25:07 INFO - PROCESS | 31868 | Browser inner width/height: 1024/697 20:25:07 INFO - PROCESS | 31868 | __metrics 20:25:07 ERROR - PROCESS | 31868 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 20:25:08 INFO - TEST-INFO | 31868: exit 0 20:25:08 INFO - Browser initialized. 20:25:08 INFO - Running cycle 1/1 for kraken test... 20:25:08 INFO - TEST-INFO | started process 31990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpld0bfY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:20 INFO - PROCESS | 31990 | RSS: Main: 185511936 20:25:20 INFO - PROCESS | 31990 | 20:25:23 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:56971/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56971/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:24 INFO - PROCESS | 31990 | RSS: Main: 190812160 20:25:24 INFO - PROCESS | 31990 | 20:25:26 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:56971/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56971/tests/kraken/driver.html?testName=audio-dft) 20:25:27 INFO - PROCESS | 31990 | RSS: Main: 190107648 20:25:27 INFO - PROCESS | 31990 | 20:25:30 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:56971/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56971/tests/kraken/driver.html?testName=audio-fft) 20:25:30 INFO - PROCESS | 31990 | RSS: Main: 184840192 20:25:30 INFO - PROCESS | 31990 | 20:25:33 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:56971/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56971/tests/kraken/driver.html?testName=audio-oscillator) 20:25:33 INFO - PROCESS | 31990 | RSS: Main: 185626624 20:25:33 INFO - PROCESS | 31990 | 20:25:35 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:56971/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56971/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:25:36 INFO - PROCESS | 31990 | RSS: Main: 186048512 20:25:36 INFO - PROCESS | 31990 | 20:25:39 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:56971/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56971/tests/kraken/driver.html?testName=imaging-darkroom) 20:25:40 INFO - PROCESS | 31990 | RSS: Main: 185868288 20:25:40 INFO - PROCESS | 31990 | 20:25:43 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:56971/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56971/tests/kraken/driver.html?testName=imaging-desaturate) 20:25:44 INFO - PROCESS | 31990 | RSS: Main: 184012800 20:25:44 INFO - PROCESS | 31990 | 20:25:47 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:56971/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56971/tests/kraken/driver.html?testName=json-parse-financial) 20:25:47 INFO - PROCESS | 31990 | RSS: Main: 185270272 20:25:47 INFO - PROCESS | 31990 | 20:25:49 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:56971/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56971/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:25:49 INFO - PROCESS | 31990 | RSS: Main: 185655296 20:25:49 INFO - PROCESS | 31990 | 20:25:51 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:56971/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56971/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:25:52 INFO - PROCESS | 31990 | RSS: Main: 185524224 20:25:52 INFO - PROCESS | 31990 | 20:25:54 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:56971/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56971/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:25:55 INFO - PROCESS | 31990 | RSS: Main: 185737216 20:25:55 INFO - PROCESS | 31990 | 20:25:57 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:56971/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56971/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:25:58 INFO - PROCESS | 31990 | RSS: Main: 186355712 20:25:58 INFO - PROCESS | 31990 | 20:26:01 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:56971/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56971/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:01 INFO - PROCESS | 31990 | RSS: Main: 186163200 20:26:01 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:56971/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56971/tests/kraken/driver.html?testName=ai-astar) 20:26:03 INFO - PROCESS | 31990 | RSS: Main: 186806272 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | __start_tp_report 20:26:03 INFO - PROCESS | 31990 | _x_x_mozilla_page_load 20:26:03 INFO - PROCESS | 31990 | _x_x_mozilla_page_load_details 20:26:03 INFO - PROCESS | 31990 | |i|pagename|runs| 20:26:03 INFO - PROCESS | 31990 | |0;ai-astar;104;112;107;113;114;112;119;110;112;112 20:26:03 INFO - PROCESS | 31990 | |1;audio-beat-detection;166;128;158;173;133;152;156;135;176;125 20:26:03 INFO - PROCESS | 31990 | |2;audio-dft;164;162;164;164;164;170;163;163;164;163 20:26:03 INFO - PROCESS | 31990 | |3;audio-fft;74;75;76;156;76;80;75;76;167;76 20:26:03 INFO - PROCESS | 31990 | |4;audio-oscillator;86;84;150;84;85;84;129;85;85;153 20:26:03 INFO - PROCESS | 31990 | |5;imaging-gaussian-blur;118;117;117;117;117;117;118;118;118;118 20:26:03 INFO - PROCESS | 31990 | |6;imaging-darkroom;150;149;148;150;149;149;147;147;150;147 20:26:03 INFO - PROCESS | 31990 | |7;imaging-desaturate;97;96;97;97;96;96;100;95;96;96 20:26:03 INFO - PROCESS | 31990 | |8;json-parse-financial;56;55;54;55;54;56;54;58;54;55 20:26:03 INFO - PROCESS | 31990 | |9;json-stringify-tinderbox;61;63;62;63;63;62;61;62;63;62 20:26:03 INFO - PROCESS | 31990 | |10;stanford-crypto-aes;79;84;78;81;81;80;79;86;95;81 20:26:03 INFO - PROCESS | 31990 | |11;stanford-crypto-ccm;122;121;136;121;130;123;126;135;132;132 20:26:03 INFO - PROCESS | 31990 | |12;stanford-crypto-pbkdf2;160;157;160;159;160;159;155;158;160;157 20:26:03 INFO - PROCESS | 31990 | |13;stanford-crypto-sha256-iterative;63;66;64;67;62;64;66;65;62;69 20:26:03 INFO - PROCESS | 31990 | __end_tp_report 20:26:03 INFO - PROCESS | 31990 | __start_cc_report 20:26:03 INFO - PROCESS | 31990 | _x_x_mozilla_cycle_collect,916 20:26:03 INFO - PROCESS | 31990 | __end_cc_report 20:26:03 INFO - PROCESS | 31990 | __startTimestamp1466997963557__endTimestamp 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | ------- Summary: start ------- 20:26:03 INFO - PROCESS | 31990 | Number of tests: 14 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:4.01 (3.6%) stddev-sans-first:3.20 20:26:03 INFO - PROCESS | 31990 | Values: 104.0 112.0 107.0 113.0 114.0 112.0 119.0 110.0 112.0 112.0 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:157.00 stddev:18.82 (12.0%) stddev-sans-first:19.07 20:26:03 INFO - PROCESS | 31990 | Values: 166.0 128.0 158.0 173.0 133.0 152.0 156.0 135.0 176.0 125.0 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.18 (1.3%) stddev-sans-first:2.32 20:26:03 INFO - PROCESS | 31990 | Values: 164.0 162.0 164.0 164.0 164.0 170.0 163.0 163.0 164.0 163.0 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.00 stddev:36.18 (47.6%) stddev-sans-first:37.71 20:26:03 INFO - PROCESS | 31990 | Values: 74.0 75.0 76.0 156.0 76.0 80.0 75.0 76.0 167.0 76.0 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:84.50 stddev:29.30 (34.7%) stddev-sans-first:30.46 20:26:03 INFO - PROCESS | 31990 | Values: 86.0 84.0 150.0 84.0 85.0 84.0 129.0 85.0 85.0 153.0 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 20:26:03 INFO - PROCESS | 31990 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:1.26 (0.8%) stddev-sans-first:1.24 20:26:03 INFO - PROCESS | 31990 | Values: 150.0 149.0 148.0 150.0 149.0 149.0 147.0 147.0 150.0 147.0 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 20:26:03 INFO - PROCESS | 31990 | Values: 97.0 96.0 97.0 97.0 96.0 96.0 100.0 95.0 96.0 96.0 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.29 (2.3%) stddev-sans-first:1.32 20:26:03 INFO - PROCESS | 31990 | Values: 56.0 55.0 54.0 55.0 54.0 56.0 54.0 58.0 54.0 55.0 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.50 stddev:0.79 (1.3%) stddev-sans-first:0.71 20:26:03 INFO - PROCESS | 31990 | Values: 61.0 63.0 62.0 63.0 63.0 62.0 61.0 62.0 63.0 62.0 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:81.00 stddev:5.04 (6.2%) stddev-sans-first:5.19 20:26:03 INFO - PROCESS | 31990 | Values: 79.0 84.0 78.0 81.0 81.0 80.0 79.0 86.0 95.0 81.0 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:131.00 stddev:5.88 (4.5%) stddev-sans-first:5.85 20:26:03 INFO - PROCESS | 31990 | Values: 122.0 121.0 136.0 121.0 130.0 123.0 126.0 135.0 132.0 132.0 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:159.50 stddev:1.72 (1.1%) stddev-sans-first:1.73 20:26:03 INFO - PROCESS | 31990 | Values: 160.0 157.0 160.0 159.0 160.0 159.0 155.0 158.0 160.0 157.0 20:26:03 INFO - PROCESS | 31990 | 20:26:03 INFO - PROCESS | 31990 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.50 stddev:2.25 (3.4%) stddev-sans-first:2.29 20:26:03 INFO - PROCESS | 31990 | Values: 63.0 66.0 64.0 67.0 62.0 64.0 66.0 65.0 62.0 69.0 20:26:03 INFO - PROCESS | 31990 | -------- Summary: end -------- 20:26:03 INFO - PROCESS | 31990 | 20:26:04 INFO - TEST-INFO | 31990: exit 0 20:26:04 INFO - TEST-OK | kraken | took 61952ms 20:26:04 INFO - SUITE-END | took 1173s 20:26:04 INFO - Completed test suite (00:19:33) 20:26:04 INFO - javascript benchmark 20:26:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7358.424323259729, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.891503797367, 3100.7829451938373, 3121.079281611924, 3136.85884135214, 3139.827309497977, 5424.701641409721, 5426.538744206742, 5492.47821456962, 5504.559635229182, 5603.915941260884, 5337.5196232339085, 5427.240186373911, 5443.863903402407, 5484.095124304495, 5537.1140617501105, 4907.975460122712, 4927.236278376858, 5023.572996295319, 5078.39059312883, 5134.127198376285, 672.3273015647405, 4887.511248875102, 4896.045271172123, 4983.103041452537, 5032.6477146599755, 4941.777620007108, 4947.975260123694, 4986.3767029121545, 4992.45083040867, 4996.300517927493, 4991.825286115005, 4996.1756310208775, 5004.749762511896, 5008.724520151391, 5040.42035165957, 4859.902801943977, 4904.877378065541, 4918.803247870081, 4927.95072049282, 4944.60443164546, 5331.226972089025, 5403.78384864605, 5445.319335083114, 5454.809081682122, 5481.725913704338, 5689.487946084831, 5743.5118014968775, 5828.795992140297, 5830.096335068029, 5834.008218602848, 5833.037548804442, 5894.58737888348, 5923.674197919113, 5966.403359663999, 5966.522678185735, 5480.588955828329, 5522.502974732253, 5535.889282214373, 5535.972320138414, 5537.501624853782, 5832.88334233313, 5937.643741375531, 5953.910691339634, 5966.254218222723, 5971.134185543072, 5759.913601295984, 5765.221695071195, 5770.221020162308, 5798.449147330997, 5831.067029275296, 5851.122331650201, 5852.795152169653, 5854.970725146347, 5855.092460668603, 5857.15071314657, 5709.885802284014, 5775.682337471395, 5812.912806307909, 5824.5631577631, 5867.823965281048, 5807.5063619591965, 5883.441073098049, 5889.911651325234, 5907.350191478934, 5921.822345329647, 4423.712458690175, 4426.822927082881, 4463.129689710475, 4467.352233926127, 4501.864944051684, 3893.9610603894166, 3909.58949310324, 3929.9214015719526, 3960.3069462843887, 3991.0, 5581.469760372758, 5612.494875461147, 5613.635113717595, 5645.717714114277, 5662.801801936995, 5958.433948774946, 5976.073708575178, 5979.1629171915965, 5980.192673989043, 5986.07215881539, 5478.424765399575, 5529.502344788908, 5579.860503487445, 5581.6930068845795, 5620.718964051781, 5004.3494345734825, 5021.59827213822, 5049.772760225798, 5051.621128415383, 5084.898302034013, 5808.912866307009, 6069.484093852072, 6079.665618391031, 6081.57428979976, 6098.176746139215, 5891.3224979127945, 5946.286445626552, 5955.791547295824, 6007.189029480965, 6013.789517366871, 6139.723712432862, 6143.139960405636, 6153.876922461436, 6157.96921015392, 6159.476444502267, 5683.857903552444, 5702.971485142548, 5830.5627077968475, 5839.766409343749, 5847.830433913149, 5831.970840145772, 5897.056470964625, 5902.203202567598, 5902.940970590239, 5962.4633782959745, 5723.399043100581, 5754.0, 5768.0, 5771.163181338767, 5784.392638773036, 5645.915311270416, 5661.377248502744, 5707.315122185364, 5741.052726300114, 5743.10981797822, 5587.441255874543, 5621.269234999424, 5640.266765320482, 5647.519960803378, 5685.857853553694, 5710.8001219957105, 5724.914126288026, 5751.223584816164, 5766.0, 5770.682612456355, 5532.197831314517, 5621.55027597783, 5644.181593668813, 5653.067243904709, 5701.372848986691], "value": 5369.9114190982955, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.2593140020872, 619.4486906653079, 636.6466611030877, 638.7764282501125, 646.069659690046, 38806.223875522504, 42587.0, 43173.78413107934, 43201.78399108004, 43269.0, 43284.350734739004, 43979.0, 44154.337684934755, 44221.115577688426, 44293.55706442943, 8950.104989501064, 9083.863742043875, 9111.362204645677, 9123.817523649523, 9127.26981841451, 8944.284457243404, 9010.954945225265, 9018.323625728064, 9029.503377314246, 9057.682981095662, 8993.370464067519, 9010.459372437643, 9035.0, 9091.409058411215, 9108.817823643556, 9059.456432614064, 9063.365564410495, 9110.498922559256, 9111.0, 9117.544122793834, 8879.778005549848, 8948.194662480408, 8956.059613740594, 8973.955130224307, 8978.326625503114, 40900.38649420261, 40918.0, 41285.380719289235, 41408.1718365631, 41520.169596608204, 3067.8466076696077, 3451.3442445935443, 3492.930141397158, 3616.8191590420374, 3641.7086633069557, 30691.232719181975, 30873.691263087305, 31169.84415077933, 33065.0, 34109.0, 4431.2466880630045, 4437.2013037653205, 4440.511543730187, 4484.282514797649, 4541.84103556374, 361078.0, 361999.0, 362346.0, 362875.0, 363351.9999999974, 61892.0, 62310.37689623136, 62761.68619156875, 62820.371796282365, 62856.37143628505, 31118.0, 31224.063278101694, 31425.05724828259, 33028.50457243143, 63546.6822665893, 17447.82552174462, 17492.0, 17531.474055778348, 17545.0, 17582.824171758373, 13401.597952061455, 13415.530456434173, 13447.394867230998, 13474.191548506926, 13474.393652285671, 18834.246630134916, 19031.809681903003, 19111.90444047771, 19142.71285930712, 19160.90419547893, 7030.191527974246, 7293.489455738153, 7323.963380183065, 7388.630568471555, 7391.482596218213, 994.7761753605525, 1005.406809982114, 1008.4100801031332, 1035.0839507036328, 1101.1631160318216, 32155.839220803748, 32682.67317326844, 32743.67256327454, 32898.0, 32927.0, 1119.462657924201, 1146.3179408252076, 1181.4447209811374, 1204.801207800703, 1207.9939600301943, 16874.15629218534, 16921.7461738074, 16966.15169241533, 17255.74116388255, 17470.912645436692, 622602.0, 664147.0, 676046.0, 679141.4171716538, 1024546.0, 59582.70208648929, 59868.0, 60003.69998149981, 60551.394486055455, 60766.392336076955, 1339.912905661129, 1392.5752645443035, 1393.5053056165118, 1401.4884567132924, 1414.4978532620978, 31774.0, 32837.50743738894, 32891.34217315688, 33151.502727458625, 33317.83341083279, 50989.0, 51713.0, 51720.48279517307, 51792.741036294574, 51856.0, 522331.0, 523971.0, 532161.0, 532514.0, 534386.0, 28541.0, 28552.286192845346, 28608.713912860603, 28632.284192895346, 28734.0, 47478.0, 47512.7624361876, 48327.275090872965, 48463.51536484731, 48930.266046008626, 40461.1907761849, 40583.1883362337, 40600.79699601483, 41152.58847411488, 41641.58358416377, 39224.411633824944, 39947.0, 40937.79531102445, 41118.383224252255, 41388.1722365557, 36355.818220908724, 39912.80043599763, 40285.798571006955, 40319.79840100781, 41249.79375103105, 32154.35691286208, 36211.0, 39610.207795843344, 39619.80190099031, 39642.80178599204, 28541.429171416872, 29231.269218269714, 29626.703732962393, 29629.703702963558, 29842.552361715025], "value": 20426.908759537608, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.65830752322904, 380.7876239051112, 386.6249737754378, 396.27877263380657, 403.0709215258831, 18030.819691803095, 19629.60740785187, 19742.703859442085, 19824.909629970345, 19980.60038799227, 18741.34405295815, 18861.90569047153, 19080.522986925334, 19153.71269430956, 19548.804511954913, 5534.114541673343, 5655.236543066695, 5690.0, 5762.193292938992, 5770.9422905770825, 5486.890262194754, 5643.153526970967, 5658.688772117532, 5664.518515926151, 5694.914576281359, 5599.188117722928, 5600.439956004408, 5647.09646456567, 5654.575906806986, 5659.51894089003, 5687.687177205273, 5702.716888700009, 5711.114777209539, 5724.427557244284, 5738.110592858114, 5059.468755780626, 5083.822066227701, 5100.591952643779, 5104.566111880495, 5106.591472682214, 22501.9874105664, 22654.66018009731, 22778.772212277832, 22926.88536557323, 23179.652305215433, 2383.511380167062, 2453.570625140593, 2459.7417271186446, 2561.2316305108393, 2699.4736026474843, 9851.408915465096, 9903.207743380512, 12296.569620063256, 13054.804177937338, 14659.0, 1924.6728056230475, 1941.2235105957589, 1983.9206431742714, 2070.223666125203, 2096.9475763106043, 75163.0, 79461.60269198618, 81857.0, 81941.18058819395, 83605.58197209035, 10022.098011178883, 10104.797904041878, 10615.31000484966, 10670.62652807148, 10845.349279043125, 13761.587152385444, 13781.0, 13801.102928309829, 13871.167729936236, 13964.0, 7810.101838288556, 8084.474509156886, 8103.513789172551, 8245.628946697412, 8287.917120828715, 8076.192380761877, 8163.836723265502, 8304.418690691715, 8313.251807337369, 8369.623366948503, 4192.287311157111, 4239.40648309237, 4251.617354438115, 4276.3799249109325, 4284.91430171401, 1779.1904683369037, 1827.1869018287, 1840.4110684580805, 1848.7689038870142, 1852.3609354772852, 947.265868951568, 963.9132478077007, 988.8318985772436, 1066.6053560182781, 1115.4032592563103, 18819.247230110916, 19011.524711882314, 19290.903545482182, 19833.809971401763, 19836.404907852786, 987.5161171026289, 989.2580564576567, 996.2080146283722, 1002.318423472046, 1006.7885743993843, 10587.629432969808, 10855.837162442569, 10866.782664346827, 10875.374965912315, 10884.442026345063, 451093.0, 458150.0, 458782.0, 466103.0, 468511.0, 73803.63098184475, 93062.06937930534, 95587.52206238924, 95703.12890613293, 96874.0312596865, 992.7815880506278, 1007.0684616729496, 1016.9898301017043, 1020.994895025535, 1026.3892983674552, 17092.57268568246, 17211.006623437257, 17283.481495555152, 17623.647527049132, 17799.73300400521, 29557.556636650897, 29813.0, 40668.59331406648, 40707.0, 41165.0, 56327.15509267446, 56365.718171410525, 57193.714031429576, 57223.0, 57906.420935790105, 8301.0, 8345.290650294794, 8479.830403391774, 8506.617202226038, 8529.74410767678, 12681.112322137362, 13085.149465284727, 13385.598432047054, 13483.056186067273, 13646.590602281947, 11711.88288117108, 11826.231294965799, 11859.0, 11885.989690876026, 12143.817842732542, 11707.063434925016, 11804.114691398008, 11955.581554645545, 11995.340256285988, 12062.577809776616, 11634.76730465403, 11935.641930742091, 12176.147669663038, 12325.260484370967, 12415.130940834055, 7110.680019399036, 8469.491830489944, 8636.26591739684, 8682.175193356621, 8716.259117975043, 11160.497777599865, 11176.0, 11704.36138940566, 11904.464299106388, 12242.265464072185], "value": 9131.403034566833, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.2751551739648, 1493.1712899340864, 1624.821269660337, 1722.3369002933875, 1752.3078384038297, 8010.839783204332, 8861.46831190129, 8872.112788721133, 9478.0, 9496.145346918776, 8909.465432074065, 9145.0, 9176.954115229415, 9177.541122943843, 9181.2654987601, 2183.5087105401276, 2228.4874478869788, 2236.3067449090754, 2238.183063181935, 2239.1826983151195, 2212.1814928476488, 2243.091547923094, 2267.6598510223516, 2299.4711216420233, 2300.620397634388, 2259.2318611672026, 2259.3560835161984, 2278.3506700590333, 2278.737945136314, 2317.4322291038634, 2173.8913054347217, 2191.3973657244305, 2192.342297310808, 2213.712217411742, 2225.8441909066373, 2223.444138965259, 2238.507528343778, 2241.730992280937, 2243.596152692515, 2246.786555277246, 9131.2238459731, 9159.0, 9186.0, 9256.0, 9259.166674999282, 5349.144136938071, 5472.562195024429, 5483.259759932398, 5484.040292948758, 5485.588580856412, 3381.340638575479, 3422.144463884029, 3536.3811333016874, 3569.8929032129076, 3584.1577229351083, 1052.947352632373, 1074.3661239868516, 1079.0396547073112, 1079.6599071292517, 1087.8259478483483, 12853.935730321382, 12855.421506032251, 12882.677933051655, 12893.226406415644, 12903.16129451592, 4745.881352966204, 4786.760661966888, 4799.784009719571, 4817.012512434942, 4910.508949105132, 10585.04734573892, 10622.0, 10626.096781773482, 10641.946790266, 10657.147428205724, 5433.429489903582, 5437.510624043855, 5464.644798088191, 5475.041867673221, 5479.0, 4505.977470112694, 4923.433805112458, 4940.530649588283, 5069.290299358093, 5104.923426148611, 3967.7024223183375, 3987.8803635890968, 4018.5378681452007, 4038.1519880825354, 4087.346024636044, 1258.6098309524077, 1263.5514392390753, 1266.3731452930858, 1270.707737220426, 1278.2905487454552, 809.2756982500629, 901.3870568013814, 922.5341202692597, 948.3361646847235, 964.6189755046857, 5905.141237899948, 6020.909686354708, 6090.756369745161, 6130.2030736004035, 6230.314665386803, 916.6150216908915, 974.3763991045737, 994.0655783563427, 1016.8525563793208, 1064.0742553977934, 3947.881563553098, 4023.597640235953, 4035.7982100894837, 4042.8989275268355, 4058.330375488011, 10824.458777061272, 11436.942815286036, 11474.713132171762, 11553.942230288794, 11607.187496875307, 11194.552217911192, 11195.2723073, 11206.83189752138, 11239.438028098562, 11282.94358528202, 8509.446885952393, 8535.999999999876, 8564.61459234336, 8655.826883462421, 8715.694950676696, 5637.0, 5764.827055188351, 5857.359939217026, 5908.202392676933, 6025.849353766191, 10053.095221430107, 10210.540525676213, 10236.795264094826, 10321.948390258001, 10350.689479315633, 10498.527566259383, 10522.0, 10527.631532896312, 10740.516676749721, 11146.108311334912, 7716.305532502101, 7943.126256111707, 7996.080450748006, 8006.07930088024, 8049.476784009021, 8691.869621955802, 8695.826083478421, 8697.130286971505, 8702.782430439289, 8768.60541275657, 7714.575698336421, 7791.961040194763, 7792.688292468238, 7825.960870195612, 7939.701000823482, 7703.653335599799, 7748.845023099394, 7847.254510821463, 7946.483478573874, 8010.198980102176, 7297.744578939712, 7308.8903666443985, 7437.8140546486775, 7479.252074792477, 7523.210062943313, 4973.104841128632, 5027.673201241908, 5039.798408063636, 5075.543201111917, 5101.0, 5150.665206761549, 5204.193350030751, 5212.296339994053, 5246.921296180637, 5280.656757310762], "value": 4704.31728975466, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.5939759517438, 317.2417921168407, 322.5258869461891, 324.8083630657911, 324.91964218971924, 5367.812126575571, 5463.863403414916, 5478.890627108562, 5485.149801780721, 5617.691026993509, 5484.643498172616, 5548.500634942854, 5566.638168519044, 5596.552275817935, 5600.375890991618, 4318.287482565389, 4319.308910574308, 4339.088791353819, 4343.891402714941, 4357.869263922072, 4258.467691538558, 4289.313709806432, 4320.848770293041, 4340.218760623086, 4354.303311470166, 4256.276433006381, 4289.914201715964, 4290.334998075287, 4290.54949230331, 4307.901485121305, 4292.120115376356, 4296.162248361571, 4304.160688665712, 4332.526940840098, 4335.393044973706, 3705.5182826232685, 3733.51464309638, 3817.3701339278987, 3833.865814696472, 3836.8081595920094, 5288.576913846921, 5387.730613469311, 5396.352437707461, 5406.972965135188, 5421.349438067417, 4804.25534042224, 4818.807247710122, 4843.75781210938, 4852.053849499313, 4880.414350277953, 5497.890042199134, 5827.708614569297, 5868.911966320508, 5897.7935772247765, 5903.645781253095, 4034.152827906143, 4054.2499637567144, 4056.71602987791, 4060.0, 4064.6138616831354, 6017.232073246312, 6037.245344331958, 6054.636721796663, 6069.878602427971, 6088.295277322357, 4049.0484736086996, 4065.3698676705158, 4105.794710264475, 4108.137291168829, 4132.607402296777, 4156.91686166281, 4165.167326376385, 4172.228137794517, 4202.516710578261, 4202.642775364128, 4852.951470485321, 4861.173600487926, 4876.463589005207, 4878.82924097662, 4891.437484689235, 5489.313835770528, 5822.7088645567555, 5831.446012628793, 5848.8537786554825, 5870.412958704095, 1429.2782145016909, 1432.7349440353569, 1436.8491308412674, 1440.9495667651581, 1451.8620731030535, 896.2292428511475, 900.8063266397756, 921.3642586615214, 927.4018258223408, 933.3886304470583, 5004.974975125101, 5023.824166154167, 5071.2139618359215, 5084.542391184811, 5097.7706003229205, 5276.126974923924, 5305.4164041955355, 5307.548858347083, 5312.946870531323, 5343.732813359316, 4976.825811096666, 5000.849974500771, 5028.572571331405, 5291.100512912814, 5775.942240577624, 3213.6464988851208, 3214.3249917517114, 3216.6140063192565, 3228.580284562992, 3233.9676603233665, 6028.889888538976, 6179.196704428396, 6229.937700622936, 6232.501399888089, 6233.812985610439, 6109.358517355614, 6109.969450152721, 6112.572119951649, 6133.846653833601, 6170.382961703884, 5994.272605964363, 6128.3759803652065, 6195.845103872349, 6213.161223234805, 6240.31356550779, 5726.169705392778, 5920.73356698941, 5938.168656388023, 5950.494207992196, 5991.520678345809, 5845.941540584539, 5885.205497257986, 5890.319904443553, 5941.58408911372, 6010.3088144863905, 5947.197128387612, 6154.846128846814, 6170.734999325217, 6205.162303089025, 6232.906506402498, 4121.289664789079, 4132.442120313719, 4136.958630413657, 4140.254754144163, 4155.127423241153, 5808.6805225711305, 5837.912431313619, 5957.49361304294, 5987.75459202799, 5995.0, 5816.662167701368, 5834.15404766315, 5837.883242335214, 5846.152307915243, 5851.61964472308, 5765.913511297418, 5829.417058294137, 5840.328362238397, 5850.5904586678525, 5916.3492015877355, 5499.865076906285, 5742.7702891883855, 5746.626469279484, 5748.310202775694, 5748.597598168088, 5828.883422331445, 5831.79588714393, 5858.47273745365, 5869.207656966255, 5885.440883116097, 5428.56571474289, 5657.8019769307875, 5668.489835914787, 5699.062318811624, 5730.684812335361], "value": 4361.293998278197, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.6763159473022, 770.8643129609643, 811.1969150540964, 823.2097186700771, 834.8163404051114, 14190.0, 15464.922675386635, 15489.535313940572, 15508.302126404311, 15547.533573992785, 14971.401143954228, 15011.549653510385, 15109.84890151098, 15120.924395378035, 15176.241187940586, 653.3074940563007, 785.2069409895989, 800.0519384529322, 822.1778221778221, 843.161054750521, 814.8655471847138, 820.5568992743941, 821.3306155483292, 825.5995842016617, 827.871679889615, 862.4523427623442, 864.6238886084574, 869.4696235296464, 873.5108339329964, 876.0582373948031, 866.6403442571325, 866.921977022071, 867.4101610904582, 867.4621734524603, 867.483847110968, 622.6793201501231, 627.2817623820746, 630.9274433440168, 631.5074242091176, 634.6890023888308, 13295.0, 13298.468061277537, 13378.46486140563, 13395.665108372368, 13513.932430337883, 14900.0, 14906.329215185342, 15005.0, 15067.246637668073, 15087.547373578811, 12314.75370492594, 12754.80867786984, 12790.360481975957, 12901.548445804352, 13017.544385946541, 3852.5954774748807, 4498.707584007029, 4521.570450807168, 4563.06457176278, 4789.137955168103, 78161.60919195424, 78688.60655696684, 79131.0, 79290.60354698189, 79456.60271698663, 10956.945215274032, 11120.61077862271, 11491.310521368745, 11635.418229088511, 11709.0, 20449.18203271882, 20683.79316206819, 20693.379198624065, 20754.273600424214, 20906.268280610104, 8397.6221070052, 8601.411145658913, 8633.611487483078, 8645.3948223625, 8796.692115775917, 4800.207965685692, 4851.902961940741, 5012.874678133003, 5182.144946083854, 5200.479952004769, 3679.632036796299, 3802.315583194996, 3829.6170382962036, 3829.6170382962036, 3841.5006049213425, 632.9208848893888, 638.52748965765, 640.9391107844747, 646.360103497534, 648.5946283572767, 601.4466690644617, 634.4131678197649, 670.5138774388529, 688.9621070841151, 762.0778857582387, 8985.865212021825, 9660.275479339078, 10123.44321062334, 10505.212109091695, 10657.893421065844, 705.6507029020565, 738.5421038955882, 742.5433358484601, 746.488655271141, 757.2351924556128, 4597.770111494478, 4618.261078227535, 4796.736179510091, 4841.3222148899185, 4966.15575352191, 104609.0, 117150.0, 117479.41260293814, 119563.0, 120406.39796801136, 60159.0, 90743.54628226817, 98532.50733746286, 98765.0, 99364.5031774851, 89046.0, 90538.69944409706, 90975.0, 94397.0, 94603.0539694608, 9098.636054558008, 9243.306751993761, 9298.395604285699, 9327.533623318672, 9368.67209647659, 51708.48291517037, 52000.21999669932, 52853.471465284856, 53318.0, 54664.0, 69663.0, 70233.29766702268, 79815.60092199733, 80630.19369806227, 80774.59612701899, 11981.880181198076, 12112.21270617407, 12312.569060083213, 12553.686157846127, 12713.11008229452, 14493.492727754478, 14820.18488983073, 15034.699306014038, 15354.30905609228, 16295.18524073768, 13765.449382024606, 14383.640408989859, 14483.782743259071, 14539.709205816036, 14616.342264597906, 14134.363953622318, 14421.351039203471, 14682.0, 15290.082595044332, 15499.30253138634, 13414.932925335312, 14247.931405144449, 15174.31715572824, 15257.694846103237, 15274.770878437055, 11613.187076904536, 11675.474603642686, 11768.52925882955, 12143.14997950135, 12598.0, 12273.570425035081, 12331.50673973031, 12366.19619724715, 12380.938095309466, 12614.747705045664], "value": 7724.066883782021, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 107.0, 113.0, 114.0, 112.0, 119.0, 110.0, 112.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 128.0, 158.0, 173.0, 133.0, 152.0, 156.0, 135.0, 176.0, 125.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 164.0, 164.0, 170.0, 163.0, 163.0, 164.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 156.0, 76.0, 80.0, 75.0, 76.0, 167.0, 76.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 150.0, 84.0, 85.0, 84.0, 129.0, 85.0, 85.0, 153.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 148.0, 150.0, 149.0, 149.0, 147.0, 147.0, 150.0, 147.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 100.0, 95.0, 96.0, 96.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 55.0, 54.0, 56.0, 54.0, 58.0, 54.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 63.0, 63.0, 62.0, 61.0, 62.0, 63.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 78.0, 81.0, 81.0, 80.0, 79.0, 86.0, 95.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 136.0, 121.0, 130.0, 123.0, 126.0, 135.0, 132.0, 132.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 160.0, 159.0, 160.0, 159.0, 155.0, 158.0, 160.0, 157.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 64.0, 67.0, 62.0, 64.0, 66.0, 65.0, 62.0, 69.0], "value": 64.8, "unit": "score"}]}]} 20:26:04 INFO - Return code: 0 20:26:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:26:04 ERROR - # TBPL SUCCESS # 20:26:04 INFO - Running post-action listener: _resource_record_post_action 20:26:04 INFO - ##### 20:26:04 INFO - ##### Finished run-tests step (success) 20:26:04 INFO - ##### 20:26:04 INFO - Running post-run listener: _resource_record_post_run 20:26:04 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 551788544; Read time: 0; Write time: 492476 20:26:04 INFO - TinderboxPrint: CPU usage
13.4% 20:26:04 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:26:04 INFO - TinderboxPrint: I/O write bytes / time
551,788,544 / 492,476 20:26:04 INFO - TinderboxPrint: CPU idle
8,223.4 (86.6%) 20:26:04 INFO - TinderboxPrint: CPU user
1,219.7 (12.8%) 20:26:04 INFO - TinderboxPrint: Swap in / out
0 / 0 20:26:04 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256536576; Read time: 0; Write time: 290808 20:26:04 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295251968; Read time: 0; Write time: 201668 20:26:05 INFO - Running post-run listener: _upload_blobber_files 20:26:05 INFO - Blob upload gear active. 20:26:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:26:05 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:26:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:26:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:06 INFO - (blobuploader) - INFO - Done attempting. 20:26:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:26:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:11 INFO - (blobuploader) - INFO - Done attempting. 20:26:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:26:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:11 INFO - (blobuploader) - INFO - Done attempting. 20:26:11 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:11 INFO - Return code: 0 20:26:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f31cd99a26657f4bb167ff7c00bf3ffa38daa993584be48f12e082cdd340c35b40e52d24f14f9f81b0506ea82b2c3093ff7d1b14449e29b11aa4a2763e3b0d1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ea6626f98404454906224f2a62e894930cade352ec874cce93d8125c7c15aeedf44d490796e917e65afcc06ebb7effe6570224e17ad7f6407283e618202a9f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b992bb09714f1a8a9b10698d9973644509ee6e925cd33b25c2dd26dc257a0ee879d712dc236d6acad04fc3e82814564e1728df8021f84217164fc4542203f7b4"} 20:26:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:11 INFO - Contents: 20:26:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f31cd99a26657f4bb167ff7c00bf3ffa38daa993584be48f12e082cdd340c35b40e52d24f14f9f81b0506ea82b2c3093ff7d1b14449e29b11aa4a2763e3b0d1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ea6626f98404454906224f2a62e894930cade352ec874cce93d8125c7c15aeedf44d490796e917e65afcc06ebb7effe6570224e17ad7f6407283e618202a9f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b992bb09714f1a8a9b10698d9973644509ee6e925cd33b25c2dd26dc257a0ee879d712dc236d6acad04fc3e82814564e1728df8021f84217164fc4542203f7b4"} 20:26:11 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:11 INFO - Copying logs to upload dir... 20:26:11 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.181684 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-26 20:26:10.420866) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 20:26:10.424023) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f31cd99a26657f4bb167ff7c00bf3ffa38daa993584be48f12e082cdd340c35b40e52d24f14f9f81b0506ea82b2c3093ff7d1b14449e29b11aa4a2763e3b0d1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ea6626f98404454906224f2a62e894930cade352ec874cce93d8125c7c15aeedf44d490796e917e65afcc06ebb7effe6570224e17ad7f6407283e618202a9f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b992bb09714f1a8a9b10698d9973644509ee6e925cd33b25c2dd26dc257a0ee879d712dc236d6acad04fc3e82814564e1728df8021f84217164fc4542203f7b4"} build_url:https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f31cd99a26657f4bb167ff7c00bf3ffa38daa993584be48f12e082cdd340c35b40e52d24f14f9f81b0506ea82b2c3093ff7d1b14449e29b11aa4a2763e3b0d1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ea6626f98404454906224f2a62e894930cade352ec874cce93d8125c7c15aeedf44d490796e917e65afcc06ebb7effe6570224e17ad7f6407283e618202a9f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b992bb09714f1a8a9b10698d9973644509ee6e925cd33b25c2dd26dc257a0ee879d712dc236d6acad04fc3e82814564e1728df8021f84217164fc4542203f7b4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 20:26:10.452375) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:26:10.452763) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1466994376.989557-1348841240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:26:10.536732) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 20:26:10.537093) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 20:26:10.537430) ========= ========= Total master_lag: 0.20 =========