builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1466595939.17 results: success (0) buildid: 20160622041004 builduid: ac94413f3f144b4c96228cadfae605db revision: 93a9cda876d8c452e4b851c7f8ef275006c220af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 04:45:39.174763) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 04:45:39.175497) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 04:45:39.175808) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 04:45:39.231730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:45:39.232051) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 04:45:40-- 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% 5.94M=0.002s 2016-06-22 04:45:40 (5.94 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165771 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:45:39.418333) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:45:39.418946) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019512 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:45:39.470690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 04:45:39.471125) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 93a9cda876d8c452e4b851c7f8ef275006c220af --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 93a9cda876d8c452e4b851c7f8ef275006c220af --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=a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 04:45:40,302 truncating revision to first 12 chars 2016-06-22 04:45:40,302 Setting DEBUG logging. 2016-06-22 04:45:40,302 attempt 1/10 2016-06-22 04:45:40,302 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/93a9cda876d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 04:45:41,107 unpacking tar archive at: fx-team-93a9cda876d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.141257 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 04:45:40.626380) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 04:45:40.626688) ========= script_repo_revision: 93a9cda876d8c452e4b851c7f8ef275006c220af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 04:45:40.627106) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 04:45:40.627385) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 04:45:40.639581) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-06-22 04:45:40.639990) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:45:41 INFO - MultiFileLogger online at 20160622 04:45:41 in /builds/slave/test 04:45:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:45:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:41 INFO - {'append_to_log': False, 04:45:41 INFO - 'base_work_dir': '/builds/slave/test', 04:45:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:45:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:41 INFO - 'branch': 'Fx-Team-Non-PGO', 04:45:41 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:41 INFO - 'config_files': ('talos/linux_config.py',), 04:45:41 INFO - 'default_actions': ('clobber', 04:45:41 INFO - 'read-buildbot-config', 04:45:41 INFO - 'download-and-extract', 04:45:41 INFO - 'populate-webroot', 04:45:41 INFO - 'create-virtualenv', 04:45:41 INFO - 'install', 04:45:41 INFO - 'run-tests'), 04:45:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:41 INFO - 'download_minidump_stackwalk': True, 04:45:41 INFO - 'download_symbols': 'ondemand', 04:45:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:41 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:41 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:41 INFO - 'installer_path': 'installer.exe', 04:45:41 INFO - 'log_level': 'info', 04:45:41 INFO - 'log_name': 'talos', 04:45:41 INFO - 'log_to_console': True, 04:45:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:45:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:45:41 INFO - 'opt_config_files': (), 04:45:41 INFO - 'pip_index': False, 04:45:41 INFO - 'sps_profile': False, 04:45:41 INFO - 'sps_profile_interval': 0, 04:45:41 INFO - 'suite': 'dromaeojs-e10s', 04:45:41 INFO - 'system_bits': '32', 04:45:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:41 INFO - 'title': 'talos-linux64-ix-002', 04:45:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:41 INFO - 'use_talos_json': True, 04:45:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:41 INFO - 'work_dir': 'build'} 04:45:41 INFO - ##### 04:45:41 INFO - ##### Running clobber step. 04:45:41 INFO - ##### 04:45:41 INFO - Running pre-action listener: _resource_record_pre_action 04:45:41 INFO - Running main action method: clobber 04:45:41 INFO - rmtree: /builds/slave/test/build 04:45:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:45:42 INFO - Running post-action listener: _resource_record_post_action 04:45:42 INFO - ##### 04:45:42 INFO - ##### Finished clobber step (success) 04:45:42 INFO - ##### 04:45:42 INFO - ##### 04:45:42 INFO - ##### Running read-buildbot-config step. 04:45:42 INFO - ##### 04:45:42 INFO - Running pre-action listener: _resource_record_pre_action 04:45:42 INFO - Running main action method: read_buildbot_config 04:45:42 INFO - Using buildbot properties: 04:45:42 INFO - { 04:45:42 INFO - "project": "", 04:45:42 INFO - "product": "firefox", 04:45:42 INFO - "script_repo_revision": "production", 04:45:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:45:42 INFO - "repository": "", 04:45:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:45:42 INFO - "buildid": "20160622041004", 04:45:42 INFO - "pgo_build": "False", 04:45:42 INFO - "basedir": "/builds/slave/test", 04:45:42 INFO - "buildnumber": 1603, 04:45:42 INFO - "slavename": "talos-linux64-ix-002", 04:45:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:45:42 INFO - "platform": "ubuntu64_hw", 04:45:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:45:42 INFO - "branch": "fx-team", 04:45:42 INFO - "repo_path": "integration/fx-team", 04:45:42 INFO - "revision": "93a9cda876d8c452e4b851c7f8ef275006c220af", 04:45:42 INFO - "stage_platform": "linux64", 04:45:42 INFO - "builduid": "ac94413f3f144b4c96228cadfae605db", 04:45:42 INFO - "slavebuilddir": "test" 04:45:42 INFO - } 04:45:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:45:42 INFO - Running post-action listener: _resource_record_post_action 04:45:42 INFO - ##### 04:45:42 INFO - ##### Finished read-buildbot-config step (success) 04:45:42 INFO - ##### 04:45:42 INFO - ##### 04:45:42 INFO - ##### Running download-and-extract step. 04:45:42 INFO - ##### 04:45:42 INFO - Running pre-action listener: _resource_record_pre_action 04:45:42 INFO - Running main action method: download_and_extract 04:45:42 INFO - mkdir: /builds/slave/test/build/tests 04:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:42 INFO - https://queue.taskcluster.net/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:45:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:45:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:45:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/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 04:45:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/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 04:45:44 INFO - Downloaded 1361 bytes. 04:45:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:45:44 INFO - Using the following test package requirements: 04:45:44 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:45:44 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:45:44 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:45:44 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:44 INFO - u'jsshell-linux-x86_64.zip'], 04:45:44 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:45:44 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:45:44 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:45:44 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:45:44 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:45:44 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:45:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:45: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')]} 04:45:44 INFO - https://queue.taskcluster.net/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:45:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:45:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:45:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/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 04:45:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/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 04:45:45 INFO - Downloaded 22701903 bytes. 04:45:45 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'] 04:45:45 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 04:45:46 INFO - Return code: 0 04:45:46 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 04:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:46 INFO - https://queue.taskcluster.net/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:45:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:45:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:45:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/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 04:45:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/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 04:45:48 INFO - Downloaded 22701903 bytes. 04:45:48 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'] 04:45:48 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 04:45:49 INFO - Return code: 0 04:45:49 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')]} 04:45:49 INFO - https://queue.taskcluster.net/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:45:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:45:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:45:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/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 04:45:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/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 04:45:50 INFO - Downloaded 14405384 bytes. 04:45:50 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'] 04:45:50 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 04:45:50 INFO - Return code: 0 04:45: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')]} 04:45:50 INFO - https://queue.taskcluster.net/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:45:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:45:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:45:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/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 04:45:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/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 04:46:02 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:46:02 INFO - Running command: ['nslookup', 'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 04:46:02 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 04:46:02 INFO - Server: 10.26.75.40 04:46:02 INFO - Address: 10.26.75.40#53 04:46:02 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 04:46:02 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 04:46:02 INFO - Address: 10.26.48.46 04:46:02 INFO - Return code: 0 04:46:02 INFO - retry: attempt #1 caught exception: 04:46:02 INFO - retry: Failed, sleeping 30 seconds before retrying 04:46:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q9voajH8SvGYF_0vEp4__g/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 #2 04:46:36 INFO - Downloaded 56246289 bytes. 04:46:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:46:36 INFO - mkdir: /builds/slave/test/properties 04:46:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:46:36 INFO - Writing to file /builds/slave/test/properties/build_url 04:46:36 INFO - Contents: 04:46:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:46:37 INFO - Running post-action listener: _resource_record_post_action 04:46:37 INFO - Running post-action listener: set_extra_try_arguments 04:46:37 INFO - ##### 04:46:37 INFO - ##### Finished download-and-extract step (success) 04:46:37 INFO - ##### 04:46:37 INFO - ##### 04:46:37 INFO - ##### Running populate-webroot step. 04:46:37 INFO - ##### 04:46:37 INFO - Running pre-action listener: _resource_record_pre_action 04:46:37 INFO - Running main action method: populate_webroot 04:46:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:46:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:46:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:46:37 INFO - '--tppagecycles', 04:46:37 INFO - '7'], 04:46:37 INFO - 'tests': ['tsvgm']}}, 04:46:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:46:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:46:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:46:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:46:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:46:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:46:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:37 INFO - 'talos_options': ['--disable-e10s'], 04:46:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:37 INFO - 'talos_options': ['--disable-e10s'], 04:46:37 INFO - 'tests': ['damp', 'tps']}, 04:46:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:37 INFO - 'tests': ['damp', 'tps']}, 04:46:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:46:37 INFO - 'tests': ['dromaeo_dom']}, 04:46:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:46:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:46:37 INFO - 'tests': ['basic_compositor_video']}, 04:46:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:46:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:46:37 INFO - 'tests': ['a11yr', 04:46:37 INFO - 'ts_paint', 04:46:37 INFO - 'tpaint', 04:46:37 INFO - 'sessionrestore', 04:46:37 INFO - 'sessionrestore_no_auto_restore', 04:46:37 INFO - 'tabpaint']}, 04:46:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:46:37 INFO - 'ts_paint', 04:46:37 INFO - 'tpaint', 04:46:37 INFO - 'sessionrestore', 04:46:37 INFO - 'sessionrestore_no_auto_restore', 04:46:37 INFO - 'tabpaint']}, 04:46:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:46:37 INFO - 'ts_paint', 04:46:37 INFO - 'tpaint', 04:46:37 INFO - 'sessionrestore', 04:46:37 INFO - 'sessionrestore_no_auto_restore', 04:46:37 INFO - 'tabpaint']}, 04:46:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:46:37 INFO - 'ts_paint', 04:46:37 INFO - 'tpaint', 04:46:37 INFO - 'sessionrestore', 04:46:37 INFO - 'sessionrestore_no_auto_restore', 04:46:37 INFO - 'tabpaint']}, 04:46:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:46:37 INFO - 'tests': ['a11yr', 04:46:37 INFO - 'ts_paint', 04:46:37 INFO - 'tpaint', 04:46:37 INFO - 'sessionrestore', 04:46:37 INFO - 'sessionrestore_no_auto_restore', 04:46:37 INFO - 'tabpaint']}, 04:46:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:46:37 INFO - 'tests': ['a11yr', 04:46:37 INFO - 'ts_paint', 04:46:37 INFO - 'tpaint', 04:46:37 INFO - 'sessionrestore', 04:46:37 INFO - 'sessionrestore_no_auto_restore', 04:46:37 INFO - 'tabpaint']}, 04:46:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:46:37 INFO - 'tests': ['tsvgx', 04:46:37 INFO - 'tsvgr_opacity', 04:46:37 INFO - 'tart', 04:46:37 INFO - 'tscrollx', 04:46:37 INFO - 'cart']}, 04:46:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:46:37 INFO - 'tsvgr_opacity', 04:46:37 INFO - 'tart', 04:46:37 INFO - 'tscrollx', 04:46:37 INFO - 'cart']}, 04:46:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:37 INFO - 'talos_options': ['--disable-e10s'], 04:46:37 INFO - 'tests': ['tp5o']}, 04:46:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:37 INFO - 'tests': ['tp5o']}, 04:46:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:37 INFO - 'talos_options': ['--disable-e10s', 04:46:37 INFO - '--xperf_path', 04:46:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:37 INFO - 'tests': ['tp5n']}, 04:46:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:37 INFO - 'talos_options': ['--xperf_path', 04:46:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:37 INFO - 'tests': ['tp5n']}}, 04:46:37 INFO - 'talos.zip': {'path': '', 04:46:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:46:37 INFO - Running post-action listener: _resource_record_post_action 04:46:37 INFO - ##### 04:46:37 INFO - ##### Finished populate-webroot step (success) 04:46:37 INFO - ##### 04:46:37 INFO - ##### 04:46:37 INFO - ##### Running create-virtualenv step. 04:46:37 INFO - ##### 04:46:37 INFO - Running pre-action listener: _resource_record_pre_action 04:46:37 INFO - Running main action method: create_virtualenv 04:46:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:46:37 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 04:46:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:46:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:46:37 INFO - Using real prefix '/usr' 04:46:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:46:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:46:40 INFO - Installing pip.................done. 04:46:40 INFO - Return code: 0 04:46:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:40 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 0x7fee692baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e01c0>, '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 0x12e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', '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 04:46:40 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 04:46:40 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 04:46:40 INFO - Using env: {'DISPLAY': ':0', 04:46:40 INFO - 'HOME': '/home/cltbld', 04:46:40 INFO - 'LANG': 'en_US.UTF-8', 04:46:40 INFO - 'LANGUAGE': 'en_US:en', 04:46:40 INFO - 'LOGNAME': 'cltbld', 04:46:40 INFO - 'MAIL': '/var/mail/cltbld', 04:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:40 INFO - 'MOZ_NO_REMOTE': '1', 04:46:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:40 INFO - 'NO_EM_RESTART': '1', 04:46:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:40 INFO - 'PWD': '/builds/slave/test', 04:46:40 INFO - 'SHELL': '/bin/bash', 04:46:40 INFO - 'SHLVL': '1', 04:46:40 INFO - 'TERM': 'linux', 04:46:40 INFO - 'TMOUT': '86400', 04:46:40 INFO - 'USER': 'cltbld', 04:46:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', 04:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:40 INFO - '_': '/tools/buildbot/bin/python'} 04:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:40 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 04:46:40 INFO - Cleaning up... 04:46:40 INFO - Return code: 0 04:46:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:40 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 0x7fee692baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e01c0>, '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 0x12e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', '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 04:46:40 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 04:46:40 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 04:46:40 INFO - Using env: {'DISPLAY': ':0', 04:46:40 INFO - 'HOME': '/home/cltbld', 04:46:40 INFO - 'LANG': 'en_US.UTF-8', 04:46:40 INFO - 'LANGUAGE': 'en_US:en', 04:46:40 INFO - 'LOGNAME': 'cltbld', 04:46:40 INFO - 'MAIL': '/var/mail/cltbld', 04:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:40 INFO - 'MOZ_NO_REMOTE': '1', 04:46:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:40 INFO - 'NO_EM_RESTART': '1', 04:46:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:40 INFO - 'PWD': '/builds/slave/test', 04:46:40 INFO - 'SHELL': '/bin/bash', 04:46:40 INFO - 'SHLVL': '1', 04:46:40 INFO - 'TERM': 'linux', 04:46:40 INFO - 'TMOUT': '86400', 04:46:40 INFO - 'USER': 'cltbld', 04:46:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', 04:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:40 INFO - '_': '/tools/buildbot/bin/python'} 04:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:40 INFO - Downloading/unpacking psutil>=3.1.1 04:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:46:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:42 INFO - Installing collected packages: psutil 04:46:42 INFO - Running setup.py install for psutil 04:46:42 INFO - building 'psutil._psutil_linux' extension 04:46:42 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 04:46:42 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 04:46:42 INFO - building 'psutil._psutil_posix' extension 04:46:42 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 04:46:43 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 04:46:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:43 INFO - Successfully installed psutil 04:46:43 INFO - Cleaning up... 04:46:43 INFO - Return code: 0 04:46:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:46:43 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')]} 04:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:43 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')]} 04:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:43 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 0x7fee692baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e01c0>, '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 0x12e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', '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 04:46:43 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 04:46:43 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 04:46:43 INFO - Using env: {'DISPLAY': ':0', 04:46:43 INFO - 'HOME': '/home/cltbld', 04:46:43 INFO - 'LANG': 'en_US.UTF-8', 04:46:43 INFO - 'LANGUAGE': 'en_US:en', 04:46:43 INFO - 'LOGNAME': 'cltbld', 04:46:43 INFO - 'MAIL': '/var/mail/cltbld', 04:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:43 INFO - 'MOZ_NO_REMOTE': '1', 04:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:43 INFO - 'NO_EM_RESTART': '1', 04:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:43 INFO - 'PWD': '/builds/slave/test', 04:46:43 INFO - 'SHELL': '/bin/bash', 04:46:43 INFO - 'SHLVL': '1', 04:46:43 INFO - 'TERM': 'linux', 04:46:43 INFO - 'TMOUT': '86400', 04:46:43 INFO - 'USER': 'cltbld', 04:46:43 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', 04:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:43 INFO - '_': '/tools/buildbot/bin/python'} 04:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:46:45 INFO - Installing collected packages: mozsystemmonitor 04:46:45 INFO - Running setup.py install for mozsystemmonitor 04:46:45 INFO - Successfully installed mozsystemmonitor 04:46:45 INFO - Cleaning up... 04:46:45 INFO - Return code: 0 04:46:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee692baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e01c0>, '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 0x12e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', '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 04:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:46:45 INFO - Using env: {'DISPLAY': ':0', 04:46:45 INFO - 'HOME': '/home/cltbld', 04:46:45 INFO - 'LANG': 'en_US.UTF-8', 04:46:45 INFO - 'LANGUAGE': 'en_US:en', 04:46:45 INFO - 'LOGNAME': 'cltbld', 04:46:45 INFO - 'MAIL': '/var/mail/cltbld', 04:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:45 INFO - 'MOZ_NO_REMOTE': '1', 04:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:45 INFO - 'NO_EM_RESTART': '1', 04:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:45 INFO - 'PWD': '/builds/slave/test', 04:46:45 INFO - 'SHELL': '/bin/bash', 04:46:45 INFO - 'SHLVL': '1', 04:46:45 INFO - 'TERM': 'linux', 04:46:45 INFO - 'TMOUT': '86400', 04:46:45 INFO - 'USER': 'cltbld', 04:46:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', 04:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:45 INFO - '_': '/tools/buildbot/bin/python'} 04:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:45 INFO - Downloading/unpacking jsonschema==2.5.1 04:46:45 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 04:46:45 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 04:46:45 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 04:46:45 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 04:46:45 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 04:46:45 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 04:46:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:46:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:47 INFO - Downloading functools32-3.2.3-2.tar.gz 04:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:46:47 INFO - warning: no files found matching '*.txt' 04:46:47 INFO - no previously-included directories found matching 'build' 04:46:47 INFO - no previously-included directories found matching 'dist' 04:46:47 INFO - no previously-included directories found matching '.git*' 04:46:47 INFO - Installing collected packages: jsonschema, functools32 04:46:47 INFO - Running setup.py install for functools32 04:46:48 INFO - warning: no files found matching '*.txt' 04:46:48 INFO - no previously-included directories found matching 'build' 04:46:48 INFO - no previously-included directories found matching 'dist' 04:46:48 INFO - no previously-included directories found matching '.git*' 04:46:48 INFO - Successfully installed jsonschema functools32 04:46:48 INFO - Cleaning up... 04:46:48 INFO - Return code: 0 04:46:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:48 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 0x7fee692baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e01c0>, '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 0x12e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', '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 04:46:48 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 04:46:48 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 04:46:48 INFO - Using env: {'DISPLAY': ':0', 04:46:48 INFO - 'HOME': '/home/cltbld', 04:46:48 INFO - 'LANG': 'en_US.UTF-8', 04:46:48 INFO - 'LANGUAGE': 'en_US:en', 04:46:48 INFO - 'LOGNAME': 'cltbld', 04:46:48 INFO - 'MAIL': '/var/mail/cltbld', 04:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:48 INFO - 'MOZ_NO_REMOTE': '1', 04:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:48 INFO - 'NO_EM_RESTART': '1', 04:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:48 INFO - 'PWD': '/builds/slave/test', 04:46:48 INFO - 'SHELL': '/bin/bash', 04:46:48 INFO - 'SHLVL': '1', 04:46:48 INFO - 'TERM': 'linux', 04:46:48 INFO - 'TMOUT': '86400', 04:46:48 INFO - 'USER': 'cltbld', 04:46:48 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', 04:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:48 INFO - '_': '/tools/buildbot/bin/python'} 04:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:48 INFO - Downloading/unpacking blobuploader==1.2.4 04:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:50 INFO - Downloading blobuploader-1.2.4.tar.gz 04:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:46:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:46:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:50 INFO - Downloading docopt-0.6.1.tar.gz 04:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:46:51 INFO - Installing collected packages: blobuploader, requests, docopt 04:46:51 INFO - Running setup.py install for blobuploader 04:46:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:46:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:46:51 INFO - Running setup.py install for requests 04:46:51 INFO - Running setup.py install for docopt 04:46:51 INFO - Successfully installed blobuploader requests docopt 04:46:51 INFO - Cleaning up... 04:46:51 INFO - Return code: 0 04:46:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:51 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 0x7fee692baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e01c0>, '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 0x12e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', '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 04:46:51 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 04:46:51 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 04:46:51 INFO - Using env: {'DISPLAY': ':0', 04:46:51 INFO - 'HOME': '/home/cltbld', 04:46:51 INFO - 'LANG': 'en_US.UTF-8', 04:46:51 INFO - 'LANGUAGE': 'en_US:en', 04:46:51 INFO - 'LOGNAME': 'cltbld', 04:46:51 INFO - 'MAIL': '/var/mail/cltbld', 04:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:51 INFO - 'MOZ_NO_REMOTE': '1', 04:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:51 INFO - 'NO_EM_RESTART': '1', 04:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:51 INFO - 'PWD': '/builds/slave/test', 04:46:51 INFO - 'SHELL': '/bin/bash', 04:46:51 INFO - 'SHLVL': '1', 04:46:51 INFO - 'TERM': 'linux', 04:46:51 INFO - 'TMOUT': '86400', 04:46:51 INFO - 'USER': 'cltbld', 04:46:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', 04:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:51 INFO - '_': '/tools/buildbot/bin/python'} 04:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:51 INFO - Running setup.py (path:/tmp/pip-MidJYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:51 INFO - Running setup.py (path:/tmp/pip-G6xxMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:51 INFO - Running setup.py (path:/tmp/pip-KQkKQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:52 INFO - Running setup.py (path:/tmp/pip-eHiiw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:52 INFO - Running setup.py (path:/tmp/pip-BGk71F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:52 INFO - Running setup.py (path:/tmp/pip-aF_bZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:52 INFO - Running setup.py (path:/tmp/pip-pZa09x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:52 INFO - Running setup.py (path:/tmp/pip-hlHWgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:52 INFO - Running setup.py (path:/tmp/pip-5FYJkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:52 INFO - Running setup.py (path:/tmp/pip-q_bmWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:52 INFO - Running setup.py (path:/tmp/pip-6Dryfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:52 INFO - Running setup.py (path:/tmp/pip-5MbARJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:52 INFO - Running setup.py (path:/tmp/pip-1ak60E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:52 INFO - Running setup.py (path:/tmp/pip-AUInMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:52 INFO - Running setup.py (path:/tmp/pip-mo_of7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:52 INFO - Running setup.py (path:/tmp/pip-S_NSHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:53 INFO - Running setup.py (path:/tmp/pip-bGjcwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:46:53 INFO - Running setup.py install for manifestparser 04:46:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Running setup.py install for mozcrash 04:46:53 INFO - Running setup.py install for mozdebug 04:46:53 INFO - Running setup.py install for mozdevice 04:46:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Running setup.py install for mozfile 04:46:53 INFO - Running setup.py install for mozhttpd 04:46:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Running setup.py install for mozinfo 04:46:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Running setup.py install for mozInstall 04:46:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Running setup.py install for mozleak 04:46:53 INFO - Running setup.py install for mozlog 04:46:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:46:54 INFO - Running setup.py install for moznetwork 04:46:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:46:54 INFO - Running setup.py install for mozprocess 04:46:54 INFO - Running setup.py install for mozprofile 04:46:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:46:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:46:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:46:54 INFO - Running setup.py install for mozrunner 04:46:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:46:54 INFO - Running setup.py install for mozscreenshot 04:46:54 INFO - Running setup.py install for moztest 04:46:54 INFO - Running setup.py install for mozversion 04:46:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:46:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:46:54 INFO - Cleaning up... 04:46:54 INFO - Return code: 0 04:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:54 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 0x7fee692baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e01c0>, '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 0x12e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', '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 04:46:54 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 04:46:54 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 04:46:54 INFO - Using env: {'DISPLAY': ':0', 04:46:54 INFO - 'HOME': '/home/cltbld', 04:46:54 INFO - 'LANG': 'en_US.UTF-8', 04:46:54 INFO - 'LANGUAGE': 'en_US:en', 04:46:54 INFO - 'LOGNAME': 'cltbld', 04:46:54 INFO - 'MAIL': '/var/mail/cltbld', 04:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:54 INFO - 'MOZ_NO_REMOTE': '1', 04:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:54 INFO - 'NO_EM_RESTART': '1', 04:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:54 INFO - 'PWD': '/builds/slave/test', 04:46:54 INFO - 'SHELL': '/bin/bash', 04:46:54 INFO - 'SHLVL': '1', 04:46:54 INFO - 'TERM': 'linux', 04:46:54 INFO - 'TMOUT': '86400', 04:46:54 INFO - 'USER': 'cltbld', 04:46:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', 04:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:54 INFO - '_': '/tools/buildbot/bin/python'} 04:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:55 INFO - Running setup.py (path:/tmp/pip-VtAXzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:55 INFO - Running setup.py (path:/tmp/pip-41821P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:55 INFO - Running setup.py (path:/tmp/pip-V2I1_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:55 INFO - Running setup.py (path:/tmp/pip-AKRXv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:55 INFO - Running setup.py (path:/tmp/pip-fkYah2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:55 INFO - Running setup.py (path:/tmp/pip-E3HOwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:55 INFO - Running setup.py (path:/tmp/pip-FujRKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:55 INFO - Running setup.py (path:/tmp/pip-KKvbyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:55 INFO - Running setup.py (path:/tmp/pip-mXHvOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:55 INFO - Running setup.py (path:/tmp/pip-KY6dp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:55 INFO - Running setup.py (path:/tmp/pip-KDeLwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:55 INFO - Running setup.py (path:/tmp/pip-lNKGFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:55 INFO - Running setup.py (path:/tmp/pip-7W_xHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:56 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)) 04:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:56 INFO - Running setup.py (path:/tmp/pip-t07vEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:56 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)) 04:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:56 INFO - Running setup.py (path:/tmp/pip-8onnkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:56 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)) 04:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:56 INFO - Running setup.py (path:/tmp/pip-ip4Xev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:56 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)) 04:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:56 INFO - Running setup.py (path:/tmp/pip-E1_Ebv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:56 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)) 04:46:56 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)) 04:46:56 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)) 04:46:56 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)) 04:46:56 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)) 04:46:56 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)) 04:46:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46: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 04:46: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 04:46: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 04:46: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 04:46: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 04:46: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 04:46:58 INFO - Downloading blessings-1.6.tar.gz 04:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:46:58 INFO - Installing collected packages: blessings 04:46:58 INFO - Running setup.py install for blessings 04:46:58 INFO - Successfully installed blessings 04:46:58 INFO - Cleaning up... 04:46:58 INFO - Return code: 0 04:46:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:46:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:58 INFO - Reading from file tmpfile_stdout 04:46:58 INFO - Current package versions: 04:46:58 INFO - argparse == 1.2.1 04:46:58 INFO - blessings == 1.6 04:46:58 INFO - blobuploader == 1.2.4 04:46:58 INFO - docopt == 0.6.1 04:46:58 INFO - functools32 == 3.2.3-2 04:46:58 INFO - jsonschema == 2.5.1 04:46:58 INFO - manifestparser == 1.1 04:46:58 INFO - mozInstall == 1.12 04:46:58 INFO - mozcrash == 0.17 04:46:58 INFO - mozdebug == 0.1 04:46:58 INFO - mozdevice == 0.48 04:46:58 INFO - mozfile == 1.2 04:46:58 INFO - mozhttpd == 0.7 04:46:58 INFO - mozinfo == 0.9 04:46:58 INFO - mozleak == 0.1 04:46:58 INFO - mozlog == 3.2 04:46:58 INFO - moznetwork == 0.27 04:46:58 INFO - mozprocess == 0.22 04:46:58 INFO - mozprofile == 0.28 04:46:58 INFO - mozrunner == 6.11 04:46:58 INFO - mozscreenshot == 0.1 04:46:58 INFO - mozsystemmonitor == 0.3 04:46:58 INFO - moztest == 0.7 04:46:58 INFO - mozversion == 1.4 04:46:58 INFO - psutil == 3.1.1 04:46:58 INFO - requests == 1.2.3 04:46:58 INFO - wsgiref == 0.1.2 04:46:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:58 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 0x7fee692baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e01c0>, '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 0x12e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', '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 04:46:58 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 04:46:58 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 04:46:58 INFO - Using env: {'DISPLAY': ':0', 04:46:58 INFO - 'HOME': '/home/cltbld', 04:46:58 INFO - 'LANG': 'en_US.UTF-8', 04:46:58 INFO - 'LANGUAGE': 'en_US:en', 04:46:58 INFO - 'LOGNAME': 'cltbld', 04:46:58 INFO - 'MAIL': '/var/mail/cltbld', 04:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:58 INFO - 'MOZ_NO_REMOTE': '1', 04:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:58 INFO - 'NO_EM_RESTART': '1', 04:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:58 INFO - 'PWD': '/builds/slave/test', 04:46:58 INFO - 'SHELL': '/bin/bash', 04:46:58 INFO - 'SHLVL': '1', 04:46:58 INFO - 'TERM': 'linux', 04:46:58 INFO - 'TMOUT': '86400', 04:46:58 INFO - 'USER': 'cltbld', 04:46:58 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', 04:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:58 INFO - '_': '/tools/buildbot/bin/python'} 04:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:58 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)) 04:46:58 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)) 04:46:58 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)) 04:46:58 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)) 04:46:58 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)) 04:46:58 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)) 04:46:58 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)) 04:46:58 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)) 04:46:58 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)) 04:46:58 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)) 04:46:58 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)) 04:46:58 INFO - Cleaning up... 04:46:58 INFO - Return code: 0 04:46:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee692baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e01c0>, '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 0x12e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', '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 04:46: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', 'jsonschema'] in /builds/slave/test/build 04:46: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 jsonschema 04:46:58 INFO - Using env: {'DISPLAY': ':0', 04:46:58 INFO - 'HOME': '/home/cltbld', 04:46:58 INFO - 'LANG': 'en_US.UTF-8', 04:46:58 INFO - 'LANGUAGE': 'en_US:en', 04:46:58 INFO - 'LOGNAME': 'cltbld', 04:46:58 INFO - 'MAIL': '/var/mail/cltbld', 04:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:58 INFO - 'MOZ_NO_REMOTE': '1', 04:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:58 INFO - 'NO_EM_RESTART': '1', 04:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:58 INFO - 'PWD': '/builds/slave/test', 04:46:58 INFO - 'SHELL': '/bin/bash', 04:46:58 INFO - 'SHLVL': '1', 04:46:58 INFO - 'TERM': 'linux', 04:46:58 INFO - 'TMOUT': '86400', 04:46:58 INFO - 'USER': 'cltbld', 04:46:58 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', 04:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:58 INFO - '_': '/tools/buildbot/bin/python'} 04:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:46:59 INFO - Cleaning up... 04:46:59 INFO - Return code: 0 04:46:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:59 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 0x7fee692baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e01c0>, '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 0x12e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', '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 04:46:59 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 04:46:59 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 04:46:59 INFO - Using env: {'DISPLAY': ':0', 04:46:59 INFO - 'HOME': '/home/cltbld', 04:46:59 INFO - 'LANG': 'en_US.UTF-8', 04:46:59 INFO - 'LANGUAGE': 'en_US:en', 04:46:59 INFO - 'LOGNAME': 'cltbld', 04:46:59 INFO - 'MAIL': '/var/mail/cltbld', 04:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:59 INFO - 'MOZ_NO_REMOTE': '1', 04:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:59 INFO - 'NO_EM_RESTART': '1', 04:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:59 INFO - 'PWD': '/builds/slave/test', 04:46:59 INFO - 'SHELL': '/bin/bash', 04:46:59 INFO - 'SHLVL': '1', 04:46:59 INFO - 'TERM': 'linux', 04:46:59 INFO - 'TMOUT': '86400', 04:46:59 INFO - 'USER': 'cltbld', 04:46:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', 04:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:59 INFO - '_': '/tools/buildbot/bin/python'} 04:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:59 INFO - Downloading/unpacking flake8 04:46:59 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 04:46:59 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 04:46:59 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 04:46:59 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 04:46:59 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 04:46:59 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 04:47:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:47:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:47:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:47:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:47:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:47:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:47:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:47:01 INFO - no previously-included directories found matching 'docs/_build' 04:47:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:47:01 INFO - Running setup.py install for pep8 04:47:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:47:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:47:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:47:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:47:02 INFO - no previously-included directories found matching 'docs/_build' 04:47:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:47:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:47:02 INFO - Cleaning up... 04:47:02 INFO - Return code: 0 04:47:02 INFO - Running post-action listener: _resource_record_post_action 04:47:02 INFO - Running post-action listener: _start_resource_monitoring 04:47:02 INFO - Starting resource monitoring. 04:47:02 INFO - ##### 04:47:02 INFO - ##### Finished create-virtualenv step (success) 04:47:02 INFO - ##### 04:47:02 INFO - ##### 04:47:02 INFO - ##### Running install step. 04:47:02 INFO - ##### 04:47:02 INFO - Running pre-action listener: _resource_record_pre_action 04:47:02 INFO - Running main action method: install 04:47:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:02 INFO - Reading from file tmpfile_stdout 04:47:02 INFO - Detecting whether we're running mozinstall >=1.0... 04:47:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:47:02 INFO - Reading from file tmpfile_stdout 04:47:02 INFO - Output received: 04:47:02 INFO - Usage: mozinstall [options] installer 04:47:02 INFO - Options: 04:47:02 INFO - -h, --help show this help message and exit 04:47:02 INFO - -d DEST, --destination=DEST 04:47:02 INFO - Directory to install application into. [default: 04:47:02 INFO - "/builds/slave/test"] 04:47:02 INFO - --app=APP Application being installed. [default: firefox] 04:47:02 INFO - mkdir: /builds/slave/test/build/application 04:47:02 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'] 04:47:02 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 04:47:18 INFO - Reading from file tmpfile_stdout 04:47:18 INFO - Output received: 04:47:18 INFO - /builds/slave/test/build/application/firefox/firefox 04:47:18 INFO - Running post-action listener: _resource_record_post_action 04:47:18 INFO - ##### 04:47:18 INFO - ##### Finished install step (success) 04:47:18 INFO - ##### 04:47:18 INFO - ##### 04:47:18 INFO - ##### Running run-tests step. 04:47:18 INFO - ##### 04:47:18 INFO - Running pre-action listener: _resource_record_pre_action 04:47:18 INFO - Running main action method: run_tests 04:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:18 INFO - Python 2.7.3 04:47:18 INFO - Return code: 0 04:47:18 INFO - grabbing minidump binary from tooltool 04:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:18 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 0x12e01c0>, '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 0x12e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:18 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 04:47:18 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 04:47:18 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 04:47:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:18 INFO - Return code: 0 04:47:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:47:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:47:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:47:19 INFO - Return code: 0 04:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 04:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 04:47:19 INFO - Using env: {'DISPLAY': ':0', 04:47:19 INFO - 'HOME': '/home/cltbld', 04:47:19 INFO - 'LANG': 'en_US.UTF-8', 04:47:19 INFO - 'LANGUAGE': 'en_US:en', 04:47:19 INFO - 'LOGNAME': 'cltbld', 04:47:19 INFO - 'MAIL': '/var/mail/cltbld', 04:47:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:19 INFO - 'MOZ_NO_REMOTE': '1', 04:47:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:19 INFO - 'NO_EM_RESTART': '1', 04:47:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:19 INFO - 'PWD': '/builds/slave/test', 04:47:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:19 INFO - 'SHELL': '/bin/bash', 04:47:19 INFO - 'SHLVL': '1', 04:47:19 INFO - 'TERM': 'linux', 04:47:19 INFO - 'TMOUT': '86400', 04:47:19 INFO - 'USER': 'cltbld', 04:47:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315', 04:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:19 INFO - '_': '/tools/buildbot/bin/python'} 04:47:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 04:47:19 INFO - mozversion application_buildid: 20160622041004 04:47:19 INFO - mozversion application_changeset: 93a9cda876d8c452e4b851c7f8ef275006c220af 04:47:19 INFO - mozversion application_display_name: Nightly 04:47:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:19 INFO - mozversion application_name: Firefox 04:47:19 INFO - mozversion application_remotingname: firefox 04:47:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:47:19 INFO - mozversion application_vendor: Mozilla 04:47:19 INFO - mozversion application_version: 50.0a1 04:47:19 INFO - mozversion platform_buildid: 20160622041004 04:47:19 INFO - mozversion platform_changeset: 93a9cda876d8c452e4b851c7f8ef275006c220af 04:47:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:47:19 INFO - mozversion platform_version: 50.0a1 04:47:19 INFO - using testdate: 1466596039 04:47:19 INFO - actual date: 1466596039 04:47:19 INFO - starting webserver on 'localhost:54084' 04:47:19 INFO - SUITE-START | Running 2 tests 04:47:19 INFO - TEST-START | dromaeo_css 04:47:19 INFO - operating with platform_type : linux_ 04:47:19 INFO - Initialising browser for dromaeo_css test... 04:47:19 INFO - TEST-INFO | started process 13562 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprYeN_A/profile http://localhost:54084/getInfo.html) 04:47:25 INFO - PROCESS | 13562 | __metrics Screen width/height:1600/1200 04:47:25 INFO - PROCESS | 13562 | colorDepth:24 04:47:25 INFO - PROCESS | 13562 | Browser inner width/height: 1024/697 04:47:25 INFO - PROCESS | 13562 | __metrics 04:47:25 ERROR - PROCESS | 13562 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 04:47:26 INFO - TEST-INFO | 13562: exit 0 04:47:26 INFO - Browser initialized. 04:47:26 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:26 INFO - TEST-INFO | started process 13682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprYeN_A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:38 INFO - PROCESS | 13682 | RSS: Main: 186277888 04:47:38 INFO - PROCESS | 13682 | 04:48:28 INFO - PROCESS | 13682 | 1466596108383 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] 04:50:40 INFO - PROCESS | 13682 | Cycle 1(1): loaded http://localhost:54084/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54084/tests/dromaeo/cssquery-ext.html) 04:50:41 INFO - PROCESS | 13682 | RSS: Main: 189599744 04:50:41 INFO - PROCESS | 13682 | 04:53:43 INFO - PROCESS | 13682 | Cycle 1(1): loaded http://localhost:54084/tests/dromaeo/cssquery-ext.html (next: http://localhost:54084/tests/dromaeo/cssquery-jquery.html) 04:53:44 INFO - PROCESS | 13682 | RSS: Main: 188608512 04:53:44 INFO - PROCESS | 13682 | 04:56:46 INFO - PROCESS | 13682 | Cycle 1(1): loaded http://localhost:54084/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54084/tests/dromaeo/cssquery-mootools.html) 04:56:46 INFO - PROCESS | 13682 | RSS: Main: 190103552 04:56:46 INFO - PROCESS | 13682 | 04:59:48 INFO - PROCESS | 13682 | Cycle 1(1): loaded http://localhost:54084/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54084/tests/dromaeo/cssquery-prototype.html) 04:59:49 INFO - PROCESS | 13682 | RSS: Main: 187629568 04:59:49 INFO - PROCESS | 13682 | 05:02:52 INFO - PROCESS | 13682 | Cycle 1(1): loaded http://localhost:54084/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54084/tests/dromaeo/cssquery-yui.html) 05:02:52 INFO - PROCESS | 13682 | RSS: Main: 189714432 05:02:52 INFO - PROCESS | 13682 | 05:05:55 INFO - PROCESS | 13682 | Cycle 1(1): loaded http://localhost:54084/tests/dromaeo/cssquery-yui.html (next: http://localhost:54084/tests/dromaeo/cssquery-dojo.html) 05:05:55 INFO - PROCESS | 13682 | RSS: Main: 190377984 05:05:55 INFO - PROCESS | 13682 | 05:05:55 INFO - PROCESS | 13682 | __start_tp_report 05:05:55 INFO - PROCESS | 13682 | _x_x_mozilla_page_load 05:05:55 INFO - PROCESS | 13682 | _x_x_mozilla_page_load_details 05:05:55 INFO - PROCESS | 13682 | |i|pagename|runs| 05:05:55 INFO - PROCESS | 13682 | |0;dojo.html;2637.222019504246;2673.1713168917636;2696.366353906833;2710.498557766812;2712.4575084983007;4831.565159135677;4838.177509823334;4874.951250487494;4955.256711493278;5021.57316628087;4795.0889331027165;4880.170371036923;4906.705597664142;4914.606831453484;4946.629002824785;4467.039586488904;4500.842470513533;4589.977050114761;4601.447826260854;4609.216433206346;460.79312042636514;4403.537628549005;4470.217711900421;4503.414556107701;4503.594676479116;4499.122671079157;4539;4541.500434952152;4547.386102876102;4583.266677331644;4517.277235642281;4535.523770004168;4535.750533720644;4539.2737162054245;4578.038611891507;4370.519242883281;4444.955550444486;4461.420015397977;4464.709793863389;4480.574345437179;4456.5766252205985;4904.362432883738;4934.925976110361;4942.431620363668;4944.110060189165;5188.299579556787;5293.338332708411;5293.57651387888;5300.522952934254;5359.866003349908;5248.71132087735;5287.180487024518;5296.814611488579;5320.494553017457;5375.596830237748;4927.876803079916;4927.90144197114;4931.964287499593;4938.9012219755405;4945.406551213878;5324.121519949165;5403.864903377368;5423.810166644149;5425.267588875451;5436.293281873332;5232.136697444955;5241.344831896013;5241.502057304626;5247.7113758743635;5295.814646487354;5334.279872217201;5340.732963351817;5347.278117454094;5347.705876176769;5398.379186393537;5033.748312584356;5187.247849061865;5230.320058392384;5241.895162096736;5253.737313134328;5219.765110570033;5221.895562088737;5225.1117310056625;5246.921296180561;5266.552343050807;4492.775361231926;4501.864944051684;4515.119551687455;4520.276755719069;4546.477155127202;3864.942025869614;3876.0697432616535;3897.0452239201577;3898.317794385971;3917.882463526099;4377.9124417511475;4423.181711383404;4426.911461770746;4491.640668746492;4498.707584007029;5218.295530103387;5273.6572122811895;5281;5340.519353258225;5359.062164121263;4522.4346956630425;4545.250033744462;4552.157850797546;4554;4603;4584.426946631605;4587.105514424722;4604.769761511911;4648.558386953234;4676.812927482931;4936.062148191832;4971.850844474671;4973.850784476472;4974.527419895104;4977.776000080077;5322.946770532245;5323.600729945347;5326.520613144836;5328.387235467971;5332;4749.216379297377;4867.537583929521;4887.3890763654545;4904.558589726942;4905.583025442877;5165.302684137593;5170.43125256229;5188.403333616531;5198.740062996911;5224.843254702213;5095.515925987025;5249.580033597226;5252.949410118068;5257;5274.287971123849;5017.899642007066;5037.093323201859;5063.26582645507;5093.796248150033;5099.26060721186;5062.038212739568;5074.873128171826;5076.238564215398;5089.821856235014;5122.334096567422;4862.246351815475;4945.208766597327;5002.07461619587;5003.324551185543;5008.373953255843;5064.18972964324;5085.872853178552;5094.465081166424;5129.8717532062;5163.8192663256605;5009.298698182184;5010.048090862724;5021.472745361684;5021.84934451967;5070.6957582545165 05:05:55 INFO - PROCESS | 13682 | |1;ext.html;549.9897873273186;585.1515302810919;586.8650210451597;598.8323269484546;605.6275390634759;38902;39895;39923.80800016;39986.600133998654;44774.77612611932;40879.59120408795;41277.79361103198;41477.926103694845;41511.169776604525;41523.58476415235;7792.96103519483;7807.609619519029;7895.684172633088;7936.642851071716;7945.284924356835;7708.460407771458;7822.882656760153;7836.882446763303;7846.72536461224;7856.057273127204;7877.566733829637;7898.8815167772245;7899.091604465502;7899.565523896184;7903.130655627876;7811.375089992787;7827.178146294671;7848.254415830515;7856.1751016143335;7865.134835168127;7815.882761758578;7880.921190788134;7894.131645518988;7903.130655627876;7918.524888506708;39283.803580982196;39288.41067383991;39513.60486395128;39560.40659390111;39718.20563588741;2962.2002059444044;3128;3355.798652080883;3358.596968363812;3635.363811333006;28822.279443013882;29571.70428295711;29781;29850.552241716392;30627.693723062708;3273;3300.9834950825334;3305.0910999475095;3309;3355.278615097766;243279;244258.99999999822;245480;247323;250489;53406;53947.46052539503;54003;54048.18927716009;54199.187012194845;33080.338393232;33727.32545349079;33799.32401351959;35646.10884727903;35724;15765.896387253011;15814.920925395529;15826.92086539583;15917.602059948362;15946.840531594535;11818.881811181778;11888.702782430508;11889.464974076014;11948.701282468008;12012.579559715543;18429.41988121664;18603.720944185847;18715.157817898227;18753.90623046876;18954.620907582048;6801.965990170018;6895.55178913369;7047.788566343018;7111.857762844714;7165.319294667102;873.8121303919688;875.5228400521604;895.0288936503836;911.1617312072909;1030.228684837784;27511.31221719433;28343.57484637732;29047.854760726063;29240.85379573131;29310.12069637914;932.3566738950238;956.3066776586919;993.4585650820176;996.2279233594022;996.7707427291764;14237.64405889861;14656.487022954145;14724.779128313085;14937.551873443814;15075.39698412073;357817;365095;365200;366360.35477516317;368901;44069;44900.77549612231;45036.77481612571;45228.51243181591;45258.321125183145;1208.4924331780674;1229.3730197599289;1247.108317552954;1257.5472829781454;1266.1580049267318;26515;27053.458930820878;27133.86433067822;27493.315042893326;27591.31021724473;42370;42673.359899602154;42912.78543607262;42954;42969.14061718811;283760;285433;286151;286153;286374.13625863474;25232.116875909254;25368.492630146924;25979.480410392065;26032.219033429028;26106.477870442104;42377;42491.7875410621;42841.571584285004;43231.35152972645;43340.13319733651;36275.63724362723;36658.63341366552;36664.81667591645;37084.81457592695;37663.81168094142;36338;36807;36932.26135477329;37375.5705879117;37624.62375376211;33428.1642958928;35789.5999880011;36676.44985325169;36757.26485470329;36887;32004.19989500281;32600.184995375304;33331.50002750009;33528.49707254345;33693.83153084219;25495.872520637276;26096.217113486626;26135.215943521725;26152.34619134537;26585.601215981387 05:05:55 INFO - PROCESS | 13682 | |2;jquery.html;367.5148803579275;369.4495202148797;372.13293027246516;373.3745975491052;386.27958856732204;15652.139132347716;16853.073080980543;16979.235934382952;17277;17368.392106276282;15248.69502609947;16868.662626747457;17428;17429.73855392167;17472.82527174728;4976.576990955773;5091.134507133777;5174.4049434314975;5175.689458632475;5184.507471790174;3715.1269451678836;5033.370828646419;5570;5834.474897259246;5893.528517718593;5847.8538036549;5876.030454974924;5895.616784908989;5923.674197919113;5959.582829201958;5847.356790753014;5884.911726324109;6016.939830601704;6023.156758053832;6029.78895738647;5218.269442278084;5290.232916227164;5297.390800058004;5307.469253074701;5363.570914326844;17737.467875963743;18836.811631883644;20915.5816883663;21468.677969830464;21545.56908861814;1937.9612407751765;1953.7850836407983;1992.1533348326902;2000.2998950367255;2357.552065107624;8618.870716939251;8981.461112333216;8995.730128096167;8999;9246.537673116318;1763.2858692229668;1823.4256209294163;1926.2198809482181;1943.1644392911044;1945.1441365799003;67453.66273168652;69689.30310696879;69883.65058174677;70125.64937175333;70889.64555177192;8847.778805529913;9637.951810240904;9955.452450115314;10204.132648724793;10341.327813692085;13869.514566990107;13896.374663140183;13934.094283871516;13969.58091257264;13989.090709103875;7484.700611975569;7537.773866784005;7639.923600763921;7768.84462310762;7778.572178530235;7121.465890058266;7122.821929451805;7140.107486564179;7253.455990800606;7290.5625662460425;3930.744501607386;4083.9183216335505;4158.334666453353;4300.333448315516;4404.559544045634;1655.7433597792362;1901.7622797150357;2953.4536110819568;3220.62962759281;3452.223249768782;746.5371469688719;792.2354927494995;856.9528675922884;880.225401646547;898.9505577193187;16325.428609998593;16393.016548959782;16749.83250167507;17036.2333694984;17226.397076102527;828.349745449819;838.5639467476877;849.3799526345803;863.96976105836;875.2254254984384;8891.422057566237;9335.486548239776;9689.370190937567;9762.560684769202;9806;362502;368087;368729;370179;374074;72389.27610723826;72723.63638181775;73852;75452.24547754561;75725;877.3332267476763;878.912108789116;886.078478382475;888.8311220868144;897.2373482539658;14994.400223990919;15272.923635381752;15318.080915145127;15441.845581544041;15710.842891570937;35505.644943550236;36025.81987090048;36469.27061458703;37058.814705927376;37512.624873750916;48856.2671559934;50382.49617503778;50434.24348634847;50653.74673126758;50836.237456438925;7518.360939320219;7524.887126693214;7525.8118547036765;7546.547207167588;7610.277023682741;10701.571937122428;11206.159538034517;11250;11729.178957473236;11824.76350473003;9220.216281616138;9662.3236373456;9942.701718948443;10003.899961000297;10152.695419137437;10145.18838492904;10164.79670406573;10407.895921040996;10424.478776061318;10426.791464170827;9789;9987.250956178461;10210.336328138646;10417.583296668352;10451.68644940653;7423;7647.88528172089;7654.73208437702;7688.846672999095;7923.6830526778285;7535.284148005931;9918;10276.845847312446;10280.640177593748;10414.323069000491 05:05:55 INFO - PROCESS | 13682 | |3;mootools.html;1365.4674676876018;1402.8036074949507;1471.8822494200465;1653.3469279634537;1653.743669731192;6869.175698916125;7561.357284630813;7573;8093.595320233987;8094.676212951482;7673.117591476982;7849.0973538043145;7903.3282171015535;7904.881426778588;7924.128345881948;2200.8239340852733;2249.055396733376;2262.1064679451606;2265.920692775753;2270.330252575486;2182.34529641107;2207;2231.564844855254;2240.955180896381;2241.9551608967813;2217.3347995601334;2224.5439684864646;2225.121077174515;2228.6211344071467;2235.105957616958;2156.579467003935;2166.469215042317;2175.0321107107343;2175.1408193763455;2190.1020581561643;2097.8216851567636;2124.4370241885913;2137.016972192793;2137.1985505435464;2145.013293884815;7817.609119544;7829.960850195713;7944.364450843918;7945.761627151194;7985.321247693953;4596.655250856199;4705.905881882378;4711.599514041311;4714.434267887841;4738.786754596052;2911.69427210142;3015.2461884528866;3037.4532584134845;3065;3071.43178511976;999.3853779925366;1008.5713571731984;1009.9141572966307;1015.3907655406771;1037.0303765978833;10639.734006649818;10653.467326633638;10661.09380702649;10675.83986240207;10694.144468442506;4130.297849365615;4246.235677578065;4306.82772689089;4314.9784251078545;4329.956700433018;8985;9005.459672419545;9006.144416280444;9045.954770226239;9067.863982040275;4637.466691330473;4645.187092258909;4650.953490465052;4652.511486293958;4658.464276608233;3798.1833905710405;4090.8568200112854;4125.91748165035;4190.1200747843295;4245.363195520635;3647.6170002149925;3657.7805331680183;3684.244729830378;3741.6258374162367;3770.189409276964;1186.792311345511;1225.9387030648431;1227.1593958138703;1232.975340493203;1245.2839617220134;837.8198687282263;861.143162553251;866.9436486628349;887.5473508510706;910.01263628962;5408.783648654088;5639.154126881001;5674.4892959633835;5693.402192769782;5720.08478643415;798.2137594469443;878.8813510176044;910.3172620534599;941.2422999485343;965.8937516873139;3546.361654902091;3685.3734865073;3703.333399988028;3707.332680117551;3759.2669429460993;9335.346525743269;9448.716538503855;9679.661211857692;9706.563204655808;9773.46245956465;9626.518674066268;9631.855522167172;9645.951770241103;9655.420674759536;9688.951555242178;7120.145582530026;7235.710571577183;7283.927160728324;7408.814779630552;7435.293647103516;5418.512333889968;5447.400785913625;5459.972700136474;5585.329760428612;5630.268065151504;8841.955790221007;9037.548122593975;9109.863352049591;9159.862602061108;9186.31102667316;8964.462132272085;9026.232770214343;9300.813983720423;9312.161905428544;9317.72046838596;6200.627962322275;6674.232463266787;6937.653117344214;6960.060391847036;7100.289971002859;7647.311741943252;7660.5403675779635;7716.807079822825;7718.112417071884;7791.922080779346;6584.209894812653;6837.042814006142;6868.416184624363;6949.583025018515;6951.443884489127;6686.598804071771;6720.092787473628;6777.559458635173;6785.796426107225;6911.3779759821855;6155.322914479493;6161.476274516537;6230.127782110599;6255.468285195628;6271.3415091414745;4713.08094921487;4757.452892917358;4766.713997160182;4805.327254184347;4818.277258411266;4620.768961551842;4636.907261854676;4668.719876807267;4707.505711900338;4748.9050218994735 05:05:55 INFO - PROCESS | 13682 | |4;prototype.html;298.874472721457;304.62531086763295;306.4682775384707;306.63663558682964;314.5486227263876;5154.149565321723;5159.871003224912;5160.20016897381;5160.587153027758;5172.715500647463;5039.1433456312425;5065.416637514875;5078.060558796626;5095.668781529198;5101.821436249732;3788.4317352397084;3810.618938106181;3945.112349721304;3954.1893911748166;3965.136385898623;3915.2169566086754;3978.9204215915665;3980.4825372701653;3983.506185180557;3987.1427643056736;3949.486566746333;3962.6433620974108;3968.246033253687;3985.342418500944;3987.501562304712;3801.6388443097862;3959.5842436544326;3970.166265084336;3979.462772525701;3982.6017398260087;3502.614712381636;3510.7191424685966;3536.522569453117;3536.982315088434;3542.326957877995;4979.875503112415;5028.321176641143;5035.295058691786;5036.697798132123;5043.546080852704;4386.1447017831215;4573.977130114361;4578.885527861797;4583.152116858392;4586.770661466913;5253.474652534716;5262.815996322208;5280.920786188171;5301.787928482856;5307.416184219733;3814.4850445189822;3832.5017747692623;3834.118152824838;3849.6727778138893;3858.151206734542;5338.41277459483;5556.888382414697;5590.385057643656;5601.831945041656;5641.210230567724;3865.9806700966315;3867.2265546890735;3886.8639597614515;3901.45379646844;3932.8426862925735;3896.5908579598736;3910.3743401055694;3924.3917192834583;3930.155016671429;3931.4299426582984;4501.41481607389;4512.616427603625;4527.411436513232;4530.207213737649;4538.2738761797955;5152.665076770073;5161.716105614228;5279.551238144724;5301.5493683037375;5317.787288508416;1357.5384369314481;1376.8072469854228;1379.751644703943;1383.3774801339437;1383.8131852200027;852.8805967164602;887.4453466583385;899.7660608241773;914.7347269291964;918.7703074231442;4464.2187617166865;4555.246230201396;4563.748993805372;4629.305604159403;4632.86101416958;5402.91895621566;5403.5136837684795;5435.673859568438;5440.836774896759;5456.208849716769;4527.524609915911;4595.770211489479;4606.332081848181;4648.767561621906;4653.883652908705;2915.1983204618477;2917.226934862263;2932.1643331650375;2949.7640188785276;2958.748506376939;5120.590352771769;5121.743912804345;5142.871428214325;5148.150555158431;5180.378354597472;5412.188171774265;5538.224648549206;5555.861103472364;5611.691356975405;5622.803201887914;5072.5688316493515;5108.821191258288;5123.8719032023755;5149.459306772735;5160.587153027674;5468.207109969112;5471.72641367938;5478.479544443271;5480.945190548203;5531.640443371168;5125.8974820502635;5283.2075188722;5349.753103696379;5361.705106219196;5450.127979523258;5126;5142.434332223377;5146.202338637517;5152.407473140487;5170.870728231825;3862.1310205204727;3883.2427676602792;3885.979290768841;3886.2033283177448;3896.279188350164;5247.396549396715;5408.8377348679605;5431.2667789847865;5455.399906010256;5498.51540084183;5284.6564973278155;5309.7345132743985;5312.62811603184;5336.439673834347;5351.518363347317;5270.420253772006;5316.6544174628525;5331.4401987790725;5349.545288650508;5349.866253343697;4971.850844474671;5227.607929405233;5240.34495688039;5290.232916227203;5305.469453054664;5176.767045482887;5208.218767184952;5338.839834804962;5382.407935127055;5389.2455056291365;5258.7904781899615;5265.684058956322;5266.683998960075;5298.576113910801;5309.442508536548 05:05:55 INFO - PROCESS | 13682 | |5;yui.html;597.050689403848;616.2512547255086;629.5624540944045;633.3096924352454;691.3950293493193;11876.940615296922;11985.280883147007;12290.38548072595;12299.200551964115;13008.609741707764;14124.505642302522;14561.92719036406;14672.779908301358;14693.044952078135;14720.779188312184;622.1414448061669;765.3953376832324;774.0479210570987;786.8662327404327;790.2492631999595;767.6699019421646;770.9284095107805;771.0362047440699;771.0824119298045;771.1825465007082;807.1524898856206;812.2892469089546;812.4150611559668;812.5246730662569;812.6505602590913;803.6785285885634;805.2672068417712;806.0206848678854;807.3057170833108;807.8667019941703;584.5440556366042;584.5878655547829;586.8092869817284;588.2705445247861;589.6815719511502;11878.227915185485;11908.821367679491;11926.284422934565;11930.164888457812;11961;12778.808317875239;13130.737385252241;13272.601821945356;13435.731285374335;13446.12600180995;10593.699133369466;10725.410102444363;10778.191635627281;10834.40410777407;10948.835767463494;3292.4732042873025;3343.5820522434697;3345.5149003394613;3347.6484969078383;3348;62499.06251406232;63114.68442657803;63258.36741632617;63447;64144.67927660378;10213.74465638365;10227.539760710786;10240;10384.636537721144;10450.216233782498;18913.338033168773;19153.52116197106;19195.904020479808;19221;19268.22927082929;6552.57408268461;6588.8352791180605;6641.468682505388;6641.966790166115;6746.696398662072;3596.496490491333;3709.554853417553;3748.775073495599;3766.0396598867114;3804.410316400907;3031.34826012404;3103.5344698295435;3124.9531257031163;3142.1673256586564;3150.747940164827;520.3833457353048;524.8215606693742;534.2140736061381;535.1464414259328;540.6026570470701;550.3615805665409;568.8321945026228;596.8836076965036;600.5083511289236;601.7923816283375;7843.9607801961765;8185.631646575918;8682.869756953525;8757.562121894007;8970.730878073668;522.3496746550569;557.7378632042934;569.3680015183144;582.257621532541;622.228436738441;4012.217617564547;4058.848338998177;4130.979345103316;4237.533871274158;4278.44380230568;87474;90802;91209.54395227981;91739.20216781649;92706;75499;79408;79698;80357;81498.59250703709;70797.29202708113;71012.64493677602;73443.63278183575;73808.26191738121;73925.63037184888;7615.314621684075;7750.689972401041;7899.995537286121;7921.089074756246;8018.3184429324165;42846.35730464108;42967.785161073996;44176.55823441724;44383.77808111068;44733;56862;57396.42603573911;61002.38997610145;64172.67913660402;64444.67777661081;9967.50162491887;10147.594096236067;10185.847212291674;10230.590776368861;10304;12806;13103.803442948554;13178.934105329412;14347.210903399995;14419.85580144185;11900.464479098287;11960.282383057045;12013.879861201276;12513.749725005267;13685;11572.537098515964;11648.76702465929;11824.881751182378;12530.310832904277;12688;10986.725331866768;11189.72025699364;11586.536538538365;11788.941055294668;12206;9891.406515608798;10663.46682665879;10822.729431764268;10828.5127169276;11003.559857605605;10261.640842570474;10707.732306692084;11196.496157672762;11225;11350.772984540428 05:05:55 INFO - PROCESS | 13682 | __end_tp_report 05:05:55 INFO - PROCESS | 13682 | __start_cc_report 05:05:55 INFO - PROCESS | 13682 | _x_x_mozilla_cycle_collect,388 05:05:55 INFO - PROCESS | 13682 | __end_cc_report 05:05:55 INFO - PROCESS | 13682 | __startTimestamp1466597155589__endTimestamp 05:05:55 INFO - PROCESS | 13682 | 05:05:55 INFO - PROCESS | 13682 | ------- Summary: start ------- 05:05:55 INFO - PROCESS | 13682 | Number of tests: 6 05:05:55 INFO - PROCESS | 13682 | 05:05:55 INFO - PROCESS | 13682 | [#0] dojo.html Cycles:165 Average:4823.14 Median:4971.85 stddev:624.63 (12.6%) stddev-sans-first:602.54 05:05:55 INFO - PROCESS | 13682 | Values: 2637.2 2673.2 2696.4 2710.5 2712.5 4831.6 4838.2 4875.0 4955.3 5021.6 4795.1 4880.2 4906.7 4914.6 4946.6 4467.0 4500.8 4590.0 4601.4 4609.2 460.8 4403.5 4470.2 4503.4 4503.6 4499.1 4539.0 4541.5 4547.4 4583.3 4517.3 4535.5 4535.8 4539.3 4578.0 4370.5 4445.0 4461.4 4464.7 4480.6 4456.6 4904.4 4934.9 4942.4 4944.1 5188.3 5293.3 5293.6 5300.5 5359.9 5248.7 5287.2 5296.8 5320.5 5375.6 4927.9 4927.9 4932.0 4938.9 4945.4 5324.1 5403.9 5423.8 5425.3 5436.3 5232.1 5241.3 5241.5 5247.7 5295.8 5334.3 5340.7 5347.3 5347.7 5398.4 5033.7 5187.2 5230.3 5241.9 5253.7 5219.8 5221.9 5225.1 5246.9 5266.6 4492.8 4501.9 4515.1 4520.3 4546.5 3864.9 3876.1 3897.0 3898.3 3917.9 4377.9 4423.2 4426.9 4491.6 4498.7 5218.3 5273.7 5281.0 5340.5 5359.1 4522.4 4545.3 4552.2 4554.0 4603.0 4584.4 4587.1 4604.8 4648.6 4676.8 4936.1 4971.9 4973.9 4974.5 4977.8 5322.9 5323.6 5326.5 5328.4 5332.0 4749.2 4867.5 4887.4 4904.6 4905.6 5165.3 5170.4 5188.4 5198.7 5224.8 5095.5 5249.6 5252.9 5257.0 5274.3 5017.9 5037.1 5063.3 5093.8 5099.3 5062.0 5074.9 5076.2 5089.8 5122.3 4862.2 4945.2 5002.1 5003.3 5008.4 5064.2 5085.9 5094.5 5129.9 5163.8 5009.3 5010.0 5021.5 5021.8 5070.7 05:05:55 INFO - PROCESS | 13682 | 05:05:55 INFO - PROCESS | 13682 | [#1] ext.html Cycles:180 Average:45411.64 Median:36670.63 stddev:79429.88 (216.6%) stddev-sans-first:79581.28 05:05:55 INFO - PROCESS | 13682 | Values: 550.0 585.2 586.9 598.8 605.6 38902.0 39895.0 39923.8 39986.6 44774.8 40879.6 41277.8 41477.9 41511.2 41523.6 7793.0 7807.6 7895.7 7936.6 7945.3 7708.5 7822.9 7836.9 7846.7 7856.1 7877.6 7898.9 7899.1 7899.6 7903.1 7811.4 7827.2 7848.3 7856.2 7865.1 7815.9 7880.9 7894.1 7903.1 7918.5 39283.8 39288.4 39513.6 39560.4 39718.2 2962.2 3128.0 3355.8 3358.6 3635.4 28822.3 29571.7 29781.0 29850.6 30627.7 3273.0 3301.0 3305.1 3309.0 3355.3 243279.0 244259.0 245480.0 247323.0 250489.0 53406.0 53947.5 54003.0 54048.2 54199.2 33080.3 33727.3 33799.3 35646.1 35724.0 15765.9 15814.9 15826.9 15917.6 15946.8 11818.9 11888.7 11889.5 11948.7 12012.6 18429.4 18603.7 18715.2 18753.9 18954.6 6802.0 6895.6 7047.8 7111.9 7165.3 873.8 875.5 895.0 911.2 1030.2 27511.3 28343.6 29047.9 29240.9 29310.1 932.4 956.3 993.5 996.2 996.8 14237.6 14656.5 14724.8 14937.6 15075.4 357817.0 365095.0 365200.0 366360.4 368901.0 44069.0 44900.8 45036.8 45228.5 45258.3 1208.5 1229.4 1247.1 1257.5 1266.2 26515.0 27053.5 27133.9 27493.3 27591.3 42370.0 42673.4 42912.8 42954.0 42969.1 283760.0 285433.0 286151.0 286153.0 286374.1 25232.1 25368.5 25979.5 26032.2 26106.5 42377.0 42491.8 42841.6 43231.4 43340.1 36275.6 36658.6 36664.8 37084.8 37663.8 36338.0 36807.0 36932.3 37375.6 37624.6 33428.2 35789.6 36676.4 36757.3 36887.0 32004.2 32600.2 33331.5 33528.5 33693.8 25495.9 26096.2 26135.2 26152.3 26585.6 05:05:55 INFO - PROCESS | 13682 | 05:05:55 INFO - PROCESS | 13682 | [#2] jquery.html Cycles:180 Average:23603.45 Median:50544.00 stddev:60949.26 (120.6%) stddev-sans-first:61095.27 05:05:55 INFO - PROCESS | 13682 | Values: 367.5 369.4 372.1 373.4 386.3 15652.1 16853.1 16979.2 17277.0 17368.4 15248.7 16868.7 17428.0 17429.7 17472.8 4976.6 5091.1 5174.4 5175.7 5184.5 3715.1 5033.4 5570.0 5834.5 5893.5 5847.9 5876.0 5895.6 5923.7 5959.6 5847.4 5884.9 6016.9 6023.2 6029.8 5218.3 5290.2 5297.4 5307.5 5363.6 17737.5 18836.8 20915.6 21468.7 21545.6 1938.0 1953.8 1992.2 2000.3 2357.6 8618.9 8981.5 8995.7 8999.0 9246.5 1763.3 1823.4 1926.2 1943.2 1945.1 67453.7 69689.3 69883.7 70125.6 70889.6 8847.8 9638.0 9955.5 10204.1 10341.3 13869.5 13896.4 13934.1 13969.6 13989.1 7484.7 7537.8 7639.9 7768.8 7778.6 7121.5 7122.8 7140.1 7253.5 7290.6 3930.7 4083.9 4158.3 4300.3 4404.6 1655.7 1901.8 2953.5 3220.6 3452.2 746.5 792.2 857.0 880.2 899.0 16325.4 16393.0 16749.8 17036.2 17226.4 828.3 838.6 849.4 864.0 875.2 8891.4 9335.5 9689.4 9762.6 9806.0 362502.0 368087.0 368729.0 370179.0 374074.0 72389.3 72723.6 73852.0 75452.2 75725.0 877.3 878.9 886.1 888.8 897.2 14994.4 15272.9 15318.1 15441.8 15710.8 35505.6 36025.8 36469.3 37058.8 37512.6 48856.3 50382.5 50434.2 50653.7 50836.2 7518.4 7524.9 7525.8 7546.5 7610.3 10701.6 11206.2 11250.0 11729.2 11824.8 9220.2 9662.3 9942.7 10003.9 10152.7 10145.2 10164.8 10407.9 10424.5 10426.8 9789.0 9987.3 10210.3 10417.6 10451.7 7423.0 7647.9 7654.7 7688.8 7923.7 7535.3 9918.0 10276.8 10280.6 10414.3 05:05:55 INFO - PROCESS | 13682 | 05:05:55 INFO - PROCESS | 13682 | [#3] mootools.html Cycles:180 Average:5204.93 Median:5432.96 stddev:2877.57 (53.0%) stddev-sans-first:2871.17 05:05:55 INFO - PROCESS | 13682 | Values: 1365.5 1402.8 1471.9 1653.3 1653.7 6869.2 7561.4 7573.0 8093.6 8094.7 7673.1 7849.1 7903.3 7904.9 7924.1 2200.8 2249.1 2262.1 2265.9 2270.3 2182.3 2207.0 2231.6 2241.0 2242.0 2217.3 2224.5 2225.1 2228.6 2235.1 2156.6 2166.5 2175.0 2175.1 2190.1 2097.8 2124.4 2137.0 2137.2 2145.0 7817.6 7830.0 7944.4 7945.8 7985.3 4596.7 4705.9 4711.6 4714.4 4738.8 2911.7 3015.2 3037.5 3065.0 3071.4 999.4 1008.6 1009.9 1015.4 1037.0 10639.7 10653.5 10661.1 10675.8 10694.1 4130.3 4246.2 4306.8 4315.0 4330.0 8985.0 9005.5 9006.1 9046.0 9067.9 4637.5 4645.2 4651.0 4652.5 4658.5 3798.2 4090.9 4125.9 4190.1 4245.4 3647.6 3657.8 3684.2 3741.6 3770.2 1186.8 1225.9 1227.2 1233.0 1245.3 837.8 861.1 866.9 887.5 910.0 5408.8 5639.2 5674.5 5693.4 5720.1 798.2 878.9 910.3 941.2 965.9 3546.4 3685.4 3703.3 3707.3 3759.3 9335.3 9448.7 9679.7 9706.6 9773.5 9626.5 9631.9 9646.0 9655.4 9689.0 7120.1 7235.7 7283.9 7408.8 7435.3 5418.5 5447.4 5460.0 5585.3 5630.3 8842.0 9037.5 9109.9 9159.9 9186.3 8964.5 9026.2 9300.8 9312.2 9317.7 6200.6 6674.2 6937.7 6960.1 7100.3 7647.3 7660.5 7716.8 7718.1 7791.9 6584.2 6837.0 6868.4 6949.6 6951.4 6686.6 6720.1 6777.6 6785.8 6911.4 6155.3 6161.5 6230.1 6255.5 6271.3 4713.1 4757.5 4766.7 4805.3 4818.3 4620.8 4636.9 4668.7 4707.5 4748.9 05:05:55 INFO - PROCESS | 13682 | 05:05:55 INFO - PROCESS | 13682 | [#4] prototype.html Cycles:180 Average:4414.91 Median:5098.75 stddev:1277.30 (25.1%) stddev-sans-first:1242.96 05:05:55 INFO - PROCESS | 13682 | Values: 298.9 304.6 306.5 306.6 314.5 5154.1 5159.9 5160.2 5160.6 5172.7 5039.1 5065.4 5078.1 5095.7 5101.8 3788.4 3810.6 3945.1 3954.2 3965.1 3915.2 3978.9 3980.5 3983.5 3987.1 3949.5 3962.6 3968.2 3985.3 3987.5 3801.6 3959.6 3970.2 3979.5 3982.6 3502.6 3510.7 3536.5 3537.0 3542.3 4979.9 5028.3 5035.3 5036.7 5043.5 4386.1 4574.0 4578.9 4583.2 4586.8 5253.5 5262.8 5280.9 5301.8 5307.4 3814.5 3832.5 3834.1 3849.7 3858.2 5338.4 5556.9 5590.4 5601.8 5641.2 3866.0 3867.2 3886.9 3901.5 3932.8 3896.6 3910.4 3924.4 3930.2 3931.4 4501.4 4512.6 4527.4 4530.2 4538.3 5152.7 5161.7 5279.6 5301.5 5317.8 1357.5 1376.8 1379.8 1383.4 1383.8 852.9 887.4 899.8 914.7 918.8 4464.2 4555.2 4563.7 4629.3 4632.9 5402.9 5403.5 5435.7 5440.8 5456.2 4527.5 4595.8 4606.3 4648.8 4653.9 2915.2 2917.2 2932.2 2949.8 2958.7 5120.6 5121.7 5142.9 5148.2 5180.4 5412.2 5538.2 5555.9 5611.7 5622.8 5072.6 5108.8 5123.9 5149.5 5160.6 5468.2 5471.7 5478.5 5480.9 5531.6 5125.9 5283.2 5349.8 5361.7 5450.1 5126.0 5142.4 5146.2 5152.4 5170.9 3862.1 3883.2 3886.0 3886.2 3896.3 5247.4 5408.8 5431.3 5455.4 5498.5 5284.7 5309.7 5312.6 5336.4 5351.5 5270.4 5316.7 5331.4 5349.5 5349.9 4971.9 5227.6 5240.3 5290.2 5305.5 5176.8 5208.2 5338.8 5382.4 5389.2 5258.8 5265.7 5266.7 5298.6 5309.4 05:05:55 INFO - PROCESS | 13682 | 05:05:55 INFO - PROCESS | 13682 | [#5] yui.html Cycles:180 Average:17428.97 Median:44280.17 stddev:24197.93 (54.6%) stddev-sans-first:24232.81 05:05:55 INFO - PROCESS | 13682 | Values: 597.1 616.3 629.6 633.3 691.4 11876.9 11985.3 12290.4 12299.2 13008.6 14124.5 14561.9 14672.8 14693.0 14720.8 622.1 765.4 774.0 786.9 790.2 767.7 770.9 771.0 771.1 771.2 807.2 812.3 812.4 812.5 812.7 803.7 805.3 806.0 807.3 807.9 584.5 584.6 586.8 588.3 589.7 11878.2 11908.8 11926.3 11930.2 11961.0 12778.8 13130.7 13272.6 13435.7 13446.1 10593.7 10725.4 10778.2 10834.4 10948.8 3292.5 3343.6 3345.5 3347.6 3348.0 62499.1 63114.7 63258.4 63447.0 64144.7 10213.7 10227.5 10240.0 10384.6 10450.2 18913.3 19153.5 19195.9 19221.0 19268.2 6552.6 6588.8 6641.5 6642.0 6746.7 3596.5 3709.6 3748.8 3766.0 3804.4 3031.3 3103.5 3125.0 3142.2 3150.7 520.4 524.8 534.2 535.1 540.6 550.4 568.8 596.9 600.5 601.8 7844.0 8185.6 8682.9 8757.6 8970.7 522.3 557.7 569.4 582.3 622.2 4012.2 4058.8 4131.0 4237.5 4278.4 87474.0 90802.0 91209.5 91739.2 92706.0 75499.0 79408.0 79698.0 80357.0 81498.6 70797.3 71012.6 73443.6 73808.3 73925.6 7615.3 7750.7 7900.0 7921.1 8018.3 42846.4 42967.8 44176.6 44383.8 44733.0 56862.0 57396.4 61002.4 64172.7 64444.7 9967.5 10147.6 10185.8 10230.6 10304.0 12806.0 13103.8 13178.9 14347.2 14419.9 11900.5 11960.3 12013.9 12513.7 13685.0 11572.5 11648.8 11824.9 12530.3 12688.0 10986.7 11189.7 11586.5 11788.9 12206.0 9891.4 10663.5 10822.7 10828.5 11003.6 10261.6 10707.7 11196.5 11225.0 11350.8 05:05:55 INFO - PROCESS | 13682 | -------- Summary: end -------- 05:05:55 INFO - PROCESS | 13682 | 05:05:56 INFO - TEST-INFO | 13682: exit 0 05:05:56 INFO - TEST-OK | dromaeo_css | took 1116585ms 05:05:56 INFO - TEST-START | kraken 05:05:56 INFO - operating with platform_type : linux_ 05:05:56 INFO - Initialising browser for kraken test... 05:05:56 INFO - TEST-INFO | started process 13915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpySjsBw/profile http://localhost:54084/getInfo.html) 05:06:01 INFO - PROCESS | 13915 | __metrics Screen width/height:1600/1200 05:06:01 INFO - PROCESS | 13915 | colorDepth:24 05:06:01 INFO - PROCESS | 13915 | Browser inner width/height: 1024/697 05:06:01 INFO - PROCESS | 13915 | __metrics 05:06:02 ERROR - PROCESS | 13915 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:06:02 INFO - TEST-INFO | 13915: exit 0 05:06:02 INFO - Browser initialized. 05:06:02 INFO - Running cycle 1/1 for kraken test... 05:06:02 INFO - TEST-INFO | started process 14033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpySjsBw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:15 INFO - PROCESS | 14033 | RSS: Main: 186449920 05:06:15 INFO - PROCESS | 14033 | 05:06:17 INFO - PROCESS | 14033 | Cycle 1(1): loaded http://localhost:54084/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54084/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:18 INFO - PROCESS | 14033 | RSS: Main: 190701568 05:06:18 INFO - PROCESS | 14033 | 05:06:21 INFO - PROCESS | 14033 | Cycle 1(1): loaded http://localhost:54084/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54084/tests/kraken/driver.html?testName=audio-dft) 05:06:22 INFO - PROCESS | 14033 | RSS: Main: 190459904 05:06:22 INFO - PROCESS | 14033 | 05:06:25 INFO - PROCESS | 14033 | Cycle 1(1): loaded http://localhost:54084/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54084/tests/kraken/driver.html?testName=audio-fft) 05:06:25 INFO - PROCESS | 14033 | RSS: Main: 186490880 05:06:25 INFO - PROCESS | 14033 | 05:06:28 INFO - PROCESS | 14033 | Cycle 1(1): loaded http://localhost:54084/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54084/tests/kraken/driver.html?testName=audio-oscillator) 05:06:28 INFO - PROCESS | 14033 | RSS: Main: 186961920 05:06:28 INFO - PROCESS | 14033 | 05:06:30 INFO - PROCESS | 14033 | Cycle 1(1): loaded http://localhost:54084/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54084/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:06:31 INFO - PROCESS | 14033 | RSS: Main: 187006976 05:06:31 INFO - PROCESS | 14033 | 05:06:34 INFO - PROCESS | 14033 | Cycle 1(1): loaded http://localhost:54084/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54084/tests/kraken/driver.html?testName=imaging-darkroom) 05:06:35 INFO - PROCESS | 14033 | RSS: Main: 187420672 05:06:35 INFO - PROCESS | 14033 | 05:06:38 INFO - PROCESS | 14033 | Cycle 1(1): loaded http://localhost:54084/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54084/tests/kraken/driver.html?testName=imaging-desaturate) 05:06:39 INFO - PROCESS | 14033 | RSS: Main: 184037376 05:06:39 INFO - PROCESS | 14033 | 05:06:42 INFO - PROCESS | 14033 | Cycle 1(1): loaded http://localhost:54084/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54084/tests/kraken/driver.html?testName=json-parse-financial) 05:06:43 INFO - PROCESS | 14033 | RSS: Main: 185618432 05:06:43 INFO - PROCESS | 14033 | 05:06:44 INFO - PROCESS | 14033 | Cycle 1(1): loaded http://localhost:54084/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54084/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:06:45 INFO - PROCESS | 14033 | RSS: Main: 186302464 05:06:45 INFO - PROCESS | 14033 | 05:06:47 INFO - PROCESS | 14033 | Cycle 1(1): loaded http://localhost:54084/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54084/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:06:48 INFO - PROCESS | 14033 | RSS: Main: 186499072 05:06:48 INFO - PROCESS | 14033 | 05:06:50 INFO - PROCESS | 14033 | Cycle 1(1): loaded http://localhost:54084/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54084/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:06:51 INFO - PROCESS | 14033 | RSS: Main: 187211776 05:06:51 INFO - PROCESS | 14033 | 05:06:53 INFO - PROCESS | 14033 | Cycle 1(1): loaded http://localhost:54084/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:06:54 INFO - PROCESS | 14033 | RSS: Main: 187490304 05:06:54 INFO - PROCESS | 14033 | 05:06:57 INFO - PROCESS | 14033 | Cycle 1(1): loaded http://localhost:54084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:06:57 INFO - PROCESS | 14033 | RSS: Main: 186785792 05:06:57 INFO - PROCESS | 14033 | 05:06:59 INFO - PROCESS | 14033 | Cycle 1(1): loaded http://localhost:54084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54084/tests/kraken/driver.html?testName=ai-astar) 05:06:59 INFO - PROCESS | 14033 | RSS: Main: 187695104 05:06:59 INFO - PROCESS | 14033 | 05:06:59 INFO - PROCESS | 14033 | __start_tp_report 05:06:59 INFO - PROCESS | 14033 | _x_x_mozilla_page_load 05:06:59 INFO - PROCESS | 14033 | _x_x_mozilla_page_load_details 05:06:59 INFO - PROCESS | 14033 | |i|pagename|runs| 05:06:59 INFO - PROCESS | 14033 | |0;ai-astar;115;107;114;115;115;114;114;113;114;112 05:06:59 INFO - PROCESS | 14033 | |1;audio-beat-detection;156;136;168;177;133;168;162;137;189;145 05:06:59 INFO - PROCESS | 14033 | |2;audio-dft;163;165;172;167;164;165;164;163;163;164 05:06:59 INFO - PROCESS | 14033 | |3;audio-fft;75;77;76;170;79;85;74;76;172;77 05:06:59 INFO - PROCESS | 14033 | |4;audio-oscillator;88;86;140;87;87;87;127;87;88;157 05:06:59 INFO - PROCESS | 14033 | |5;imaging-gaussian-blur;118;118;118;117;117;118;118;118;118;118 05:06:59 INFO - PROCESS | 14033 | |6;imaging-darkroom;147;148;148;147;154;147;148;146;147;146 05:06:59 INFO - PROCESS | 14033 | |7;imaging-desaturate;96;95;95;95;96;97;96;95;95;96 05:06:59 INFO - PROCESS | 14033 | |8;json-parse-financial;65;65;64;63;64;64;65;63;66;63 05:07:00 INFO - PROCESS | 14033 | |9;json-stringify-tinderbox;65;66;66;67;67;65;65;66;66;66 05:07:00 INFO - PROCESS | 14033 | |10;stanford-crypto-aes;86;83;86;85;91;85;85;85;106;85 05:07:00 INFO - PROCESS | 14033 | |11;stanford-crypto-ccm;135;135;136;141;137;131;134;151;146;137 05:07:00 INFO - PROCESS | 14033 | |12;stanford-crypto-pbkdf2;172;174;169;168;170;170;174;174;173;173 05:07:00 INFO - PROCESS | 14033 | |13;stanford-crypto-sha256-iterative;70;69;68;68;70;66;67;68;72;68 05:07:00 INFO - PROCESS | 14033 | __end_tp_report 05:07:00 INFO - PROCESS | 14033 | __start_cc_report 05:07:00 INFO - PROCESS | 14033 | _x_x_mozilla_cycle_collect,992 05:07:00 INFO - PROCESS | 14033 | __end_cc_report 05:07:00 INFO - PROCESS | 14033 | __startTimestamp1466597219993__endTimestamp 05:07:00 INFO - PROCESS | 14033 | 05:07:00 INFO - PROCESS | 14033 | ------- Summary: start ------- 05:07:00 INFO - PROCESS | 14033 | Number of tests: 14 05:07:00 INFO - PROCESS | 14033 | 05:07:00 INFO - PROCESS | 14033 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:2.41 (2.1%) stddev-sans-first:2.47 05:07:00 INFO - PROCESS | 14033 | Values: 115.0 107.0 114.0 115.0 115.0 114.0 114.0 113.0 114.0 112.0 05:07:00 INFO - PROCESS | 14033 | 05:07:00 INFO - PROCESS | 14033 | [#1] audio-beat-detection Cycles:10 Average:157.10 Median:165.00 stddev:19.01 (11.5%) stddev-sans-first:20.16 05:07:00 INFO - PROCESS | 14033 | Values: 156.0 136.0 168.0 177.0 133.0 168.0 162.0 137.0 189.0 145.0 05:07:00 INFO - PROCESS | 14033 | 05:07:00 INFO - PROCESS | 14033 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:2.75 (1.7%) stddev-sans-first:2.82 05:07:00 INFO - PROCESS | 14033 | Values: 163.0 165.0 172.0 167.0 164.0 165.0 164.0 163.0 163.0 164.0 05:07:00 INFO - PROCESS | 14033 | 05:07:00 INFO - PROCESS | 14033 | [#3] audio-fft Cycles:10 Average:96.10 Median:76.50 stddev:39.59 (51.8%) stddev-sans-first:41.25 05:07:00 INFO - PROCESS | 14033 | Values: 75.0 77.0 76.0 170.0 79.0 85.0 74.0 76.0 172.0 77.0 05:07:00 INFO - PROCESS | 14033 | 05:07:00 INFO - PROCESS | 14033 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:87.00 stddev:27.13 (31.2%) stddev-sans-first:28.19 05:07:00 INFO - PROCESS | 14033 | Values: 88.0 86.0 140.0 87.0 87.0 87.0 127.0 87.0 88.0 157.0 05:07:00 INFO - PROCESS | 14033 | 05:07:00 INFO - PROCESS | 14033 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:07:00 INFO - PROCESS | 14033 | Values: 118.0 118.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 05:07:00 INFO - PROCESS | 14033 | 05:07:00 INFO - PROCESS | 14033 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.50 stddev:2.30 (1.6%) stddev-sans-first:2.42 05:07:00 INFO - PROCESS | 14033 | Values: 147.0 148.0 148.0 147.0 154.0 147.0 148.0 146.0 147.0 146.0 05:07:00 INFO - PROCESS | 14033 | 05:07:00 INFO - PROCESS | 14033 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 05:07:00 INFO - PROCESS | 14033 | Values: 96.0 95.0 95.0 95.0 96.0 97.0 96.0 95.0 95.0 96.0 05:07:00 INFO - PROCESS | 14033 | 05:07:00 INFO - PROCESS | 14033 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.50 stddev:1.03 (1.6%) stddev-sans-first:1.05 05:07:00 INFO - PROCESS | 14033 | Values: 65.0 65.0 64.0 63.0 64.0 64.0 65.0 63.0 66.0 63.0 05:07:00 INFO - PROCESS | 14033 | 05:07:00 INFO - PROCESS | 14033 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 05:07:00 INFO - PROCESS | 14033 | Values: 65.0 66.0 66.0 67.0 67.0 65.0 65.0 66.0 66.0 66.0 05:07:00 INFO - PROCESS | 14033 | 05:07:00 INFO - PROCESS | 14033 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:85.00 stddev:6.75 (7.9%) stddev-sans-first:7.13 05:07:00 INFO - PROCESS | 14033 | Values: 86.0 83.0 86.0 85.0 91.0 85.0 85.0 85.0 106.0 85.0 05:07:00 INFO - PROCESS | 14033 | 05:07:00 INFO - PROCESS | 14033 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:137.00 stddev:6.06 (4.4%) stddev-sans-first:6.30 05:07:00 INFO - PROCESS | 14033 | Values: 135.0 135.0 136.0 141.0 137.0 131.0 134.0 151.0 146.0 137.0 05:07:00 INFO - PROCESS | 14033 | 05:07:00 INFO - PROCESS | 14033 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:173.00 stddev:2.26 (1.3%) stddev-sans-first:2.40 05:07:00 INFO - PROCESS | 14033 | Values: 172.0 174.0 169.0 168.0 170.0 170.0 174.0 174.0 173.0 173.0 05:07:00 INFO - PROCESS | 14033 | 05:07:00 INFO - PROCESS | 14033 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.71 (2.5%) stddev-sans-first:1.74 05:07:00 INFO - PROCESS | 14033 | Values: 70.0 69.0 68.0 68.0 70.0 66.0 67.0 68.0 72.0 68.0 05:07:00 INFO - PROCESS | 14033 | -------- Summary: end -------- 05:07:00 INFO - PROCESS | 14033 | 05:07:01 INFO - TEST-INFO | 14033: exit 0 05:07:01 INFO - TEST-OK | kraken | took 64847ms 05:07:01 INFO - SUITE-END | took 1181s 05:07:01 INFO - Completed test suite (00:19:41) 05:07:01 INFO - javascript benchmark 05:07:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6516.051515207322, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2637.222019504246, 2673.1713168917636, 2696.366353906833, 2710.498557766812, 2712.4575084983007, 4831.565159135677, 4838.177509823334, 4874.951250487494, 4955.256711493278, 5021.57316628087, 4795.0889331027165, 4880.170371036923, 4906.705597664142, 4914.606831453484, 4946.629002824785, 4467.039586488904, 4500.842470513533, 4589.977050114761, 4601.447826260854, 4609.216433206346, 460.79312042636514, 4403.537628549005, 4470.217711900421, 4503.414556107701, 4503.594676479116, 4499.122671079157, 4539.0, 4541.500434952152, 4547.386102876102, 4583.266677331644, 4517.277235642281, 4535.523770004168, 4535.750533720644, 4539.2737162054245, 4578.038611891507, 4370.519242883281, 4444.955550444486, 4461.420015397977, 4464.709793863389, 4480.574345437179, 4456.5766252205985, 4904.362432883738, 4934.925976110361, 4942.431620363668, 4944.110060189165, 5188.299579556787, 5293.338332708411, 5293.57651387888, 5300.522952934254, 5359.866003349908, 5248.71132087735, 5287.180487024518, 5296.814611488579, 5320.494553017457, 5375.596830237748, 4927.876803079916, 4927.90144197114, 4931.964287499593, 4938.9012219755405, 4945.406551213878, 5324.121519949165, 5403.864903377368, 5423.810166644149, 5425.267588875451, 5436.293281873332, 5232.136697444955, 5241.344831896013, 5241.502057304626, 5247.7113758743635, 5295.814646487354, 5334.279872217201, 5340.732963351817, 5347.278117454094, 5347.705876176769, 5398.379186393537, 5033.748312584356, 5187.247849061865, 5230.320058392384, 5241.895162096736, 5253.737313134328, 5219.765110570033, 5221.895562088737, 5225.1117310056625, 5246.921296180561, 5266.552343050807, 4492.775361231926, 4501.864944051684, 4515.119551687455, 4520.276755719069, 4546.477155127202, 3864.942025869614, 3876.0697432616535, 3897.0452239201577, 3898.317794385971, 3917.882463526099, 4377.9124417511475, 4423.181711383404, 4426.911461770746, 4491.640668746492, 4498.707584007029, 5218.295530103387, 5273.6572122811895, 5281.0, 5340.519353258225, 5359.062164121263, 4522.4346956630425, 4545.250033744462, 4552.157850797546, 4554.0, 4603.0, 4584.426946631605, 4587.105514424722, 4604.769761511911, 4648.558386953234, 4676.812927482931, 4936.062148191832, 4971.850844474671, 4973.850784476472, 4974.527419895104, 4977.776000080077, 5322.946770532245, 5323.600729945347, 5326.520613144836, 5328.387235467971, 5332.0, 4749.216379297377, 4867.537583929521, 4887.3890763654545, 4904.558589726942, 4905.583025442877, 5165.302684137593, 5170.43125256229, 5188.403333616531, 5198.740062996911, 5224.843254702213, 5095.515925987025, 5249.580033597226, 5252.949410118068, 5257.0, 5274.287971123849, 5017.899642007066, 5037.093323201859, 5063.26582645507, 5093.796248150033, 5099.26060721186, 5062.038212739568, 5074.873128171826, 5076.238564215398, 5089.821856235014, 5122.334096567422, 4862.246351815475, 4945.208766597327, 5002.07461619587, 5003.324551185543, 5008.373953255843, 5064.18972964324, 5085.872853178552, 5094.465081166424, 5129.8717532062, 5163.8192663256605, 5009.298698182184, 5010.048090862724, 5021.472745361684, 5021.84934451967, 5070.6957582545165], "value": 4784.157065017298, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.9897873273186, 585.1515302810919, 586.8650210451597, 598.8323269484546, 605.6275390634759, 38902.0, 39895.0, 39923.80800016, 39986.600133998654, 44774.77612611932, 40879.59120408795, 41277.79361103198, 41477.926103694845, 41511.169776604525, 41523.58476415235, 7792.96103519483, 7807.609619519029, 7895.684172633088, 7936.642851071716, 7945.284924356835, 7708.460407771458, 7822.882656760153, 7836.882446763303, 7846.72536461224, 7856.057273127204, 7877.566733829637, 7898.8815167772245, 7899.091604465502, 7899.565523896184, 7903.130655627876, 7811.375089992787, 7827.178146294671, 7848.254415830515, 7856.1751016143335, 7865.134835168127, 7815.882761758578, 7880.921190788134, 7894.131645518988, 7903.130655627876, 7918.524888506708, 39283.803580982196, 39288.41067383991, 39513.60486395128, 39560.40659390111, 39718.20563588741, 2962.2002059444044, 3128.0, 3355.798652080883, 3358.596968363812, 3635.363811333006, 28822.279443013882, 29571.70428295711, 29781.0, 29850.552241716392, 30627.693723062708, 3273.0, 3300.9834950825334, 3305.0910999475095, 3309.0, 3355.278615097766, 243279.0, 244258.99999999822, 245480.0, 247323.0, 250489.0, 53406.0, 53947.46052539503, 54003.0, 54048.18927716009, 54199.187012194845, 33080.338393232, 33727.32545349079, 33799.32401351959, 35646.10884727903, 35724.0, 15765.896387253011, 15814.920925395529, 15826.92086539583, 15917.602059948362, 15946.840531594535, 11818.881811181778, 11888.702782430508, 11889.464974076014, 11948.701282468008, 12012.579559715543, 18429.41988121664, 18603.720944185847, 18715.157817898227, 18753.90623046876, 18954.620907582048, 6801.965990170018, 6895.55178913369, 7047.788566343018, 7111.857762844714, 7165.319294667102, 873.8121303919688, 875.5228400521604, 895.0288936503836, 911.1617312072909, 1030.228684837784, 27511.31221719433, 28343.57484637732, 29047.854760726063, 29240.85379573131, 29310.12069637914, 932.3566738950238, 956.3066776586919, 993.4585650820176, 996.2279233594022, 996.7707427291764, 14237.64405889861, 14656.487022954145, 14724.779128313085, 14937.551873443814, 15075.39698412073, 357817.0, 365095.0, 365200.0, 366360.35477516317, 368901.0, 44069.0, 44900.77549612231, 45036.77481612571, 45228.51243181591, 45258.321125183145, 1208.4924331780674, 1229.3730197599289, 1247.108317552954, 1257.5472829781454, 1266.1580049267318, 26515.0, 27053.458930820878, 27133.86433067822, 27493.315042893326, 27591.31021724473, 42370.0, 42673.359899602154, 42912.78543607262, 42954.0, 42969.14061718811, 283760.0, 285433.0, 286151.0, 286153.0, 286374.13625863474, 25232.116875909254, 25368.492630146924, 25979.480410392065, 26032.219033429028, 26106.477870442104, 42377.0, 42491.7875410621, 42841.571584285004, 43231.35152972645, 43340.13319733651, 36275.63724362723, 36658.63341366552, 36664.81667591645, 37084.81457592695, 37663.81168094142, 36338.0, 36807.0, 36932.26135477329, 37375.5705879117, 37624.62375376211, 33428.1642958928, 35789.5999880011, 36676.44985325169, 36757.26485470329, 36887.0, 32004.19989500281, 32600.184995375304, 33331.50002750009, 33528.49707254345, 33693.83153084219, 25495.872520637276, 26096.217113486626, 26135.215943521725, 26152.34619134537, 26585.601215981387], "value": 17451.8309024968, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.5148803579275, 369.4495202148797, 372.13293027246516, 373.3745975491052, 386.27958856732204, 15652.139132347716, 16853.073080980543, 16979.235934382952, 17277.0, 17368.392106276282, 15248.69502609947, 16868.662626747457, 17428.0, 17429.73855392167, 17472.82527174728, 4976.576990955773, 5091.134507133777, 5174.4049434314975, 5175.689458632475, 5184.507471790174, 3715.1269451678836, 5033.370828646419, 5570.0, 5834.474897259246, 5893.528517718593, 5847.8538036549, 5876.030454974924, 5895.616784908989, 5923.674197919113, 5959.582829201958, 5847.356790753014, 5884.911726324109, 6016.939830601704, 6023.156758053832, 6029.78895738647, 5218.269442278084, 5290.232916227164, 5297.390800058004, 5307.469253074701, 5363.570914326844, 17737.467875963743, 18836.811631883644, 20915.5816883663, 21468.677969830464, 21545.56908861814, 1937.9612407751765, 1953.7850836407983, 1992.1533348326902, 2000.2998950367255, 2357.552065107624, 8618.870716939251, 8981.461112333216, 8995.730128096167, 8999.0, 9246.537673116318, 1763.2858692229668, 1823.4256209294163, 1926.2198809482181, 1943.1644392911044, 1945.1441365799003, 67453.66273168652, 69689.30310696879, 69883.65058174677, 70125.64937175333, 70889.64555177192, 8847.778805529913, 9637.951810240904, 9955.452450115314, 10204.132648724793, 10341.327813692085, 13869.514566990107, 13896.374663140183, 13934.094283871516, 13969.58091257264, 13989.090709103875, 7484.700611975569, 7537.773866784005, 7639.923600763921, 7768.84462310762, 7778.572178530235, 7121.465890058266, 7122.821929451805, 7140.107486564179, 7253.455990800606, 7290.5625662460425, 3930.744501607386, 4083.9183216335505, 4158.334666453353, 4300.333448315516, 4404.559544045634, 1655.7433597792362, 1901.7622797150357, 2953.4536110819568, 3220.62962759281, 3452.223249768782, 746.5371469688719, 792.2354927494995, 856.9528675922884, 880.225401646547, 898.9505577193187, 16325.428609998593, 16393.016548959782, 16749.83250167507, 17036.2333694984, 17226.397076102527, 828.349745449819, 838.5639467476877, 849.3799526345803, 863.96976105836, 875.2254254984384, 8891.422057566237, 9335.486548239776, 9689.370190937567, 9762.560684769202, 9806.0, 362502.0, 368087.0, 368729.0, 370179.0, 374074.0, 72389.27610723826, 72723.63638181775, 73852.0, 75452.24547754561, 75725.0, 877.3332267476763, 878.912108789116, 886.078478382475, 888.8311220868144, 897.2373482539658, 14994.400223990919, 15272.923635381752, 15318.080915145127, 15441.845581544041, 15710.842891570937, 35505.644943550236, 36025.81987090048, 36469.27061458703, 37058.814705927376, 37512.624873750916, 48856.2671559934, 50382.49617503778, 50434.24348634847, 50653.74673126758, 50836.237456438925, 7518.360939320219, 7524.887126693214, 7525.8118547036765, 7546.547207167588, 7610.277023682741, 10701.571937122428, 11206.159538034517, 11250.0, 11729.178957473236, 11824.76350473003, 9220.216281616138, 9662.3236373456, 9942.701718948443, 10003.899961000297, 10152.695419137437, 10145.18838492904, 10164.79670406573, 10407.895921040996, 10424.478776061318, 10426.791464170827, 9789.0, 9987.250956178461, 10210.336328138646, 10417.583296668352, 10451.68644940653, 7423.0, 7647.88528172089, 7654.73208437702, 7688.846672999095, 7923.6830526778285, 7535.284148005931, 9918.0, 10276.845847312446, 10280.640177593748, 10414.323069000491], "value": 8268.197397822787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.4674676876018, 1402.8036074949507, 1471.8822494200465, 1653.3469279634537, 1653.743669731192, 6869.175698916125, 7561.357284630813, 7573.0, 8093.595320233987, 8094.676212951482, 7673.117591476982, 7849.0973538043145, 7903.3282171015535, 7904.881426778588, 7924.128345881948, 2200.8239340852733, 2249.055396733376, 2262.1064679451606, 2265.920692775753, 2270.330252575486, 2182.34529641107, 2207.0, 2231.564844855254, 2240.955180896381, 2241.9551608967813, 2217.3347995601334, 2224.5439684864646, 2225.121077174515, 2228.6211344071467, 2235.105957616958, 2156.579467003935, 2166.469215042317, 2175.0321107107343, 2175.1408193763455, 2190.1020581561643, 2097.8216851567636, 2124.4370241885913, 2137.016972192793, 2137.1985505435464, 2145.013293884815, 7817.609119544, 7829.960850195713, 7944.364450843918, 7945.761627151194, 7985.321247693953, 4596.655250856199, 4705.905881882378, 4711.599514041311, 4714.434267887841, 4738.786754596052, 2911.69427210142, 3015.2461884528866, 3037.4532584134845, 3065.0, 3071.43178511976, 999.3853779925366, 1008.5713571731984, 1009.9141572966307, 1015.3907655406771, 1037.0303765978833, 10639.734006649818, 10653.467326633638, 10661.09380702649, 10675.83986240207, 10694.144468442506, 4130.297849365615, 4246.235677578065, 4306.82772689089, 4314.9784251078545, 4329.956700433018, 8985.0, 9005.459672419545, 9006.144416280444, 9045.954770226239, 9067.863982040275, 4637.466691330473, 4645.187092258909, 4650.953490465052, 4652.511486293958, 4658.464276608233, 3798.1833905710405, 4090.8568200112854, 4125.91748165035, 4190.1200747843295, 4245.363195520635, 3647.6170002149925, 3657.7805331680183, 3684.244729830378, 3741.6258374162367, 3770.189409276964, 1186.792311345511, 1225.9387030648431, 1227.1593958138703, 1232.975340493203, 1245.2839617220134, 837.8198687282263, 861.143162553251, 866.9436486628349, 887.5473508510706, 910.01263628962, 5408.783648654088, 5639.154126881001, 5674.4892959633835, 5693.402192769782, 5720.08478643415, 798.2137594469443, 878.8813510176044, 910.3172620534599, 941.2422999485343, 965.8937516873139, 3546.361654902091, 3685.3734865073, 3703.333399988028, 3707.332680117551, 3759.2669429460993, 9335.346525743269, 9448.716538503855, 9679.661211857692, 9706.563204655808, 9773.46245956465, 9626.518674066268, 9631.855522167172, 9645.951770241103, 9655.420674759536, 9688.951555242178, 7120.145582530026, 7235.710571577183, 7283.927160728324, 7408.814779630552, 7435.293647103516, 5418.512333889968, 5447.400785913625, 5459.972700136474, 5585.329760428612, 5630.268065151504, 8841.955790221007, 9037.548122593975, 9109.863352049591, 9159.862602061108, 9186.31102667316, 8964.462132272085, 9026.232770214343, 9300.813983720423, 9312.161905428544, 9317.72046838596, 6200.627962322275, 6674.232463266787, 6937.653117344214, 6960.060391847036, 7100.289971002859, 7647.311741943252, 7660.5403675779635, 7716.807079822825, 7718.112417071884, 7791.922080779346, 6584.209894812653, 6837.042814006142, 6868.416184624363, 6949.583025018515, 6951.443884489127, 6686.598804071771, 6720.092787473628, 6777.559458635173, 6785.796426107225, 6911.3779759821855, 6155.322914479493, 6161.476274516537, 6230.127782110599, 6255.468285195628, 6271.3415091414745, 4713.08094921487, 4757.452892917358, 4766.713997160182, 4805.327254184347, 4818.277258411266, 4620.768961551842, 4636.907261854676, 4668.719876807267, 4707.505711900338, 4748.9050218994735], "value": 4217.05648847444, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.874472721457, 304.62531086763295, 306.4682775384707, 306.63663558682964, 314.5486227263876, 5154.149565321723, 5159.871003224912, 5160.20016897381, 5160.587153027758, 5172.715500647463, 5039.1433456312425, 5065.416637514875, 5078.060558796626, 5095.668781529198, 5101.821436249732, 3788.4317352397084, 3810.618938106181, 3945.112349721304, 3954.1893911748166, 3965.136385898623, 3915.2169566086754, 3978.9204215915665, 3980.4825372701653, 3983.506185180557, 3987.1427643056736, 3949.486566746333, 3962.6433620974108, 3968.246033253687, 3985.342418500944, 3987.501562304712, 3801.6388443097862, 3959.5842436544326, 3970.166265084336, 3979.462772525701, 3982.6017398260087, 3502.614712381636, 3510.7191424685966, 3536.522569453117, 3536.982315088434, 3542.326957877995, 4979.875503112415, 5028.321176641143, 5035.295058691786, 5036.697798132123, 5043.546080852704, 4386.1447017831215, 4573.977130114361, 4578.885527861797, 4583.152116858392, 4586.770661466913, 5253.474652534716, 5262.815996322208, 5280.920786188171, 5301.787928482856, 5307.416184219733, 3814.4850445189822, 3832.5017747692623, 3834.118152824838, 3849.6727778138893, 3858.151206734542, 5338.41277459483, 5556.888382414697, 5590.385057643656, 5601.831945041656, 5641.210230567724, 3865.9806700966315, 3867.2265546890735, 3886.8639597614515, 3901.45379646844, 3932.8426862925735, 3896.5908579598736, 3910.3743401055694, 3924.3917192834583, 3930.155016671429, 3931.4299426582984, 4501.41481607389, 4512.616427603625, 4527.411436513232, 4530.207213737649, 4538.2738761797955, 5152.665076770073, 5161.716105614228, 5279.551238144724, 5301.5493683037375, 5317.787288508416, 1357.5384369314481, 1376.8072469854228, 1379.751644703943, 1383.3774801339437, 1383.8131852200027, 852.8805967164602, 887.4453466583385, 899.7660608241773, 914.7347269291964, 918.7703074231442, 4464.2187617166865, 4555.246230201396, 4563.748993805372, 4629.305604159403, 4632.86101416958, 5402.91895621566, 5403.5136837684795, 5435.673859568438, 5440.836774896759, 5456.208849716769, 4527.524609915911, 4595.770211489479, 4606.332081848181, 4648.767561621906, 4653.883652908705, 2915.1983204618477, 2917.226934862263, 2932.1643331650375, 2949.7640188785276, 2958.748506376939, 5120.590352771769, 5121.743912804345, 5142.871428214325, 5148.150555158431, 5180.378354597472, 5412.188171774265, 5538.224648549206, 5555.861103472364, 5611.691356975405, 5622.803201887914, 5072.5688316493515, 5108.821191258288, 5123.8719032023755, 5149.459306772735, 5160.587153027674, 5468.207109969112, 5471.72641367938, 5478.479544443271, 5480.945190548203, 5531.640443371168, 5125.8974820502635, 5283.2075188722, 5349.753103696379, 5361.705106219196, 5450.127979523258, 5126.0, 5142.434332223377, 5146.202338637517, 5152.407473140487, 5170.870728231825, 3862.1310205204727, 3883.2427676602792, 3885.979290768841, 3886.2033283177448, 3896.279188350164, 5247.396549396715, 5408.8377348679605, 5431.2667789847865, 5455.399906010256, 5498.51540084183, 5284.6564973278155, 5309.7345132743985, 5312.62811603184, 5336.439673834347, 5351.518363347317, 5270.420253772006, 5316.6544174628525, 5331.4401987790725, 5349.545288650508, 5349.866253343697, 4971.850844474671, 5227.607929405233, 5240.34495688039, 5290.232916227203, 5305.469453054664, 5176.767045482887, 5208.218767184952, 5338.839834804962, 5382.407935127055, 5389.2455056291365, 5258.7904781899615, 5265.684058956322, 5266.683998960075, 5298.576113910801, 5309.442508536548], "value": 4006.091284804202, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.050689403848, 616.2512547255086, 629.5624540944045, 633.3096924352454, 691.3950293493193, 11876.940615296922, 11985.280883147007, 12290.38548072595, 12299.200551964115, 13008.609741707764, 14124.505642302522, 14561.92719036406, 14672.779908301358, 14693.044952078135, 14720.779188312184, 622.1414448061669, 765.3953376832324, 774.0479210570987, 786.8662327404327, 790.2492631999595, 767.6699019421646, 770.9284095107805, 771.0362047440699, 771.0824119298045, 771.1825465007082, 807.1524898856206, 812.2892469089546, 812.4150611559668, 812.5246730662569, 812.6505602590913, 803.6785285885634, 805.2672068417712, 806.0206848678854, 807.3057170833108, 807.8667019941703, 584.5440556366042, 584.5878655547829, 586.8092869817284, 588.2705445247861, 589.6815719511502, 11878.227915185485, 11908.821367679491, 11926.284422934565, 11930.164888457812, 11961.0, 12778.808317875239, 13130.737385252241, 13272.601821945356, 13435.731285374335, 13446.12600180995, 10593.699133369466, 10725.410102444363, 10778.191635627281, 10834.40410777407, 10948.835767463494, 3292.4732042873025, 3343.5820522434697, 3345.5149003394613, 3347.6484969078383, 3348.0, 62499.06251406232, 63114.68442657803, 63258.36741632617, 63447.0, 64144.67927660378, 10213.74465638365, 10227.539760710786, 10240.0, 10384.636537721144, 10450.216233782498, 18913.338033168773, 19153.52116197106, 19195.904020479808, 19221.0, 19268.22927082929, 6552.57408268461, 6588.8352791180605, 6641.468682505388, 6641.966790166115, 6746.696398662072, 3596.496490491333, 3709.554853417553, 3748.775073495599, 3766.0396598867114, 3804.410316400907, 3031.34826012404, 3103.5344698295435, 3124.9531257031163, 3142.1673256586564, 3150.747940164827, 520.3833457353048, 524.8215606693742, 534.2140736061381, 535.1464414259328, 540.6026570470701, 550.3615805665409, 568.8321945026228, 596.8836076965036, 600.5083511289236, 601.7923816283375, 7843.9607801961765, 8185.631646575918, 8682.869756953525, 8757.562121894007, 8970.730878073668, 522.3496746550569, 557.7378632042934, 569.3680015183144, 582.257621532541, 622.228436738441, 4012.217617564547, 4058.848338998177, 4130.979345103316, 4237.533871274158, 4278.44380230568, 87474.0, 90802.0, 91209.54395227981, 91739.20216781649, 92706.0, 75499.0, 79408.0, 79698.0, 80357.0, 81498.59250703709, 70797.29202708113, 71012.64493677602, 73443.63278183575, 73808.26191738121, 73925.63037184888, 7615.314621684075, 7750.689972401041, 7899.995537286121, 7921.089074756246, 8018.3184429324165, 42846.35730464108, 42967.785161073996, 44176.55823441724, 44383.77808111068, 44733.0, 56862.0, 57396.42603573911, 61002.38997610145, 64172.67913660402, 64444.67777661081, 9967.50162491887, 10147.594096236067, 10185.847212291674, 10230.590776368861, 10304.0, 12806.0, 13103.803442948554, 13178.934105329412, 14347.210903399995, 14419.85580144185, 11900.464479098287, 11960.282383057045, 12013.879861201276, 12513.749725005267, 13685.0, 11572.537098515964, 11648.76702465929, 11824.881751182378, 12530.310832904277, 12688.0, 10986.725331866768, 11189.72025699364, 11586.536538538365, 11788.941055294668, 12206.0, 9891.406515608798, 10663.46682665879, 10822.729431764268, 10828.5127169276, 11003.559857605605, 10261.640842570474, 10707.732306692084, 11196.496157672762, 11225.0, 11350.772984540428], "value": 6562.566029169919, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 114.0, 115.0, 115.0, 114.0, 114.0, 113.0, 114.0, 112.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 136.0, 168.0, 177.0, 133.0, 168.0, 162.0, 137.0, 189.0, 145.0], "value": 157.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 172.0, 167.0, 164.0, 165.0, 164.0, 163.0, 163.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 170.0, 79.0, 85.0, 74.0, 76.0, 172.0, 77.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 140.0, 87.0, 87.0, 87.0, 127.0, 87.0, 88.0, 157.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 154.0, 147.0, 148.0, 146.0, 147.0, 146.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 97.0, 96.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 63.0, 64.0, 64.0, 65.0, 63.0, 66.0, 63.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 67.0, 65.0, 65.0, 66.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 86.0, 85.0, 91.0, 85.0, 85.0, 85.0, 106.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 136.0, 141.0, 137.0, 131.0, 134.0, 151.0, 146.0, 137.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 169.0, 168.0, 170.0, 170.0, 174.0, 174.0, 173.0, 173.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 68.0, 70.0, 66.0, 67.0, 68.0, 72.0, 68.0], "value": 68.6, "unit": "score"}]}]} 05:07:01 INFO - Return code: 0 05:07:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:07:01 ERROR - # TBPL SUCCESS # 05:07:01 INFO - Running post-action listener: _resource_record_post_action 05:07:01 INFO - ##### 05:07:01 INFO - ##### Finished run-tests step (success) 05:07:01 INFO - ##### 05:07:01 INFO - Running post-run listener: _resource_record_post_run 05:07:01 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 310300672; Read time: 200; Write time: 222524 05:07:01 INFO - TinderboxPrint: CPU usage
13.4% 05:07:01 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 200 05:07:01 INFO - TinderboxPrint: I/O write bytes / time
310,300,672 / 222,524 05:07:01 INFO - TinderboxPrint: CPU idle
8,277.7 (86.5%) 05:07:01 INFO - TinderboxPrint: CPU user
1,232.5 (12.9%) 05:07:01 INFO - TinderboxPrint: Swap in / out
0 / 0 05:07:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14327808; Read time: 0; Write time: 9556 05:07:01 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295972864; Read time: 200; Write time: 212968 05:07:02 INFO - Running post-run listener: _upload_blobber_files 05:07:02 INFO - Blob upload gear active. 05:07:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:07:02 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:07:02 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:07:02 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:07:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:07:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:03 INFO - (blobuploader) - INFO - Done attempting. 05:07:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:07:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:07:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:06 INFO - (blobuploader) - INFO - Done attempting. 05:07:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:07:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:07:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:07 INFO - (blobuploader) - INFO - Done attempting. 05:07:07 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:07 INFO - Return code: 0 05:07:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09176e4ebf04c88351e3b694f7eabd5c79915e2e0ffd2660689ad4f3d0a4326abcd8775e75985bc7d5f3ce03858a58204898d99173f0db730b5e693f40253552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c25f99d7c570da3edbc872071df4904c443618cd12fffcd1e9cce05f987101b5fdbe407d0acc560f9170b5f11deb95c4f7308b04d355676c347a51f547206b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ead55411fcd6d42bde8958c3902824db5ab6e6a07a3edac8c6fc2503bfaa78060114296bd2fac272b2f6107a9a4070ccedb620852d34e9db68907d3850494198"} 05:07:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:07 INFO - Contents: 05:07:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09176e4ebf04c88351e3b694f7eabd5c79915e2e0ffd2660689ad4f3d0a4326abcd8775e75985bc7d5f3ce03858a58204898d99173f0db730b5e693f40253552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c25f99d7c570da3edbc872071df4904c443618cd12fffcd1e9cce05f987101b5fdbe407d0acc560f9170b5f11deb95c4f7308b04d355676c347a51f547206b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ead55411fcd6d42bde8958c3902824db5ab6e6a07a3edac8c6fc2503bfaa78060114296bd2fac272b2f6107a9a4070ccedb620852d34e9db68907d3850494198"} 05:07:07 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:07 INFO - Copying logs to upload dir... 05:07:07 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.351822 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-06-22 05:07:07.011820) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:07.015574) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315 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-Non-PGO/sha512/09176e4ebf04c88351e3b694f7eabd5c79915e2e0ffd2660689ad4f3d0a4326abcd8775e75985bc7d5f3ce03858a58204898d99173f0db730b5e693f40253552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c25f99d7c570da3edbc872071df4904c443618cd12fffcd1e9cce05f987101b5fdbe407d0acc560f9170b5f11deb95c4f7308b04d355676c347a51f547206b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ead55411fcd6d42bde8958c3902824db5ab6e6a07a3edac8c6fc2503bfaa78060114296bd2fac272b2f6107a9a4070ccedb620852d34e9db68907d3850494198"} build_url:https://queue.taskcluster.net/v1/task/Q9voajH8SvGYF_0vEp4__g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011489 build_url: 'https://queue.taskcluster.net/v1/task/Q9voajH8SvGYF_0vEp4__g/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-Non-PGO/sha512/09176e4ebf04c88351e3b694f7eabd5c79915e2e0ffd2660689ad4f3d0a4326abcd8775e75985bc7d5f3ce03858a58204898d99173f0db730b5e693f40253552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c25f99d7c570da3edbc872071df4904c443618cd12fffcd1e9cce05f987101b5fdbe407d0acc560f9170b5f11deb95c4f7308b04d355676c347a51f547206b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ead55411fcd6d42bde8958c3902824db5ab6e6a07a3edac8c6fc2503bfaa78060114296bd2fac272b2f6107a9a4070ccedb620852d34e9db68907d3850494198"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:07.041491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:07.041897) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466592071.224064-111076315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:07.126395) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 05:07:07.126807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 05:07:07.127276) ========= ========= Total master_lag: 0.18 =========