builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1461923133.33 results: success (0) buildid: 20160429020646 builduid: 8af7154fbbc342e0a08a2b98cdaa9071 revision: 70b3e6ac383941005652196f432d9134dea468a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 02:45:33.329715) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 02:45:33.330384) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 02:45:33.330726) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 02:45:33.348823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 02:45:33.349111) ========= 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-1461922614.425881-1385736047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 02:45:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 85.6M=0s 2016-04-29 02:45:34 (85.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149373 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 02:45:33.511374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 02:45:33.511672) ========= 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-1461922614.425881-1385736047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015029 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 02:45:33.562877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 02:45:33.563227) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 70b3e6ac383941005652196f432d9134dea468a7 --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 70b3e6ac383941005652196f432d9134dea468a7 --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-1461922614.425881-1385736047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 02:45:34,231 truncating revision to first 12 chars 2016-04-29 02:45:34,231 Setting DEBUG logging. 2016-04-29 02:45:34,231 attempt 1/10 2016-04-29 02:45:34,232 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/70b3e6ac3839?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 02:45:34,466 unpacking tar archive at: fx-team-70b3e6ac3839/testing/mozharness/ program finished with exit code 0 elapsedTime=0.493407 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 02:45:34.072085) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 02:45:34.072504) ========= script_repo_revision: 70b3e6ac383941005652196f432d9134dea468a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 02:45:34.073050) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 02:45:34.073345) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 02:45:34.083800) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-29 02:45:34.084261) ========= /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-1461922614.425881-1385736047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:45:34 INFO - MultiFileLogger online at 20160429 02:45:34 in /builds/slave/test 02:45:34 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 02:45:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:45:34 INFO - {'append_to_log': False, 02:45:34 INFO - 'base_work_dir': '/builds/slave/test', 02:45:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:45:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:45:34 INFO - 'branch': 'Fx-Team-Non-PGO', 02:45:34 INFO - 'buildbot_json_path': 'buildprops.json', 02:45:34 INFO - 'config_files': ('talos/linux_config.py',), 02:45:34 INFO - 'default_actions': ('clobber', 02:45:34 INFO - 'read-buildbot-config', 02:45:34 INFO - 'download-and-extract', 02:45:34 INFO - 'populate-webroot', 02:45:34 INFO - 'create-virtualenv', 02:45:34 INFO - 'install', 02:45:34 INFO - 'run-tests'), 02:45:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:45:34 INFO - 'download_minidump_stackwalk': True, 02:45:34 INFO - 'download_symbols': 'ondemand', 02:45:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:45:34 INFO - 'tooltool.py': '/tools/tooltool.py', 02:45:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:45:34 INFO - '/tools/misc-python/virtualenv.py')}, 02:45:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:45:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:45:34 INFO - 'installer_path': 'installer.exe', 02:45:34 INFO - 'log_level': 'info', 02:45:34 INFO - 'log_name': 'talos', 02:45:34 INFO - 'log_to_console': True, 02:45:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:45:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:45:34 INFO - 'opt_config_files': (), 02:45:34 INFO - 'pip_index': False, 02:45:34 INFO - 'sps_profile': False, 02:45:34 INFO - 'sps_profile_interval': 0, 02:45:34 INFO - 'suite': 'dromaeojs-e10s', 02:45:34 INFO - 'system_bits': '32', 02:45:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:45:34 INFO - 'title': 'talos-linux64-ix-002', 02:45:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:45:34 INFO - 'use_talos_json': True, 02:45:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:45:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:45:34 INFO - 'work_dir': 'build'} 02:45:34 INFO - ##### 02:45:34 INFO - ##### Running clobber step. 02:45:34 INFO - ##### 02:45:34 INFO - Running pre-action listener: _resource_record_pre_action 02:45:34 INFO - Running main action method: clobber 02:45:34 INFO - rmtree: /builds/slave/test/build 02:45:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:45:35 INFO - Running post-action listener: _resource_record_post_action 02:45:35 INFO - ##### 02:45:35 INFO - ##### Running read-buildbot-config step. 02:45:35 INFO - ##### 02:45:35 INFO - Running pre-action listener: _resource_record_pre_action 02:45:35 INFO - Running main action method: read_buildbot_config 02:45:35 INFO - Using buildbot properties: 02:45:35 INFO - { 02:45:35 INFO - "project": "", 02:45:35 INFO - "product": "firefox", 02:45:35 INFO - "script_repo_revision": "production", 02:45:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:45:35 INFO - "repository": "", 02:45:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:45:35 INFO - "buildid": "20160429020646", 02:45:35 INFO - "pgo_build": "False", 02:45:35 INFO - "basedir": "/builds/slave/test", 02:45:35 INFO - "buildnumber": 1233, 02:45:35 INFO - "slavename": "talos-linux64-ix-002", 02:45:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:45:35 INFO - "platform": "ubuntu64_hw", 02:45:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:45:35 INFO - "branch": "fx-team", 02:45:35 INFO - "repo_path": "integration/fx-team", 02:45:35 INFO - "revision": "70b3e6ac383941005652196f432d9134dea468a7", 02:45:35 INFO - "stage_platform": "linux64", 02:45:35 INFO - "builduid": "8af7154fbbc342e0a08a2b98cdaa9071", 02:45:35 INFO - "slavebuilddir": "test" 02:45:35 INFO - } 02:45:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:45:35 INFO - Running post-action listener: _resource_record_post_action 02:45:35 INFO - ##### 02:45:35 INFO - ##### Running download-and-extract step. 02:45:35 INFO - ##### 02:45:35 INFO - Running pre-action listener: _resource_record_pre_action 02:45:35 INFO - Running main action method: download_and_extract 02:45:35 INFO - mkdir: /builds/slave/test/build/tests 02:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:35 INFO - https://queue.taskcluster.net/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:45:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:45:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:45:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:45:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:45:44 INFO - Downloaded 1361 bytes. 02:45:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:45:44 INFO - Using the following test package requirements: 02:45:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:45:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:45:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:45:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:44 INFO - u'jsshell-linux-x86_64.zip'], 02:45:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:45:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:45:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:45:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:45:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:45:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:45:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02: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')]} 02:45:44 INFO - https://queue.taskcluster.net/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:45:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:45:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:45:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:45:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:45:45 INFO - Downloaded 22301146 bytes. 02:45:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:45:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:45:46 INFO - Return code: 0 02:45:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02: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')]} 02:45:46 INFO - https://queue.taskcluster.net/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:45:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:45:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:45:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:45:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:45:49 INFO - Downloaded 22301146 bytes. 02:45:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:45:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:45:51 INFO - Return code: 0 02:45: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')]} 02:45:51 INFO - https://queue.taskcluster.net/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:45:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:45:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:45:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:45:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:45:52 INFO - Downloaded 10840145 bytes. 02:45:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:45:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:45:52 INFO - Return code: 0 02:45:52 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')]} 02:45:52 INFO - https://queue.taskcluster.net/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:45:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:45:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:45:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:45:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:45:53 INFO - Downloaded 54849863 bytes. 02:45:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:45:53 INFO - mkdir: /builds/slave/test/properties 02:45:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:45:53 INFO - Writing to file /builds/slave/test/properties/build_url 02:45:53 INFO - Contents: 02:45:53 INFO - build_url:https://queue.taskcluster.net/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:45:54 INFO - Running post-action listener: _resource_record_post_action 02:45:54 INFO - Running post-action listener: set_extra_try_arguments 02:45:54 INFO - ##### 02:45:54 INFO - ##### Running populate-webroot step. 02:45:54 INFO - ##### 02:45:54 INFO - Running pre-action listener: _resource_record_pre_action 02:45:54 INFO - Running main action method: populate_webroot 02:45:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:45:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:45:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:45:54 INFO - '--tppagecycles', 02:45:54 INFO - '7'], 02:45:54 INFO - 'tests': ['tsvgm']}}, 02:45:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:45:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:45:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:45:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:45:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:45:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:45:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:54 INFO - 'talos_options': ['--disable-e10s'], 02:45:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:45:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:45:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:54 INFO - 'talos_options': ['--disable-e10s'], 02:45:54 INFO - 'tests': ['damp', 'tps']}, 02:45:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:54 INFO - 'tests': ['damp', 'tps']}, 02:45:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:45:54 INFO - 'tests': ['dromaeo_dom']}, 02:45:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:45:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:45:54 INFO - 'tests': ['a11yr', 02:45:54 INFO - 'ts_paint', 02:45:54 INFO - 'tpaint', 02:45:54 INFO - 'sessionrestore', 02:45:54 INFO - 'sessionrestore_no_auto_restore', 02:45:54 INFO - 'tabpaint']}, 02:45:54 INFO - 'other-e10s': {'tests': ['a11yr', 02:45:54 INFO - 'ts_paint', 02:45:54 INFO - 'tpaint', 02:45:54 INFO - 'sessionrestore', 02:45:54 INFO - 'sessionrestore_no_auto_restore', 02:45:54 INFO - 'tabpaint']}, 02:45:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:45:54 INFO - 'ts_paint', 02:45:54 INFO - 'tpaint', 02:45:54 INFO - 'sessionrestore', 02:45:54 INFO - 'sessionrestore_no_auto_restore', 02:45:54 INFO - 'tabpaint']}, 02:45:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:45:54 INFO - 'ts_paint', 02:45:54 INFO - 'tpaint', 02:45:54 INFO - 'sessionrestore', 02:45:54 INFO - 'sessionrestore_no_auto_restore', 02:45:54 INFO - 'tabpaint']}, 02:45:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:45:54 INFO - 'tests': ['a11yr', 02:45:54 INFO - 'ts_paint', 02:45:54 INFO - 'tpaint', 02:45:54 INFO - 'sessionrestore', 02:45:54 INFO - 'sessionrestore_no_auto_restore', 02:45:54 INFO - 'tabpaint']}, 02:45:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:45:54 INFO - 'tests': ['a11yr', 02:45:54 INFO - 'ts_paint', 02:45:54 INFO - 'tpaint', 02:45:54 INFO - 'sessionrestore', 02:45:54 INFO - 'sessionrestore_no_auto_restore', 02:45:54 INFO - 'tabpaint']}, 02:45:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:45:54 INFO - 'tests': ['tsvgx', 02:45:54 INFO - 'tsvgr_opacity', 02:45:54 INFO - 'tart', 02:45:54 INFO - 'tscrollx', 02:45:54 INFO - 'cart']}, 02:45:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:45:54 INFO - 'tsvgr_opacity', 02:45:54 INFO - 'tart', 02:45:54 INFO - 'tscrollx', 02:45:54 INFO - 'cart']}, 02:45:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:54 INFO - 'talos_options': ['--disable-e10s'], 02:45:54 INFO - 'tests': ['tp5o']}, 02:45:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:54 INFO - 'tests': ['tp5o']}, 02:45:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:54 INFO - 'talos_options': ['--disable-e10s', 02:45:54 INFO - '--xperf_path', 02:45:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:45:54 INFO - 'tests': ['tp5n']}, 02:45:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:54 INFO - 'talos_options': ['--xperf_path', 02:45:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:45:54 INFO - 'tests': ['tp5n']}}, 02:45:54 INFO - 'talos.zip': {'path': '', 02:45:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:45:54 INFO - Running post-action listener: _resource_record_post_action 02:45:54 INFO - ##### 02:45:54 INFO - ##### Running create-virtualenv step. 02:45:54 INFO - ##### 02:45:54 INFO - Running pre-action listener: _resource_record_pre_action 02:45:54 INFO - Running main action method: create_virtualenv 02:45:54 INFO - Creating virtualenv /builds/slave/test/build/venv 02:45:54 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 02:45:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:45:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:45:54 INFO - Using real prefix '/usr' 02:45:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:45:55 INFO - Installing distribute.............................................................................................................................................................................................done. 02:45:57 INFO - Installing pip.................done. 02:45:57 INFO - Return code: 0 02:45:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:45:57 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')]} 02:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:57 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')]} 02:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:57 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 0x7f179f640f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d63410>, '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 0x2d64310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d647a0>, '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-1461922614.425881-1385736047', '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 02:45:57 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 02:45:57 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 02:45:57 INFO - Using env: {'DISPLAY': ':0', 02:45:57 INFO - 'HOME': '/home/cltbld', 02:45:57 INFO - 'LANG': 'en_US.UTF-8', 02:45:57 INFO - 'LANGUAGE': 'en_US:en', 02:45:57 INFO - 'LOGNAME': 'cltbld', 02:45:57 INFO - 'MAIL': '/var/mail/cltbld', 02:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:57 INFO - 'MOZ_NO_REMOTE': '1', 02:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:57 INFO - 'NO_EM_RESTART': '1', 02:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:57 INFO - 'PWD': '/builds/slave/test', 02:45:57 INFO - 'SHELL': '/bin/bash', 02:45:57 INFO - 'SHLVL': '1', 02:45:57 INFO - 'TERM': 'linux', 02:45:57 INFO - 'TMOUT': '86400', 02:45:57 INFO - 'USER': 'cltbld', 02:45:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461922614.425881-1385736047', 02:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:57 INFO - '_': '/tools/buildbot/bin/python'} 02:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:57 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 02:45:57 INFO - Cleaning up... 02:45:57 INFO - Return code: 0 02:45:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:45:57 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')]} 02:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:57 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')]} 02:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:57 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f179f640f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d63410>, '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 0x2d64310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d647a0>, '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-1461922614.425881-1385736047', '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 02:45:57 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>=0.7.1'] in /builds/slave/test/build 02:45:57 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>=0.7.1 02:45:57 INFO - Using env: {'DISPLAY': ':0', 02:45:57 INFO - 'HOME': '/home/cltbld', 02:45:57 INFO - 'LANG': 'en_US.UTF-8', 02:45:57 INFO - 'LANGUAGE': 'en_US:en', 02:45:57 INFO - 'LOGNAME': 'cltbld', 02:45:57 INFO - 'MAIL': '/var/mail/cltbld', 02:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:57 INFO - 'MOZ_NO_REMOTE': '1', 02:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:57 INFO - 'NO_EM_RESTART': '1', 02:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:57 INFO - 'PWD': '/builds/slave/test', 02:45:57 INFO - 'SHELL': '/bin/bash', 02:45:57 INFO - 'SHLVL': '1', 02:45:57 INFO - 'TERM': 'linux', 02:45:57 INFO - 'TMOUT': '86400', 02:45:57 INFO - 'USER': 'cltbld', 02:45:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461922614.425881-1385736047', 02:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:57 INFO - '_': '/tools/buildbot/bin/python'} 02:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:57 INFO - Downloading/unpacking psutil>=0.7.1 02:45:57 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 02:45:57 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 02:45:57 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 02:45:57 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 02:45:57 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 02:45:57 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 02:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:45:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:59 INFO - Installing collected packages: psutil 02:45:59 INFO - Running setup.py install for psutil 02:45:59 INFO - building 'psutil._psutil_linux' extension 02:45:59 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 02:45:59 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 02:46:00 INFO - building 'psutil._psutil_posix' extension 02:46:00 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 02:46:00 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 02:46:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:46:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:46:00 INFO - Successfully installed psutil 02:46:00 INFO - Cleaning up... 02:46:00 INFO - Return code: 0 02:46:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:46:00 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')]} 02:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:00 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')]} 02:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:00 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f179f640f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d63410>, '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 0x2d64310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d647a0>, '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-1461922614.425881-1385736047', '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 02:46:00 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.0.0'] in /builds/slave/test/build 02:46:00 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.0.0 02:46:00 INFO - Using env: {'DISPLAY': ':0', 02:46:00 INFO - 'HOME': '/home/cltbld', 02:46:00 INFO - 'LANG': 'en_US.UTF-8', 02:46:00 INFO - 'LANGUAGE': 'en_US:en', 02:46:00 INFO - 'LOGNAME': 'cltbld', 02:46:00 INFO - 'MAIL': '/var/mail/cltbld', 02:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:00 INFO - 'MOZ_NO_REMOTE': '1', 02:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:00 INFO - 'NO_EM_RESTART': '1', 02:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:00 INFO - 'PWD': '/builds/slave/test', 02:46:00 INFO - 'SHELL': '/bin/bash', 02:46:00 INFO - 'SHLVL': '1', 02:46:00 INFO - 'TERM': 'linux', 02:46:00 INFO - 'TMOUT': '86400', 02:46:00 INFO - 'USER': 'cltbld', 02:46:00 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461922614.425881-1385736047', 02:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:00 INFO - '_': '/tools/buildbot/bin/python'} 02:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:46:02 INFO - Installing collected packages: mozsystemmonitor 02:46:02 INFO - Running setup.py install for mozsystemmonitor 02:46:02 INFO - Successfully installed mozsystemmonitor 02:46:02 INFO - Cleaning up... 02:46:02 INFO - Return code: 0 02:46:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:02 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 0x7f179f640f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d63410>, '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 0x2d64310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d647a0>, '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-1461922614.425881-1385736047', '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 02:46:02 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 02:46:02 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 02:46:02 INFO - Using env: {'DISPLAY': ':0', 02:46:02 INFO - 'HOME': '/home/cltbld', 02:46:02 INFO - 'LANG': 'en_US.UTF-8', 02:46:02 INFO - 'LANGUAGE': 'en_US:en', 02:46:02 INFO - 'LOGNAME': 'cltbld', 02:46:02 INFO - 'MAIL': '/var/mail/cltbld', 02:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:02 INFO - 'MOZ_NO_REMOTE': '1', 02:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:02 INFO - 'NO_EM_RESTART': '1', 02:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:02 INFO - 'PWD': '/builds/slave/test', 02:46:02 INFO - 'SHELL': '/bin/bash', 02:46:02 INFO - 'SHLVL': '1', 02:46:02 INFO - 'TERM': 'linux', 02:46:02 INFO - 'TMOUT': '86400', 02:46:02 INFO - 'USER': 'cltbld', 02:46:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461922614.425881-1385736047', 02:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:02 INFO - '_': '/tools/buildbot/bin/python'} 02:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:02 INFO - Downloading/unpacking blobuploader==1.2.4 02:46:02 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 02:46:02 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 02:46:02 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 02:46:02 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 02:46:02 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 02:46:02 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 02:46:04 INFO - Downloading blobuploader-1.2.4.tar.gz 02:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:46:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:46:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:46:05 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 02:46:05 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 02:46:05 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 02:46:05 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 02:46:05 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 02:46:05 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 02:46:05 INFO - Downloading docopt-0.6.1.tar.gz 02:46:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:46:05 INFO - Installing collected packages: blobuploader, requests, docopt 02:46:05 INFO - Running setup.py install for blobuploader 02:46:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:46:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:46:05 INFO - Running setup.py install for requests 02:46:05 INFO - Running setup.py install for docopt 02:46:05 INFO - Successfully installed blobuploader requests docopt 02:46:05 INFO - Cleaning up... 02:46:06 INFO - Return code: 0 02:46:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:06 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 0x7f179f640f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d63410>, '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 0x2d64310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d647a0>, '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-1461922614.425881-1385736047', '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 02:46:06 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 02:46:06 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 02:46:06 INFO - Using env: {'DISPLAY': ':0', 02:46:06 INFO - 'HOME': '/home/cltbld', 02:46:06 INFO - 'LANG': 'en_US.UTF-8', 02:46:06 INFO - 'LANGUAGE': 'en_US:en', 02:46:06 INFO - 'LOGNAME': 'cltbld', 02:46:06 INFO - 'MAIL': '/var/mail/cltbld', 02:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:06 INFO - 'MOZ_NO_REMOTE': '1', 02:46:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:06 INFO - 'NO_EM_RESTART': '1', 02:46:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:06 INFO - 'PWD': '/builds/slave/test', 02:46:06 INFO - 'SHELL': '/bin/bash', 02:46:06 INFO - 'SHLVL': '1', 02:46:06 INFO - 'TERM': 'linux', 02:46:06 INFO - 'TMOUT': '86400', 02:46:06 INFO - 'USER': 'cltbld', 02:46:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461922614.425881-1385736047', 02:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:06 INFO - '_': '/tools/buildbot/bin/python'} 02:46:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:06 INFO - Running setup.py (path:/tmp/pip-25Eemb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:06 INFO - Running setup.py (path:/tmp/pip-l9TL5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:06 INFO - Running setup.py (path:/tmp/pip-cdvOAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:06 INFO - Running setup.py (path:/tmp/pip-lEHbTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:06 INFO - Running setup.py (path:/tmp/pip-YA0h2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:06 INFO - Running setup.py (path:/tmp/pip-TuLijM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:06 INFO - Running setup.py (path:/tmp/pip-cUvFFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:06 INFO - Running setup.py (path:/tmp/pip-0crbLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:06 INFO - Running setup.py (path:/tmp/pip-UTj7YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:06 INFO - Running setup.py (path:/tmp/pip-nlyxDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:06 INFO - Running setup.py (path:/tmp/pip-t4wPMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:07 INFO - Running setup.py (path:/tmp/pip-eohBRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:07 INFO - Running setup.py (path:/tmp/pip-0Kms9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:07 INFO - Running setup.py (path:/tmp/pip-VfsioD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:07 INFO - Running setup.py (path:/tmp/pip-zqQDth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:07 INFO - Running setup.py (path:/tmp/pip-zacaMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:07 INFO - Running setup.py (path:/tmp/pip-3Iobjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:46:07 INFO - Running setup.py install for manifestparser 02:46:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:46:07 INFO - Running setup.py install for mozcrash 02:46:07 INFO - Running setup.py install for mozdebug 02:46:07 INFO - Running setup.py install for mozdevice 02:46:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:46:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:46:07 INFO - Running setup.py install for mozfile 02:46:08 INFO - Running setup.py install for mozhttpd 02:46:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:46:08 INFO - Running setup.py install for mozinfo 02:46:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:46:08 INFO - Running setup.py install for mozInstall 02:46:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:46:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:46:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:46:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:46:08 INFO - Running setup.py install for mozleak 02:46:08 INFO - Running setup.py install for mozlog 02:46:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:46:08 INFO - Running setup.py install for moznetwork 02:46:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:46:08 INFO - Running setup.py install for mozprocess 02:46:08 INFO - Running setup.py install for mozprofile 02:46:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:46:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:46:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:46:08 INFO - Running setup.py install for mozrunner 02:46:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:46:08 INFO - Running setup.py install for mozscreenshot 02:46:09 INFO - Running setup.py install for moztest 02:46:09 INFO - Running setup.py install for mozversion 02:46:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:46:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:46:09 INFO - Cleaning up... 02:46:09 INFO - Return code: 0 02:46:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:09 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 0x7f179f640f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d63410>, '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 0x2d64310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d647a0>, '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-1461922614.425881-1385736047', '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 02:46:09 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 02:46:09 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 02:46:09 INFO - Using env: {'DISPLAY': ':0', 02:46:09 INFO - 'HOME': '/home/cltbld', 02:46:09 INFO - 'LANG': 'en_US.UTF-8', 02:46:09 INFO - 'LANGUAGE': 'en_US:en', 02:46:09 INFO - 'LOGNAME': 'cltbld', 02:46:09 INFO - 'MAIL': '/var/mail/cltbld', 02:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:09 INFO - 'MOZ_NO_REMOTE': '1', 02:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:09 INFO - 'NO_EM_RESTART': '1', 02:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:09 INFO - 'PWD': '/builds/slave/test', 02:46:09 INFO - 'SHELL': '/bin/bash', 02:46:09 INFO - 'SHLVL': '1', 02:46:09 INFO - 'TERM': 'linux', 02:46:09 INFO - 'TMOUT': '86400', 02:46:09 INFO - 'USER': 'cltbld', 02:46:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461922614.425881-1385736047', 02:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:09 INFO - '_': '/tools/buildbot/bin/python'} 02:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:09 INFO - Running setup.py (path:/tmp/pip-rL6ynR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:09 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)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:09 INFO - Running setup.py (path:/tmp/pip-83WSrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:09 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)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:09 INFO - Running setup.py (path:/tmp/pip-BvZSZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:09 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)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:09 INFO - Running setup.py (path:/tmp/pip-Dz1Qnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:09 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)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:09 INFO - Running setup.py (path:/tmp/pip-FpS3nK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:09 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)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:09 INFO - Running setup.py (path:/tmp/pip-65rOpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:09 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)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:09 INFO - Running setup.py (path:/tmp/pip-W40bau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:09 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)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:09 INFO - Running setup.py (path:/tmp/pip-TxPno3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:10 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)) 02:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:10 INFO - Running setup.py (path:/tmp/pip-v3nvPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:10 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)) 02:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:10 INFO - Running setup.py (path:/tmp/pip-Wj9Zvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 02:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:10 INFO - Running setup.py (path:/tmp/pip-4_qdwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:10 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)) 02:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:10 INFO - Running setup.py (path:/tmp/pip-P3ajgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:10 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)) 02:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:10 INFO - Running setup.py (path:/tmp/pip-urWtDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:10 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)) 02:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:10 INFO - Running setup.py (path:/tmp/pip-wHeXw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:10 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)) 02:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:10 INFO - Running setup.py (path:/tmp/pip-eOCabk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:10 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)) 02:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:10 INFO - Running setup.py (path:/tmp/pip-CNvbqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:10 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)) 02:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:10 INFO - Running setup.py (path:/tmp/pip-zkCy0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:10 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)) 02:46:10 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)) 02:46:10 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)) 02:46:10 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)) 02:46:10 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)) 02:46:10 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)) 02:46:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:46:10 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 02:46:10 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 02:46:10 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 02:46:10 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 02:46:10 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 02:46:10 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 02:46:12 INFO - Downloading blessings-1.6.tar.gz 02:46:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:46:12 INFO - Installing collected packages: blessings 02:46:12 INFO - Running setup.py install for blessings 02:46:12 INFO - Successfully installed blessings 02:46:12 INFO - Cleaning up... 02:46:12 INFO - Return code: 0 02:46:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:46:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:13 INFO - Reading from file tmpfile_stdout 02:46:13 INFO - Current package versions: 02:46:13 INFO - argparse == 1.2.1 02:46:13 INFO - blessings == 1.6 02:46:13 INFO - blobuploader == 1.2.4 02:46:13 INFO - docopt == 0.6.1 02:46:13 INFO - manifestparser == 1.1 02:46:13 INFO - mozInstall == 1.12 02:46:13 INFO - mozcrash == 0.17 02:46:13 INFO - mozdebug == 0.1 02:46:13 INFO - mozdevice == 0.48 02:46:13 INFO - mozfile == 1.2 02:46:13 INFO - mozhttpd == 0.7 02:46:13 INFO - mozinfo == 0.9 02:46:13 INFO - mozleak == 0.1 02:46:13 INFO - mozlog == 3.1 02:46:13 INFO - moznetwork == 0.27 02:46:13 INFO - mozprocess == 0.22 02:46:13 INFO - mozprofile == 0.28 02:46:13 INFO - mozrunner == 6.11 02:46:13 INFO - mozscreenshot == 0.1 02:46:13 INFO - mozsystemmonitor == 0.0 02:46:13 INFO - moztest == 0.7 02:46:13 INFO - mozversion == 1.4 02:46:13 INFO - psutil == 3.1.1 02:46:13 INFO - requests == 1.2.3 02:46:13 INFO - wsgiref == 0.1.2 02:46:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:13 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')]} 02:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:13 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')]} 02:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:13 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 0x7f179f640f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d63410>, '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 0x2d64310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d647a0>, '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-1461922614.425881-1385736047', '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 02:46:13 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 02:46:13 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 02:46:13 INFO - Using env: {'DISPLAY': ':0', 02:46:13 INFO - 'HOME': '/home/cltbld', 02:46:13 INFO - 'LANG': 'en_US.UTF-8', 02:46:13 INFO - 'LANGUAGE': 'en_US:en', 02:46:13 INFO - 'LOGNAME': 'cltbld', 02:46:13 INFO - 'MAIL': '/var/mail/cltbld', 02:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:13 INFO - 'MOZ_NO_REMOTE': '1', 02:46:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:13 INFO - 'NO_EM_RESTART': '1', 02:46:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:13 INFO - 'PWD': '/builds/slave/test', 02:46:13 INFO - 'SHELL': '/bin/bash', 02:46:13 INFO - 'SHLVL': '1', 02:46:13 INFO - 'TERM': 'linux', 02:46:13 INFO - 'TMOUT': '86400', 02:46:13 INFO - 'USER': 'cltbld', 02:46:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461922614.425881-1385736047', 02:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:13 INFO - '_': '/tools/buildbot/bin/python'} 02:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:13 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)) 02:46:13 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)) 02:46:13 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)) 02:46:13 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)) 02:46:13 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)) 02:46:13 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)) 02:46:13 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)) 02:46:13 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)) 02:46:13 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)) 02:46:13 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)) 02:46:13 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)) 02:46:13 INFO - Cleaning up... 02:46:13 INFO - Return code: 0 02:46:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:46:13 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')]} 02:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:13 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')]} 02:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:13 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 0x7f179f640f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d63410>, '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 0x2d64310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d647a0>, '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-1461922614.425881-1385736047', '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 02:46:13 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 02:46:13 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 02:46:13 INFO - Using env: {'DISPLAY': ':0', 02:46:13 INFO - 'HOME': '/home/cltbld', 02:46:13 INFO - 'LANG': 'en_US.UTF-8', 02:46:13 INFO - 'LANGUAGE': 'en_US:en', 02:46:13 INFO - 'LOGNAME': 'cltbld', 02:46:13 INFO - 'MAIL': '/var/mail/cltbld', 02:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:13 INFO - 'MOZ_NO_REMOTE': '1', 02:46:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:13 INFO - 'NO_EM_RESTART': '1', 02:46:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:13 INFO - 'PWD': '/builds/slave/test', 02:46:13 INFO - 'SHELL': '/bin/bash', 02:46:13 INFO - 'SHLVL': '1', 02:46:13 INFO - 'TERM': 'linux', 02:46:13 INFO - 'TMOUT': '86400', 02:46:13 INFO - 'USER': 'cltbld', 02:46:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461922614.425881-1385736047', 02:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:13 INFO - '_': '/tools/buildbot/bin/python'} 02:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:13 INFO - Downloading/unpacking jsonschema 02:46:13 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 02:46:13 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 02:46:13 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 02:46:13 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 02:46:13 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 02:46:13 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 02:46:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:46:15 INFO - Downloading/unpacking functools32 (from jsonschema) 02:46:15 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 02:46:15 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 02:46:15 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 02:46:15 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 02:46:15 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 02:46:15 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 02:46:15 INFO - Downloading functools32-3.2.3-2.tar.gz 02:46:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:46:15 INFO - warning: no files found matching '*.txt' 02:46:15 INFO - no previously-included directories found matching 'build' 02:46:15 INFO - no previously-included directories found matching 'dist' 02:46:15 INFO - no previously-included directories found matching '.git*' 02:46:15 INFO - Installing collected packages: jsonschema, functools32 02:46:15 INFO - Running setup.py install for functools32 02:46:15 INFO - warning: no files found matching '*.txt' 02:46:15 INFO - no previously-included directories found matching 'build' 02:46:15 INFO - no previously-included directories found matching 'dist' 02:46:15 INFO - no previously-included directories found matching '.git*' 02:46:15 INFO - Successfully installed jsonschema functools32 02:46:15 INFO - Cleaning up... 02:46:15 INFO - Return code: 0 02:46:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:46:15 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')]} 02:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:15 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')]} 02:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:15 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 0x7f179f640f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d63410>, '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 0x2d64310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d647a0>, '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-1461922614.425881-1385736047', '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 02:46:15 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 02:46:15 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 02:46:15 INFO - Using env: {'DISPLAY': ':0', 02:46:15 INFO - 'HOME': '/home/cltbld', 02:46:15 INFO - 'LANG': 'en_US.UTF-8', 02:46:15 INFO - 'LANGUAGE': 'en_US:en', 02:46:15 INFO - 'LOGNAME': 'cltbld', 02:46:15 INFO - 'MAIL': '/var/mail/cltbld', 02:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:15 INFO - 'MOZ_NO_REMOTE': '1', 02:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:15 INFO - 'NO_EM_RESTART': '1', 02:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:15 INFO - 'PWD': '/builds/slave/test', 02:46:15 INFO - 'SHELL': '/bin/bash', 02:46:15 INFO - 'SHLVL': '1', 02:46:15 INFO - 'TERM': 'linux', 02:46:15 INFO - 'TMOUT': '86400', 02:46:15 INFO - 'USER': 'cltbld', 02:46:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461922614.425881-1385736047', 02:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:15 INFO - '_': '/tools/buildbot/bin/python'} 02:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:16 INFO - Downloading/unpacking flake8 02:46:16 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 02:46:16 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 02:46:16 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 02:46:16 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 02:46:16 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 02:46:16 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 02:46:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:46:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:46:17 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 02:46:17 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 02:46:17 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 02:46:17 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 02:46:17 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 02:46:17 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 02:46:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:46:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:46:18 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 02:46:18 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 02:46:18 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 02:46:18 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 02:46:18 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 02:46:18 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 02:46:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:46:18 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 02:46:18 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 02:46:18 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 02:46:18 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 02:46:18 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 02:46:18 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 02:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:46:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:46:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:46:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:46:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:46:18 INFO - no previously-included directories found matching 'docs/_build' 02:46:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:46:18 INFO - Running setup.py install for pep8 02:46:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:46:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:46:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:46:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:46:18 INFO - no previously-included directories found matching 'docs/_build' 02:46:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:46:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:46:18 INFO - Cleaning up... 02:46:18 INFO - Return code: 0 02:46:18 INFO - Running post-action listener: _resource_record_post_action 02:46:18 INFO - Running post-action listener: _start_resource_monitoring 02:46:18 INFO - Starting resource monitoring. 02:46:18 INFO - ##### 02:46:18 INFO - ##### Running install step. 02:46:18 INFO - ##### 02:46:18 INFO - Running pre-action listener: _resource_record_pre_action 02:46:18 INFO - Running main action method: install 02:46:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:19 INFO - Reading from file tmpfile_stdout 02:46:19 INFO - Detecting whether we're running mozinstall >=1.0... 02:46:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:46:19 INFO - Reading from file tmpfile_stdout 02:46:19 INFO - Output received: 02:46:19 INFO - Usage: mozinstall [options] installer 02:46:19 INFO - Options: 02:46:19 INFO - -h, --help show this help message and exit 02:46:19 INFO - -d DEST, --destination=DEST 02:46:19 INFO - Directory to install application into. [default: 02:46:19 INFO - "/builds/slave/test"] 02:46:19 INFO - --app=APP Application being installed. [default: firefox] 02:46:19 INFO - mkdir: /builds/slave/test/build/application 02:46:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:46:35 INFO - Reading from file tmpfile_stdout 02:46:35 INFO - Output received: 02:46:35 INFO - /builds/slave/test/build/application/firefox/firefox 02:46:35 INFO - Running post-action listener: _resource_record_post_action 02:46:35 INFO - ##### 02:46:35 INFO - ##### Running run-tests step. 02:46:35 INFO - ##### 02:46:35 INFO - Running pre-action listener: _resource_record_pre_action 02:46:35 INFO - Running main action method: run_tests 02:46:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:46:35 INFO - Python 2.7.3 02:46:35 INFO - Return code: 0 02:46:35 INFO - grabbing minidump binary from tooltool 02:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:46:35 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d63410>, '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 0x2d64310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d647a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:46:35 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 02:46:35 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 02:46:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:46:35 INFO - Return code: 0 02:46:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:46:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:46:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:46:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:46:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:46:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:46:36 INFO - Return code: 0 02:46:36 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/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.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 02:46:36 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/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.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 02:46:36 INFO - Using env: {'DISPLAY': ':0', 02:46:36 INFO - 'HOME': '/home/cltbld', 02:46:36 INFO - 'LANG': 'en_US.UTF-8', 02:46:36 INFO - 'LANGUAGE': 'en_US:en', 02:46:36 INFO - 'LOGNAME': 'cltbld', 02:46:36 INFO - 'MAIL': '/var/mail/cltbld', 02:46:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:46:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:46:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:36 INFO - 'MOZ_NO_REMOTE': '1', 02:46:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:46:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:36 INFO - 'NO_EM_RESTART': '1', 02:46:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:36 INFO - 'PWD': '/builds/slave/test', 02:46:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:46:36 INFO - 'SHELL': '/bin/bash', 02:46:36 INFO - 'SHLVL': '1', 02:46:36 INFO - 'TERM': 'linux', 02:46:36 INFO - 'TMOUT': '86400', 02:46:36 INFO - 'USER': 'cltbld', 02:46:36 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461922614.425881-1385736047', 02:46:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:36 INFO - '_': '/tools/buildbot/bin/python'} 02:46:36 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/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.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 02:46:36 INFO - mozversion application_buildid: 20160429020646 02:46:36 INFO - mozversion application_changeset: 70b3e6ac383941005652196f432d9134dea468a7 02:46:36 INFO - mozversion application_display_name: Nightly 02:46:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:46:36 INFO - mozversion application_name: Firefox 02:46:36 INFO - mozversion application_remotingname: firefox 02:46:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:46:36 INFO - mozversion application_vendor: Mozilla 02:46:36 INFO - mozversion application_version: 49.0a1 02:46:36 INFO - mozversion platform_buildid: 20160429020646 02:46:36 INFO - mozversion platform_changeset: 70b3e6ac383941005652196f432d9134dea468a7 02:46:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:46:36 INFO - mozversion platform_version: 49.0a1 02:46:36 INFO - using testdate: 1461923196 02:46:36 INFO - actual date: 1461923196 02:46:36 INFO - starting webserver on 'localhost:47035' 02:46:36 INFO - SUITE-START | Running 2 tests 02:46:36 INFO - TEST-START | dromaeo_css 02:46:36 INFO - operating with platform_type : linux_ 02:46:36 INFO - Initialising browser for dromaeo_css test... 02:46:36 INFO - TEST-INFO | started process 21687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_V1Kl/profile http://localhost:47035/getInfo.html) 02:46:40 INFO - PROCESS | 21687 | 02:46:40 INFO - PROCESS | 21687 | (process:21752): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:46:41 INFO - PROCESS | 21687 | __metrics Screen width/height:1600/1200 02:46:41 INFO - PROCESS | 21687 | colorDepth:24 02:46:41 INFO - PROCESS | 21687 | Browser inner width/height: 1024/697 02:46:41 INFO - PROCESS | 21687 | __metrics 02:46:41 ERROR - PROCESS | 21687 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:46:42 INFO - TEST-INFO | 21687: exit 0 02:46:42 INFO - Browser initialized. 02:46:42 INFO - Running cycle 1/1 for dromaeo_css test... 02:46:42 INFO - TEST-INFO | started process 21803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_V1Kl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:46:44 INFO - PROCESS | 21803 | 02:46:44 INFO - PROCESS | 21803 | (process:21864): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:46:54 INFO - PROCESS | 21803 | RSS: Main: 166285312 02:46:54 INFO - PROCESS | 21803 | 02:47:44 INFO - PROCESS | 21803 | 1461923264425 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] 02:49:56 INFO - PROCESS | 21803 | Cycle 1(1): loaded http://localhost:47035/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47035/tests/dromaeo/cssquery-ext.html) 02:49:57 INFO - PROCESS | 21803 | RSS: Main: 170455040 02:49:57 INFO - PROCESS | 21803 | 02:52:59 INFO - PROCESS | 21803 | Cycle 1(1): loaded http://localhost:47035/tests/dromaeo/cssquery-ext.html (next: http://localhost:47035/tests/dromaeo/cssquery-jquery.html) 02:53:00 INFO - PROCESS | 21803 | RSS: Main: 167206912 02:53:00 INFO - PROCESS | 21803 | 02:56:02 INFO - PROCESS | 21803 | Cycle 1(1): loaded http://localhost:47035/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47035/tests/dromaeo/cssquery-mootools.html) 02:56:03 INFO - PROCESS | 21803 | RSS: Main: 168255488 02:56:03 INFO - PROCESS | 21803 | 02:59:04 INFO - PROCESS | 21803 | Cycle 1(1): loaded http://localhost:47035/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47035/tests/dromaeo/cssquery-prototype.html) 02:59:05 INFO - PROCESS | 21803 | RSS: Main: 166178816 02:59:05 INFO - PROCESS | 21803 | 03:02:08 INFO - PROCESS | 21803 | Cycle 1(1): loaded http://localhost:47035/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47035/tests/dromaeo/cssquery-yui.html) 03:02:08 INFO - PROCESS | 21803 | RSS: Main: 167337984 03:02:08 INFO - PROCESS | 21803 | 03:05:11 INFO - PROCESS | 21803 | Cycle 1(1): loaded http://localhost:47035/tests/dromaeo/cssquery-yui.html (next: http://localhost:47035/tests/dromaeo/cssquery-dojo.html) 03:05:11 INFO - PROCESS | 21803 | RSS: Main: 169619456 03:05:11 INFO - PROCESS | 21803 | 03:05:11 INFO - PROCESS | 21803 | __start_tp_report 03:05:11 INFO - PROCESS | 21803 | _x_x_mozilla_page_load 03:05:11 INFO - PROCESS | 21803 | _x_x_mozilla_page_load_details 03:05:11 INFO - PROCESS | 21803 | |i|pagename|runs| 03:05:11 INFO - PROCESS | 21803 | |0;dojo.html;2605.413781899073;2655.6813182418114;2684.382592003839;2685.342091187659;2699.0418401467477;4717.622590192785;4717.858464246074;4739.502352253011;4759.500252473493;4784.425868895737;4580.061087477067;4720.055988802244;4799.280107983805;4816.349792777974;4823.78292976816;4335.891602709926;4357.934630980538;4401.581849724287;4406.4271644686305;4429.712068715539;51.90496534736487;4293.463317085364;4367.606915377615;4409.404869880689;4439.533848945863;4384.276594361926;4396.450443694538;4398.912021759579;4404.1852257332175;4437.267850804614;4361.629261512775;4398.956010439919;4406.53731358206;4459.130469558438;4504.234280172379;4224.2185195738575;4314.892127696833;4387.758673272969;4423.668224883115;4493.168763778712;4558.156741002925;4562.224421848294;4569.862904112882;4600.217962946307;4615.376924115235;4976.979719157564;4979.626528010377;4979.825706100269;4980.676256043382;5027.648064635477;4916.901661966776;5029.597632189452;5070.442251352349;5143.202803565453;5160.690358578459;4727.858164255078;4740.976295118502;4743.928841067387;4745.857624271277;4784.162771514971;5187.144121220032;5201.193814958688;5202.97398513005;5212.270282160501;5253.44838791929;4864.5621894029;4958.157113290749;5002.724850133205;5025.246213067996;5055.140626093573;5083.8983220335385;5111.923321150186;5112.897742045213;5115.462876397999;5171.7672704728375;4919.4834542373255;5042.7982880685095;5049.5707864831165;5060.51925067118;5067.645264831426;4783.545563171493;4822.9758851206225;4982.352294201731;4999.225120106389;5014.17266151081;4252.277112890816;4264.91470170601;4267.701260911768;4299.505556861001;4309.569043095728;3630.49173115764;3707.9073023174637;3738.532683414573;3758.4174452959287;3760.191558814868;4320.027993701392;4367.235733746582;4368.104538569585;4374.628156606724;4411.1618792429335;5068.771905264272;5082.466341034212;5092.9745351273;5110.8466745997675;5137.614678899097;4218.683598730107;4329.307310830252;4358.984601250254;4393.231184542692;4435.334699795057;4531.932021019687;4547.499775024745;4550.044490656933;4584.381108550369;4594.035252596926;4750.714957102585;4767.904641907143;4768.713877167381;4770.594499467584;4809.951900480951;4955.851324460272;4985.102681517216;5052.772625231947;5067.797288108434;5090.287359769562;4747.738874361805;4765.880852978565;4778.1638213311835;4783;4816.253480710496;4957.851264462072;4959.950400496094;4962.354893863775;4962.6774259673;5028.245763135559;4957.529034741694;5026.949730502648;5029.220470827027;5079.5428411443145;5098.311727916684;4778.880527986828;4811.927821082617;4813.326134341265;4819.903601928012;4835.58897493717;4755.144074066701;4763;4795.568398844121;4824.927626085681;4848.030393921159;4678.064387122521;4743.1225223333795;4761.619070474423;4790.952090479051;4869.513048695102;4895.632827537877;4912.680675756064;4914.164592019437;4918.778654960463;4952.925706114484;4784.258439941815;4831.613470922388;4844.781984810622;4866.7079975201605;4879.804807807648 03:05:11 INFO - PROCESS | 21803 | |1;ext.html;583.5769067426116;591.9141724449954;608.9939100608992;616.6916541729136;639.172271907879;34444.48333275003;35617.46573801392;35695.64304356956;35716.642833571656;35904.820475897584;35752.46371304426;36258;36281.092972675695;36297.27405451889;36522;7555.244475552442;7780.10528789188;7788.1043679976965;7795.103563090261;7807.453478256524;7592.8861067084035;7702.383809295243;7709.6916123354995;7722.459427840054;7884.32983196429;7839.882401763978;7909.1299957004685;7912.050553933536;7912.960435197845;7921.36629069673;7719.845603087935;7798.532088074734;7843.098043724987;7871.252231038071;7878;7719.691212351499;7766.301032907066;7838.960805195995;7843.294103530652;7859.921400785976;35298;35832;36052.819735901416;36206;36213.63786362129;2565.7177710451833;3043.7869349145567;3268.0032590060023;3435.1579311880137;3712.053426376257;27259.86370068157;27500.724992750016;27570.5864412034;27883;27920.860395698095;3142.874285028596;3151.11768704763;3195.9360812783616;3219.452693042165;3236.951445728316;192450;193031;193171;193509;193540;30768.230794230323;31717.20706982344;31729.365412691615;31774.205644859063;54374.45625543773;32045.71817127289;32152.517712234334;32312.192195195308;32519.67480325214;32587.837060814545;12443.440045197987;12624.936875315565;12636.178648387826;12637.557685480964;12656.303903285409;10276.794464110675;10281.280310378352;10314.690559283234;10325.432101234504;10462.058414742709;8147.75556733299;8253.83492330162;8285.544295063708;8305.335573154132;8331.166883311742;3213.6786321368145;3232.57976463063;3264.542963985044;3285.917852053718;3286.145602143412;865.1521508921167;926.2636204217529;955.1928620315822;981.5877331520778;985.1281615769952;27338.589921151197;28230;28470.71529284722;28681.42637147287;28991.42017159687;980.8724865767405;1004.5931397783909;1021.5709402051157;1021.6271061062807;1047.9266451348333;14836.851631483763;15485.535433937;15519;15545.22273886301;15664.451744188898;396051;401417;404373;404874;407065;49626.75186624044;49971;50325;50382;50386.74806626017;1199.0395703025615;1225.4118023348842;1236.7773800715777;1240.2000709542294;1247.8689737577606;26722;27905.58141627918;28024;28538.85730571417;28611;44234.77882610566;44371.77814110909;44406;44649;44651;308701;310880;311475;312041;312576;25662;26262.86868565645;26336.34159146037;34617.134571635914;35157.64842351646;38128.428073579475;38360.616393835706;38647.42028869513;39131.6086839128;39321.2135757289;33315.33369332648;33411;33833.66166338305;33882;34091.65908340885;32229.194270143435;32477.350452990337;32773.18067048343;33377.66622333746;33420;32546.349073018882;32927.83536082304;33938;33989.49015764815;35248;28390.574141387482;29625.5556166662;32322.83838580792;32634.34731305408;32777.18057048593;23046.42383940415;24239.15162969358;24919.875400623605;25135.120270790434;25368.746312537376 03:05:11 INFO - PROCESS | 21803 | |2;jquery.html;374.48508301086014;375.234521575985;375.8233630193809;383.07678494827474;384.8633735024065;16056.51830445087;16437.67124657506;17251.654966900653;17281.56796080097;17305.22126504307;16047.95688280261;16551;17237.655246895054;17335.739963900553;17380.044097574628;5011.849644510661;5157.690538567698;5169.948300517003;5203.375594928614;5207.765650545734;3655.3785856404475;5139.203423469349;5640.7461664225;5997;5998.820035398945;5855.180274761537;5901.114832775097;5912.9113063304085;5935.703214839241;5962.195103661015;5705.229793977802;5931;5939.88120237595;5947.940520594782;5970.253718285215;4960.751962401901;5177.896442071137;5194.013137503862;5220.034293655686;5270.051390749663;18727.344542940933;19197.808021919882;19202.61594768097;19336.323228686928;20357.898210509;1836.6877630802796;1926.6435709393807;1941.6699161142499;2042.60169266993;2043.1725151313742;9069.183773460354;9126.908730912739;9570.282228832795;9612.75968100803;9634.373765705206;1759.0852756566642;1793.3970831245022;1808.7106063029853;1837.724341348795;1869.3457289948544;66311.336886631;67563;68462.65768671174;69148.6542567289;70279;9472.100150485692;9700.514974251259;9898.554565044591;9928.751781205528;10063.295569310078;13367.799483007762;13444.327783610976;13445.798313025312;13457.528986485426;13467.86532134666;6725.63009034498;6788.830279243059;6836.863262734718;6910.516263861582;6958.686859091353;6440.903386449207;6651.467882569383;6792.796216113525;6807.65961701913;6874.106366172366;3935.2719746846924;4069.6744260459686;4088.141490287073;4129.793510324472;4208.431861698693;1706.5818874375857;1726.818684038183;1839.5768973136253;1907.7138429235727;1926.422073377981;936.9250459963187;939.7697564096703;948.9098535639104;958.9409782792868;984.3995162950595;15805;16395.5901102471;16416.83583164177;16761.413350532916;16771.2452939618;892.4734406700078;933.7385532051037;934.0722262884555;958.712386284112;967.086103632075;9210.585523651453;9246.583903724348;9294;9350.859737103949;9480.478573678514;420328;424490;425388;438160;440990;80468;82564;86249;87496;88169;943.9386439881386;983.3165949664914;1003.4781913404988;1005.6279176704666;1018.3635227982511;15108.773368399263;15160.924195378953;15223.16272604973;15234.771478428054;15578.29897654631;35991.64008359988;36342.63657363393;36523.452148218326;36994.630053700195;37106.8144659275;50101.49898500968;50252.748736256086;51956.74021629868;52435.47564524306;53247;7173.282671732785;7541.698332066875;7578.696852126074;7669.463137580539;7676.884846727192;9325.813483730422;10860.076893464144;10967.725806854893;11219.439028048728;11307.378094204898;9314.627414903329;9488.525573721425;9594.136527712539;9706.320557561185;9912.752181195528;9582.329236953346;9612;9612.567434465325;9642;9666.420014799134;9092.136247056518;9445.433274003582;9450.763730906783;9635.904740485126;9678;7304.659319883748;7574.848503030019;7584.393248540214;7688.692452302069;7754.88367674474;8578.750955442641;9739.464329461947;9887.901120988698;9933.751656208653;10037.297389182688 03:05:11 INFO - PROCESS | 21803 | |3;mootools.html;1437.1448987852225;1451.6516036151324;1556.9766453503191;1725.6893759123361;1735.1064201935997;6848.4178844798125;7458.366038886701;7465.813354666136;7820.413468989827;7821.2569805868425;7465.290797374254;7474.663640136193;7490.5131166474275;7556.168821429638;7580.848383032336;2167.111484291445;2225.054351900444;2230.2528652901296;2230.933072007834;2232.743234528034;2174.684670722744;2178.684090806832;2205.2943058221376;2209.812165965895;2214.1918199857096;2080.823130033949;2118.8304935605115;2119.014658183944;2130.808227259546;2152.7954844289766;2127.7233959585233;2151.526664133888;2151.8601290916117;2155.1056311630655;2158.719366482363;2130.158587358;2182.4871155278497;2194.9341519754435;2210.071769856664;2219.2676416782424;7608.543487390719;7687.231276872324;7692.576908270043;7695.0765908090825;7715.729949451798;4534.433195850519;4666.673332866667;4676.228422310314;4705.929411058837;4709.058188362307;2781.624480695121;2816.7887408444244;2891.421715656856;2915.825050496977;2933.06142034549;867.1285358215017;903.9367244292837;909.4043401571981;910.544727636182;920.8112336970905;10551.103156231806;10573.788524229549;10578.259521833397;10600.469976501221;10657.893421065768;4252.574742525722;4310.073334233155;4352.804123814436;4353.325234588644;4385.947372630546;9081.364304498753;9096.909030909606;9147.588358523883;9199.540022998957;9210;4715.198416269242;4720.268358404453;4732.148213321566;4743.359646447685;4744.288356746516;3708.499352587366;4093.488313960755;4236.9788151059665;4284.186004659105;4316.6546676265825;3680.429533422324;3727.38498147808;3784.243151369737;3789.0906182515996;3825.3305671507374;1190.2025642819333;1205.8070708686569;1209.1415095282448;1210.7881120803825;1221.6396163131897;859.3168431097292;862.4652715316544;863.727925703414;875.4047247871508;894.3828758156851;5192.376914770176;5296.3379577552805;5408.350997880201;5525.198846167284;5656.981743286248;877.9780505487414;919.4667093085994;925.6621333213328;937.2361525356812;941.2752180820867;3594.353016457063;3643.107438677541;3645.179834537208;3688.686461650736;3719.9442008369897;9428.340016198938;9824.164945979672;9887.456189909624;9892.25808064398;9932.503374831374;9692.9030709692;9712.61149554024;9736.707898763048;9761.219102471785;9795.510224488748;7292;7509.586972716553;7548.056492938383;7553.660085296175;7560;5135.537801597874;5253.369595648546;5254.868628284324;5260.079486089842;5331.733413329395;8417.410781245255;8444.071152173134;8559.95720021396;8608.354373421893;8686.305095592212;8747.387682862138;8748.037715851124;8780.868286975572;9012.279017678438;9047.909520904706;6300;6666.633335166418;6699.263081061177;6829.726810927507;6896.172459304916;7394.223606521237;7395.408367330493;7454.4781865268915;7462.44031697614;7488.101427828696;6544;6806.863862722619;6859.725610975505;6861.382475577022;6917.584944903322;6785.457163426815;6847.109875716125;6853.4859885507785;6915.343042410963;6967.65161741921;6346.650934198478;6398.456131228898;6409.230892292955;6427;6681.164854393201;4727.881802954954;4781.6891902026255;4851.126797176542;4877.365942427462;4889.706617602955;4649.093426781745;4697.154512187839;4741.83403580873;4758.119747846659;4799.136155491905 03:05:11 INFO - PROCESS | 21803 | |4;prototype.html;302.39370063023637;310.9626844778627;311.13659594624926;315.471585094966;316.2441764183603;4947.183714687077;4977.3529441172595;4999.500049994998;5036.622253331001;5037.571806396456;4931.654784165101;4943;4952.479989601094;4955.851324460263;4959.181735013718;3715.368387374153;3813.504244448218;3924.0778417071965;3932.4073750131242;3956.3867600521967;3936.547297060846;3937.488126543545;3946.289667859784;3964.1278918637854;3972.2849887020325;3847.1920896611746;3895.6493915547594;3902.9804850975706;3918.7648741075486;3943.1127996200767;3835.789031603261;3893.299206142893;3921.509811273591;3939.9212015759667;3950.4716981132096;3469.5142680024815;3473.583170019614;3483.372992861284;3484.26830365621;3491.8603255869734;4739;4755.19584332536;4778.283257511366;4781.163296423147;4817.542333478314;4354.564543545652;4447.977760111179;4458.621017213541;4465.843695470643;4480.215962206601;5111.4121875984365;5129.84610461683;5135.073008385222;5142.897142057175;5151.253068305112;3757.210985693008;3769.095417099904;3779.7165212609166;3792.50697409335;3798.601146879593;5403.78384864605;5406.243125962368;5415.483664573926;5441.29263195786;5441.700706461143;3485.5991560970306;3686.944695829565;3723.627637236309;3742.176721121349;3743.9064023399087;3751.780671281844;3776.811159442072;3780.640839120334;3782.3002744492355;3787.9431808522895;4325.502567204749;4345.239583072949;4350.71720338177;4355.412019377407;4359;5025.844055867171;5128.358955130609;5190.24741412493;5197.870053248624;5238.214267859851;1387.6669599296097;1404.1224234853216;1405.2552147361914;1407.4792326839136;1415.610707055568;867;915.5651065743718;938.9859152112724;954.9904500954901;963.7397902566267;4478.619317358061;4585.793639286173;4598.241290187082;4601.838935637236;4616.853163279091;5273.920891186635;5331.147016477423;5385.461453854583;5393.892122157535;5429.782808687687;4457.7548234846745;4573.49691533931;4576.176288268077;4593.058423023273;4596.218642830727;3031.1815809731247;3049.4663433898977;3057.5872257245433;3061.1734831595345;3065.203047207742;5370.113931201387;5378.408375078739;5387.24578559002;5407.809837016015;5409;5689.9146512802345;5859.384764599741;5870.119482077723;5904.734286957011;5921.644701317935;5389.326334208224;5389.595780316492;5395.568354531707;5405.270288511079;5419.756110974937;5738;5753.252077229933;5762.625429347079;5778.711064446845;5781.682007489629;5054.82308119214;5335.279737235423;5351.384590772111;5352.437994010728;5353.770521288295;5098.694078355311;5122.590192784643;5130.51260130287;5137.691738495702;5146.150885103916;3778.981105094457;3813.7521061130938;3813.904652383713;3821.8089095544556;3833.386658134685;5192.948070519246;5378.005069062079;5409.594280428905;5424.53891419218;5433.130699088127;5223.399309079353;5231.875146843447;5255.605829562722;5262.631615786858;5271.446498117796;4933.55597996182;5214.556762675215;5222.947770522246;5238.449962753856;5256.842294731164;5117.616178786531;5132.5124113209185;5138.818071843422;5140;5171.844844654666;4979.825706100269;5011.922436676132;5208.661437006583;5220.686758794484;5285.572895318166;5091.643584949018;5098.852758129391;5110.853441554482;5119.28330033803;5137.922931155961 03:05:11 INFO - PROCESS | 21803 | |5;yui.html;615.6860001399285;620.8758248350331;633.1515768869716;684.9075374824398;702.4731451411442;11071.612493562727;11899.76200475991;12336.136470447072;12490.50037998479;12539.937300313497;12973.091883568153;13378.063535552516;13459.798103028437;13461.730765384686;13462.326883655802;808.8746244332124;811.9594020298962;812.7317985064944;813.9715109971153;814.5601375257384;807.2532907060975;808.5835794565803;809.7327881799022;810.0522388805113;811.4279432999721;839.2488722593275;839.6011894350196;841.1504380575632;844.6536919862857;845.247729520727;836.824266903951;841.2134654098408;842.7219017724167;846.1411667157839;846.1876598465481;587.0724255676022;605.4127496328555;610.2920612089954;610.3499772742016;612.6171143035602;12025.398730063462;12262.26426414418;12271.938640306742;12318.5072597096;12334.32161231132;10528.947355263175;10948.726281843017;11470.311781293065;11876.990455811267;12082.69793255167;9376.718698439057;9795.902040979641;10097.596096156145;10121.067069057719;10232.795344093076;3918.3142949983926;3936.7441116327345;3950.032242100675;3981.186707524818;4067.8983025424304;44409.223631054716;44631.875768696205;45558.31662525065;45921.08157836858;46836.297455538195;8727.60725767342;9019;9044.186023257938;9063.13900179482;9163.404378715362;16217.35130594763;16248.268827902773;16283.430079947146;16343.754843677354;16359.83640163607;6259.342769009279;6366.9681651591445;6421.3578642136345;6495.7076931538195;6549.639769812611;3743.344914639927;3841.116543195025;3847.1728578355787;3852.2680690669245;3878.26313000529;2676.9196924092307;2689.1125928443566;2711.295063283521;2724.3325385280336;2737.507248695254;485.83967290793953;487.7146869081627;488.8289098815457;505.28502169429845;512.3109417833009;521.9321488206584;569.5159114752428;571.6770024935898;589.3870374810149;621.7233331167678;7508.2491750825575;7549.320561149523;7659.310662040331;7772.18392068836;7836.804079898048;568.6076607141142;596.9253843269591;615.3999850146162;621.052894336141;633.4457349818908;3528.3825330567047;3722.218334149859;3731.7014638828828;3731.981340093282;3734.682551983112;50670.239946400834;51715.482845171064;52332.73833630884;53236.73381633144;54169.1874621881;44997;46690.766546167055;47060.29409558791;48191.5180848187;48206.5179348202;43287;44038.77980610076;44204.336934946004;44472.555274446844;44532.3320150198;7160.928390716234;7192.676329565287;7197.208307086321;7211.531250468703;7251.709931602677;30305.69694303029;30811.53782693306;31494;31593;31651.683483164874;36884.446733298486;38980.2203955925;39049.804750976065;39105.217895641355;40323.59676403316;8778.692745754124;8919.643214271357;8974.955125224333;8996.415233009833;9006.594703238501;10061.597536098767;10333.379997200193;10403.58385664565;10425.341537907785;10507.894921050998;9194.724158275263;9560.521973901137;9576.090271424204;9612.99063598312;9742.853857192289;9795.853062204214;9811.460369679737;9879.555420005972;9940.353876997971;10110.241731869992;9447.338686291894;9685;9723.65967191145;9768.85346719814;9811;7841.843163136591;7919.802004949692;8032.277095061472;8038.276555110068;8102.513849169069;7401.259874012556;7492.587907665131;7619.580923049286;7738.264864837832;7971.1630278819885 03:05:11 INFO - PROCESS | 21803 | __end_tp_report 03:05:11 INFO - PROCESS | 21803 | __start_cc_report 03:05:11 INFO - PROCESS | 21803 | _x_x_mozilla_cycle_collect,378 03:05:11 INFO - PROCESS | 21803 | __end_cc_report 03:05:11 INFO - PROCESS | 21803 | __startTimestamp1461924311326__endTimestamp 03:05:11 INFO - PROCESS | 21803 | 03:05:11 INFO - PROCESS | 21803 | ------- Summary: start ------- 03:05:11 INFO - PROCESS | 21803 | Number of tests: 6 03:05:11 INFO - PROCESS | 21803 | 03:05:11 INFO - PROCESS | 21803 | [#0] dojo.html Cycles:165 Average:4636.51 Median:4783.00 stddev:597.79 (12.5%) stddev-sans-first:578.00 03:05:11 INFO - PROCESS | 21803 | Values: 2605.4 2655.7 2684.4 2685.3 2699.0 4717.6 4717.9 4739.5 4759.5 4784.4 4580.1 4720.1 4799.3 4816.3 4823.8 4335.9 4357.9 4401.6 4406.4 4429.7 51.9 4293.5 4367.6 4409.4 4439.5 4384.3 4396.5 4398.9 4404.2 4437.3 4361.6 4399.0 4406.5 4459.1 4504.2 4224.2 4314.9 4387.8 4423.7 4493.2 4558.2 4562.2 4569.9 4600.2 4615.4 4977.0 4979.6 4979.8 4980.7 5027.6 4916.9 5029.6 5070.4 5143.2 5160.7 4727.9 4741.0 4743.9 4745.9 4784.2 5187.1 5201.2 5203.0 5212.3 5253.4 4864.6 4958.2 5002.7 5025.2 5055.1 5083.9 5111.9 5112.9 5115.5 5171.8 4919.5 5042.8 5049.6 5060.5 5067.6 4783.5 4823.0 4982.4 4999.2 5014.2 4252.3 4264.9 4267.7 4299.5 4309.6 3630.5 3707.9 3738.5 3758.4 3760.2 4320.0 4367.2 4368.1 4374.6 4411.2 5068.8 5082.5 5093.0 5110.8 5137.6 4218.7 4329.3 4359.0 4393.2 4435.3 4531.9 4547.5 4550.0 4584.4 4594.0 4750.7 4767.9 4768.7 4770.6 4810.0 4955.9 4985.1 5052.8 5067.8 5090.3 4747.7 4765.9 4778.2 4783.0 4816.3 4957.9 4960.0 4962.4 4962.7 5028.2 4957.5 5026.9 5029.2 5079.5 5098.3 4778.9 4811.9 4813.3 4819.9 4835.6 4755.1 4763.0 4795.6 4824.9 4848.0 4678.1 4743.1 4761.6 4791.0 4869.5 4895.6 4912.7 4914.2 4918.8 4952.9 4784.3 4831.6 4844.8 4866.7 4879.8 03:05:11 INFO - PROCESS | 21803 | 03:05:11 INFO - PROCESS | 21803 | [#1] ext.html Cycles:180 Average:44025.92 Median:33394.33 stddev:83218.45 (249.2%) stddev-sans-first:83387.98 03:05:11 INFO - PROCESS | 21803 | Values: 583.6 591.9 609.0 616.7 639.2 34444.5 35617.5 35695.6 35716.6 35904.8 35752.5 36258.0 36281.1 36297.3 36522.0 7555.2 7780.1 7788.1 7795.1 7807.5 7592.9 7702.4 7709.7 7722.5 7884.3 7839.9 7909.1 7912.1 7913.0 7921.4 7719.8 7798.5 7843.1 7871.3 7878.0 7719.7 7766.3 7839.0 7843.3 7859.9 35298.0 35832.0 36052.8 36206.0 36213.6 2565.7 3043.8 3268.0 3435.2 3712.1 27259.9 27500.7 27570.6 27883.0 27920.9 3142.9 3151.1 3195.9 3219.5 3237.0 192450.0 193031.0 193171.0 193509.0 193540.0 30768.2 31717.2 31729.4 31774.2 54374.5 32045.7 32152.5 32312.2 32519.7 32587.8 12443.4 12624.9 12636.2 12637.6 12656.3 10276.8 10281.3 10314.7 10325.4 10462.1 8147.8 8253.8 8285.5 8305.3 8331.2 3213.7 3232.6 3264.5 3285.9 3286.1 865.2 926.3 955.2 981.6 985.1 27338.6 28230.0 28470.7 28681.4 28991.4 980.9 1004.6 1021.6 1021.6 1047.9 14836.9 15485.5 15519.0 15545.2 15664.5 396051.0 401417.0 404373.0 404874.0 407065.0 49626.8 49971.0 50325.0 50382.0 50386.7 1199.0 1225.4 1236.8 1240.2 1247.9 26722.0 27905.6 28024.0 28538.9 28611.0 44234.8 44371.8 44406.0 44649.0 44651.0 308701.0 310880.0 311475.0 312041.0 312576.0 25662.0 26262.9 26336.3 34617.1 35157.6 38128.4 38360.6 38647.4 39131.6 39321.2 33315.3 33411.0 33833.7 33882.0 34091.7 32229.2 32477.4 32773.2 33377.7 33420.0 32546.3 32927.8 33938.0 33989.5 35248.0 28390.6 29625.6 32322.8 32634.3 32777.2 23046.4 24239.2 24919.9 25135.1 25368.7 03:05:11 INFO - PROCESS | 21803 | 03:05:11 INFO - PROCESS | 21803 | [#2] jquery.html Cycles:180 Average:25452.32 Median:29443.87 stddev:70950.43 (241.0%) stddev-sans-first:71124.48 03:05:11 INFO - PROCESS | 21803 | Values: 374.5 375.2 375.8 383.1 384.9 16056.5 16437.7 17251.7 17281.6 17305.2 16048.0 16551.0 17237.7 17335.7 17380.0 5011.8 5157.7 5169.9 5203.4 5207.8 3655.4 5139.2 5640.7 5997.0 5998.8 5855.2 5901.1 5912.9 5935.7 5962.2 5705.2 5931.0 5939.9 5947.9 5970.3 4960.8 5177.9 5194.0 5220.0 5270.1 18727.3 19197.8 19202.6 19336.3 20357.9 1836.7 1926.6 1941.7 2042.6 2043.2 9069.2 9126.9 9570.3 9612.8 9634.4 1759.1 1793.4 1808.7 1837.7 1869.3 66311.3 67563.0 68462.7 69148.7 70279.0 9472.1 9700.5 9898.6 9928.8 10063.3 13367.8 13444.3 13445.8 13457.5 13467.9 6725.6 6788.8 6836.9 6910.5 6958.7 6440.9 6651.5 6792.8 6807.7 6874.1 3935.3 4069.7 4088.1 4129.8 4208.4 1706.6 1726.8 1839.6 1907.7 1926.4 936.9 939.8 948.9 958.9 984.4 15805.0 16395.6 16416.8 16761.4 16771.2 892.5 933.7 934.1 958.7 967.1 9210.6 9246.6 9294.0 9350.9 9480.5 420328.0 424490.0 425388.0 438160.0 440990.0 80468.0 82564.0 86249.0 87496.0 88169.0 943.9 983.3 1003.5 1005.6 1018.4 15108.8 15160.9 15223.2 15234.8 15578.3 35991.6 36342.6 36523.5 36994.6 37106.8 50101.5 50252.7 51956.7 52435.5 53247.0 7173.3 7541.7 7578.7 7669.5 7676.9 9325.8 10860.1 10967.7 11219.4 11307.4 9314.6 9488.5 9594.1 9706.3 9912.8 9582.3 9612.0 9612.6 9642.0 9666.4 9092.1 9445.4 9450.8 9635.9 9678.0 7304.7 7574.8 7584.4 7688.7 7754.9 8578.8 9739.5 9887.9 9933.8 10037.3 03:05:11 INFO - PROCESS | 21803 | 03:05:11 INFO - PROCESS | 21803 | [#3] mootools.html Cycles:180 Average:5161.10 Median:5314.04 stddev:2848.57 (53.6%) stddev-sans-first:2842.82 03:05:11 INFO - PROCESS | 21803 | Values: 1437.1 1451.7 1557.0 1725.7 1735.1 6848.4 7458.4 7465.8 7820.4 7821.3 7465.3 7474.7 7490.5 7556.2 7580.8 2167.1 2225.1 2230.3 2230.9 2232.7 2174.7 2178.7 2205.3 2209.8 2214.2 2080.8 2118.8 2119.0 2130.8 2152.8 2127.7 2151.5 2151.9 2155.1 2158.7 2130.2 2182.5 2194.9 2210.1 2219.3 7608.5 7687.2 7692.6 7695.1 7715.7 4534.4 4666.7 4676.2 4705.9 4709.1 2781.6 2816.8 2891.4 2915.8 2933.1 867.1 903.9 909.4 910.5 920.8 10551.1 10573.8 10578.3 10600.5 10657.9 4252.6 4310.1 4352.8 4353.3 4385.9 9081.4 9096.9 9147.6 9199.5 9210.0 4715.2 4720.3 4732.1 4743.4 4744.3 3708.5 4093.5 4237.0 4284.2 4316.7 3680.4 3727.4 3784.2 3789.1 3825.3 1190.2 1205.8 1209.1 1210.8 1221.6 859.3 862.5 863.7 875.4 894.4 5192.4 5296.3 5408.4 5525.2 5657.0 878.0 919.5 925.7 937.2 941.3 3594.4 3643.1 3645.2 3688.7 3719.9 9428.3 9824.2 9887.5 9892.3 9932.5 9692.9 9712.6 9736.7 9761.2 9795.5 7292.0 7509.6 7548.1 7553.7 7560.0 5135.5 5253.4 5254.9 5260.1 5331.7 8417.4 8444.1 8560.0 8608.4 8686.3 8747.4 8748.0 8780.9 9012.3 9047.9 6300.0 6666.6 6699.3 6829.7 6896.2 7394.2 7395.4 7454.5 7462.4 7488.1 6544.0 6806.9 6859.7 6861.4 6917.6 6785.5 6847.1 6853.5 6915.3 6967.7 6346.7 6398.5 6409.2 6427.0 6681.2 4727.9 4781.7 4851.1 4877.4 4889.7 4649.1 4697.2 4741.8 4758.1 4799.1 03:05:11 INFO - PROCESS | 21803 | 03:05:11 INFO - PROCESS | 21803 | [#4] prototype.html Cycles:180 Average:4377.05 Median:4957.52 stddev:1274.68 (25.7%) stddev-sans-first:1241.03 03:05:11 INFO - PROCESS | 21803 | Values: 302.4 311.0 311.1 315.5 316.2 4947.2 4977.4 4999.5 5036.6 5037.6 4931.7 4943.0 4952.5 4955.9 4959.2 3715.4 3813.5 3924.1 3932.4 3956.4 3936.5 3937.5 3946.3 3964.1 3972.3 3847.2 3895.6 3903.0 3918.8 3943.1 3835.8 3893.3 3921.5 3939.9 3950.5 3469.5 3473.6 3483.4 3484.3 3491.9 4739.0 4755.2 4778.3 4781.2 4817.5 4354.6 4448.0 4458.6 4465.8 4480.2 5111.4 5129.8 5135.1 5142.9 5151.3 3757.2 3769.1 3779.7 3792.5 3798.6 5403.8 5406.2 5415.5 5441.3 5441.7 3485.6 3686.9 3723.6 3742.2 3743.9 3751.8 3776.8 3780.6 3782.3 3787.9 4325.5 4345.2 4350.7 4355.4 4359.0 5025.8 5128.4 5190.2 5197.9 5238.2 1387.7 1404.1 1405.3 1407.5 1415.6 867.0 915.6 939.0 955.0 963.7 4478.6 4585.8 4598.2 4601.8 4616.9 5273.9 5331.1 5385.5 5393.9 5429.8 4457.8 4573.5 4576.2 4593.1 4596.2 3031.2 3049.5 3057.6 3061.2 3065.2 5370.1 5378.4 5387.2 5407.8 5409.0 5689.9 5859.4 5870.1 5904.7 5921.6 5389.3 5389.6 5395.6 5405.3 5419.8 5738.0 5753.3 5762.6 5778.7 5781.7 5054.8 5335.3 5351.4 5352.4 5353.8 5098.7 5122.6 5130.5 5137.7 5146.2 3779.0 3813.8 3813.9 3821.8 3833.4 5192.9 5378.0 5409.6 5424.5 5433.1 5223.4 5231.9 5255.6 5262.6 5271.4 4933.6 5214.6 5222.9 5238.4 5256.8 5117.6 5132.5 5138.8 5140.0 5171.8 4979.8 5011.9 5208.7 5220.7 5285.6 5091.6 5098.9 5110.9 5119.3 5137.9 03:05:11 INFO - PROCESS | 21803 | 03:05:11 INFO - PROCESS | 21803 | [#5] yui.html Cycles:180 Average:12475.09 Median:569.06 stddev:14672.63 (2578.4%) stddev-sans-first:14686.76 03:05:11 INFO - PROCESS | 21803 | Values: 615.7 620.9 633.2 684.9 702.5 11071.6 11899.8 12336.1 12490.5 12539.9 12973.1 13378.1 13459.8 13461.7 13462.3 808.9 812.0 812.7 814.0 814.6 807.3 808.6 809.7 810.1 811.4 839.2 839.6 841.2 844.7 845.2 836.8 841.2 842.7 846.1 846.2 587.1 605.4 610.3 610.3 612.6 12025.4 12262.3 12271.9 12318.5 12334.3 10528.9 10948.7 11470.3 11877.0 12082.7 9376.7 9795.9 10097.6 10121.1 10232.8 3918.3 3936.7 3950.0 3981.2 4067.9 44409.2 44631.9 45558.3 45921.1 46836.3 8727.6 9019.0 9044.2 9063.1 9163.4 16217.4 16248.3 16283.4 16343.8 16359.8 6259.3 6367.0 6421.4 6495.7 6549.6 3743.3 3841.1 3847.2 3852.3 3878.3 2676.9 2689.1 2711.3 2724.3 2737.5 485.8 487.7 488.8 505.3 512.3 521.9 569.5 571.7 589.4 621.7 7508.2 7549.3 7659.3 7772.2 7836.8 568.6 596.9 615.4 621.1 633.4 3528.4 3722.2 3731.7 3732.0 3734.7 50670.2 51715.5 52332.7 53236.7 54169.2 44997.0 46690.8 47060.3 48191.5 48206.5 43287.0 44038.8 44204.3 44472.6 44532.3 7160.9 7192.7 7197.2 7211.5 7251.7 30305.7 30811.5 31494.0 31593.0 31651.7 36884.4 38980.2 39049.8 39105.2 40323.6 8778.7 8919.6 8975.0 8996.4 9006.6 10061.6 10333.4 10403.6 10425.3 10507.9 9194.7 9560.5 9576.1 9613.0 9742.9 9795.9 9811.5 9879.6 9940.4 10110.2 9447.3 9685.0 9723.7 9768.9 9811.0 7841.8 7919.8 8032.3 8038.3 8102.5 7401.3 7492.6 7619.6 7738.3 7971.2 03:05:11 INFO - PROCESS | 21803 | -------- Summary: end -------- 03:05:11 INFO - PROCESS | 21803 | 03:05:12 INFO - TEST-INFO | 21803: exit 0 03:05:12 INFO - TEST-OK | dromaeo_css | took 1115767ms 03:05:12 INFO - TEST-START | kraken 03:05:12 INFO - operating with platform_type : linux_ 03:05:12 INFO - Initialising browser for kraken test... 03:05:12 INFO - TEST-INFO | started process 22036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeGBO9n/profile http://localhost:47035/getInfo.html) 03:05:16 INFO - PROCESS | 22036 | 03:05:16 INFO - PROCESS | 22036 | (process:22105): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:05:16 INFO - PROCESS | 22036 | __metrics Screen width/height:1600/1200 03:05:16 INFO - PROCESS | 22036 | colorDepth:24 03:05:16 INFO - PROCESS | 22036 | Browser inner width/height: 1024/697 03:05:16 INFO - PROCESS | 22036 | __metrics 03:05:17 ERROR - PROCESS | 22036 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:05:18 INFO - TEST-INFO | 22036: exit 0 03:05:18 INFO - Browser initialized. 03:05:18 INFO - Running cycle 1/1 for kraken test... 03:05:18 INFO - TEST-INFO | started process 22156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeGBO9n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:20 INFO - PROCESS | 22156 | 03:05:20 INFO - PROCESS | 22156 | (process:22217): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:05:30 INFO - PROCESS | 22156 | RSS: Main: 165670912 03:05:30 INFO - PROCESS | 22156 | 03:05:32 INFO - PROCESS | 22156 | Cycle 1(1): loaded http://localhost:47035/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47035/tests/kraken/driver.html?testName=audio-beat-detection) 03:05:33 INFO - PROCESS | 22156 | RSS: Main: 170672128 03:05:33 INFO - PROCESS | 22156 | 03:05:36 INFO - PROCESS | 22156 | Cycle 1(1): loaded http://localhost:47035/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47035/tests/kraken/driver.html?testName=audio-dft) 03:05:37 INFO - PROCESS | 22156 | RSS: Main: 173809664 03:05:37 INFO - PROCESS | 22156 | 03:05:40 INFO - PROCESS | 22156 | Cycle 1(1): loaded http://localhost:47035/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47035/tests/kraken/driver.html?testName=audio-fft) 03:05:40 INFO - PROCESS | 22156 | RSS: Main: 164855808 03:05:40 INFO - PROCESS | 22156 | 03:05:43 INFO - PROCESS | 22156 | Cycle 1(1): loaded http://localhost:47035/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47035/tests/kraken/driver.html?testName=audio-oscillator) 03:05:43 INFO - PROCESS | 22156 | RSS: Main: 165339136 03:05:43 INFO - PROCESS | 22156 | 03:05:46 INFO - PROCESS | 22156 | Cycle 1(1): loaded http://localhost:47035/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47035/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:05:46 INFO - PROCESS | 22156 | RSS: Main: 166461440 03:05:46 INFO - PROCESS | 22156 | 03:05:49 INFO - PROCESS | 22156 | Cycle 1(1): loaded http://localhost:47035/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47035/tests/kraken/driver.html?testName=imaging-darkroom) 03:05:50 INFO - PROCESS | 22156 | RSS: Main: 165826560 03:05:50 INFO - PROCESS | 22156 | 03:05:53 INFO - PROCESS | 22156 | Cycle 1(1): loaded http://localhost:47035/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47035/tests/kraken/driver.html?testName=imaging-desaturate) 03:05:54 INFO - PROCESS | 22156 | RSS: Main: 165789696 03:05:54 INFO - PROCESS | 22156 | 03:05:57 INFO - PROCESS | 22156 | Cycle 1(1): loaded http://localhost:47035/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47035/tests/kraken/driver.html?testName=json-parse-financial) 03:05:58 INFO - PROCESS | 22156 | RSS: Main: 166400000 03:05:58 INFO - PROCESS | 22156 | 03:05:59 INFO - PROCESS | 22156 | Cycle 1(1): loaded http://localhost:47035/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47035/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:06:00 INFO - PROCESS | 22156 | RSS: Main: 166506496 03:06:00 INFO - PROCESS | 22156 | 03:06:02 INFO - PROCESS | 22156 | Cycle 1(1): loaded http://localhost:47035/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47035/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:06:02 INFO - PROCESS | 22156 | RSS: Main: 166477824 03:06:02 INFO - PROCESS | 22156 | 03:06:05 INFO - PROCESS | 22156 | Cycle 1(1): loaded http://localhost:47035/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47035/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:06:05 INFO - PROCESS | 22156 | RSS: Main: 166768640 03:06:05 INFO - PROCESS | 22156 | 03:06:08 INFO - PROCESS | 22156 | Cycle 1(1): loaded http://localhost:47035/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47035/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:06:09 INFO - PROCESS | 22156 | RSS: Main: 167129088 03:06:09 INFO - PROCESS | 22156 | 03:06:12 INFO - PROCESS | 22156 | Cycle 1(1): loaded http://localhost:47035/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47035/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:06:12 INFO - PROCESS | 22156 | RSS: Main: 167247872 03:06:12 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | Cycle 1(1): loaded http://localhost:47035/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47035/tests/kraken/driver.html?testName=ai-astar) 03:06:14 INFO - PROCESS | 22156 | RSS: Main: 168538112 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | __start_tp_report 03:06:14 INFO - PROCESS | 22156 | _x_x_mozilla_page_load 03:06:14 INFO - PROCESS | 22156 | _x_x_mozilla_page_load_details 03:06:14 INFO - PROCESS | 22156 | |i|pagename|runs| 03:06:14 INFO - PROCESS | 22156 | |0;ai-astar;113;117;114;113;114;126;115;112;113;112 03:06:14 INFO - PROCESS | 22156 | |1;audio-beat-detection;160;139;160;191;129;161;158;140;197;135 03:06:14 INFO - PROCESS | 22156 | |2;audio-dft;163;165;163;167;165;162;161;164;166;163 03:06:14 INFO - PROCESS | 22156 | |3;audio-fft;76;78;76;154;78;73;77;77;157;75 03:06:14 INFO - PROCESS | 22156 | |4;audio-oscillator;94;93;151;93;93;93;138;94;93;144 03:06:14 INFO - PROCESS | 22156 | |5;imaging-gaussian-blur;118;118;118;118;117;118;118;117;118;118 03:06:14 INFO - PROCESS | 22156 | |6;imaging-darkroom;148;147;146;147;147;147;148;147;147;146 03:06:14 INFO - PROCESS | 22156 | |7;imaging-desaturate;95;96;96;95;95;95;95;95;96;96 03:06:14 INFO - PROCESS | 22156 | |8;json-parse-financial;69;67;65;66;65;66;67;82;65;64 03:06:14 INFO - PROCESS | 22156 | |9;json-stringify-tinderbox;64;65;65;66;65;64;65;66;65;66 03:06:14 INFO - PROCESS | 22156 | |10;stanford-crypto-aes;79;79;79;90;81;81;82;82;83;82 03:06:14 INFO - PROCESS | 22156 | |11;stanford-crypto-ccm;132;138;132;137;133;131;129;136;213;142 03:06:14 INFO - PROCESS | 22156 | |12;stanford-crypto-pbkdf2;187;177;177;179;179;176;186;173;175;175 03:06:14 INFO - PROCESS | 22156 | |13;stanford-crypto-sha256-iterative;75;75;75;75;72;74;73;70;71;74 03:06:14 INFO - PROCESS | 22156 | __end_tp_report 03:06:14 INFO - PROCESS | 22156 | __start_cc_report 03:06:14 INFO - PROCESS | 22156 | _x_x_mozilla_cycle_collect,942 03:06:14 INFO - PROCESS | 22156 | __end_cc_report 03:06:14 INFO - PROCESS | 22156 | __startTimestamp1461924374908__endTimestamp 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | ------- Summary: start ------- 03:06:14 INFO - PROCESS | 22156 | Number of tests: 14 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | [#0] ai-astar Cycles:10 Average:114.90 Median:114.00 stddev:4.18 (3.7%) stddev-sans-first:4.37 03:06:14 INFO - PROCESS | 22156 | Values: 113.0 117.0 114.0 113.0 114.0 126.0 115.0 112.0 113.0 112.0 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | [#1] audio-beat-detection Cycles:10 Average:157.00 Median:160.00 stddev:22.78 (14.2%) stddev-sans-first:24.14 03:06:14 INFO - PROCESS | 22156 | Values: 160.0 139.0 160.0 191.0 129.0 161.0 158.0 140.0 197.0 135.0 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.50 stddev:1.85 (1.1%) stddev-sans-first:1.94 03:06:14 INFO - PROCESS | 22156 | Values: 163.0 165.0 163.0 167.0 165.0 162.0 161.0 164.0 166.0 163.0 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.50 stddev:33.45 (43.7%) stddev-sans-first:34.97 03:06:14 INFO - PROCESS | 22156 | Values: 76.0 78.0 76.0 154.0 78.0 73.0 77.0 77.0 157.0 75.0 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:93.00 stddev:24.85 (26.7%) stddev-sans-first:25.79 03:06:14 INFO - PROCESS | 22156 | Values: 94.0 93.0 151.0 93.0 93.0 93.0 138.0 94.0 93.0 144.0 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:06:14 INFO - PROCESS | 22156 | Values: 118.0 118.0 118.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 03:06:14 INFO - PROCESS | 22156 | Values: 148.0 147.0 146.0 147.0 147.0 147.0 148.0 147.0 147.0 146.0 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:06:14 INFO - PROCESS | 22156 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:66.50 stddev:5.25 (7.9%) stddev-sans-first:5.55 03:06:14 INFO - PROCESS | 22156 | Values: 69.0 67.0 65.0 66.0 65.0 66.0 67.0 82.0 65.0 64.0 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 03:06:14 INFO - PROCESS | 22156 | Values: 64.0 65.0 65.0 66.0 65.0 64.0 65.0 66.0 65.0 66.0 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:3.22 (3.9%) stddev-sans-first:3.26 03:06:14 INFO - PROCESS | 22156 | Values: 79.0 79.0 79.0 90.0 81.0 81.0 82.0 82.0 83.0 82.0 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:136.50 stddev:25.14 (18.4%) stddev-sans-first:26.39 03:06:14 INFO - PROCESS | 22156 | Values: 132.0 138.0 132.0 137.0 133.0 131.0 129.0 136.0 213.0 142.0 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.40 Median:178.00 stddev:4.65 (2.6%) stddev-sans-first:3.75 03:06:14 INFO - PROCESS | 22156 | Values: 187.0 177.0 177.0 179.0 179.0 176.0 186.0 173.0 175.0 175.0 03:06:14 INFO - PROCESS | 22156 | 03:06:14 INFO - PROCESS | 22156 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:74.50 stddev:1.84 (2.5%) stddev-sans-first:1.86 03:06:14 INFO - PROCESS | 22156 | Values: 75.0 75.0 75.0 75.0 72.0 74.0 73.0 70.0 71.0 74.0 03:06:14 INFO - PROCESS | 22156 | -------- Summary: end -------- 03:06:14 INFO - PROCESS | 22156 | 03:06:15 INFO - TEST-INFO | 22156: exit 0 03:06:15 INFO - TEST-OK | kraken | took 63788ms 03:06:15 INFO - SUITE-END | took 1179s 03:06:16 INFO - Completed test suite (00:19:39) 03:06:16 INFO - javascript benchmark 03:06:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2605.413781899073, 2655.6813182418114, 2684.382592003839, 2685.342091187659, 2699.0418401467477, 4717.622590192785, 4717.858464246074, 4739.502352253011, 4759.500252473493, 4784.425868895737, 4580.061087477067, 4720.055988802244, 4799.280107983805, 4816.349792777974, 4823.78292976816, 4335.891602709926, 4357.934630980538, 4401.581849724287, 4406.4271644686305, 4429.712068715539, 51.90496534736487, 4293.463317085364, 4367.606915377615, 4409.404869880689, 4439.533848945863, 4384.276594361926, 4396.450443694538, 4398.912021759579, 4404.1852257332175, 4437.267850804614, 4361.629261512775, 4398.956010439919, 4406.53731358206, 4459.130469558438, 4504.234280172379, 4224.2185195738575, 4314.892127696833, 4387.758673272969, 4423.668224883115, 4493.168763778712, 4558.156741002925, 4562.224421848294, 4569.862904112882, 4600.217962946307, 4615.376924115235, 4976.979719157564, 4979.626528010377, 4979.825706100269, 4980.676256043382, 5027.648064635477, 4916.901661966776, 5029.597632189452, 5070.442251352349, 5143.202803565453, 5160.690358578459, 4727.858164255078, 4740.976295118502, 4743.928841067387, 4745.857624271277, 4784.162771514971, 5187.144121220032, 5201.193814958688, 5202.97398513005, 5212.270282160501, 5253.44838791929, 4864.5621894029, 4958.157113290749, 5002.724850133205, 5025.246213067996, 5055.140626093573, 5083.8983220335385, 5111.923321150186, 5112.897742045213, 5115.462876397999, 5171.7672704728375, 4919.4834542373255, 5042.7982880685095, 5049.5707864831165, 5060.51925067118, 5067.645264831426, 4783.545563171493, 4822.9758851206225, 4982.352294201731, 4999.225120106389, 5014.17266151081, 4252.277112890816, 4264.91470170601, 4267.701260911768, 4299.505556861001, 4309.569043095728, 3630.49173115764, 3707.9073023174637, 3738.532683414573, 3758.4174452959287, 3760.191558814868, 4320.027993701392, 4367.235733746582, 4368.104538569585, 4374.628156606724, 4411.1618792429335, 5068.771905264272, 5082.466341034212, 5092.9745351273, 5110.8466745997675, 5137.614678899097, 4218.683598730107, 4329.307310830252, 4358.984601250254, 4393.231184542692, 4435.334699795057, 4531.932021019687, 4547.499775024745, 4550.044490656933, 4584.381108550369, 4594.035252596926, 4750.714957102585, 4767.904641907143, 4768.713877167381, 4770.594499467584, 4809.951900480951, 4955.851324460272, 4985.102681517216, 5052.772625231947, 5067.797288108434, 5090.287359769562, 4747.738874361805, 4765.880852978565, 4778.1638213311835, 4783.0, 4816.253480710496, 4957.851264462072, 4959.950400496094, 4962.354893863775, 4962.6774259673, 5028.245763135559, 4957.529034741694, 5026.949730502648, 5029.220470827027, 5079.5428411443145, 5098.311727916684, 4778.880527986828, 4811.927821082617, 4813.326134341265, 4819.903601928012, 4835.58897493717, 4755.144074066701, 4763.0, 4795.568398844121, 4824.927626085681, 4848.030393921159, 4678.064387122521, 4743.1225223333795, 4761.619070474423, 4790.952090479051, 4869.513048695102, 4895.632827537877, 4912.680675756064, 4914.164592019437, 4918.778654960463, 4952.925706114484, 4784.258439941815, 4831.613470922388, 4844.781984810622, 4866.7079975201605, 4879.804807807648], "value": 4602.083219481422, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.5769067426116, 591.9141724449954, 608.9939100608992, 616.6916541729136, 639.172271907879, 34444.48333275003, 35617.46573801392, 35695.64304356956, 35716.642833571656, 35904.820475897584, 35752.46371304426, 36258.0, 36281.092972675695, 36297.27405451889, 36522.0, 7555.244475552442, 7780.10528789188, 7788.1043679976965, 7795.103563090261, 7807.453478256524, 7592.8861067084035, 7702.383809295243, 7709.6916123354995, 7722.459427840054, 7884.32983196429, 7839.882401763978, 7909.1299957004685, 7912.050553933536, 7912.960435197845, 7921.36629069673, 7719.845603087935, 7798.532088074734, 7843.098043724987, 7871.252231038071, 7878.0, 7719.691212351499, 7766.301032907066, 7838.960805195995, 7843.294103530652, 7859.921400785976, 35298.0, 35832.0, 36052.819735901416, 36206.0, 36213.63786362129, 2565.7177710451833, 3043.7869349145567, 3268.0032590060023, 3435.1579311880137, 3712.053426376257, 27259.86370068157, 27500.724992750016, 27570.5864412034, 27883.0, 27920.860395698095, 3142.874285028596, 3151.11768704763, 3195.9360812783616, 3219.452693042165, 3236.951445728316, 192450.0, 193031.0, 193171.0, 193509.0, 193540.0, 30768.230794230323, 31717.20706982344, 31729.365412691615, 31774.205644859063, 54374.45625543773, 32045.71817127289, 32152.517712234334, 32312.192195195308, 32519.67480325214, 32587.837060814545, 12443.440045197987, 12624.936875315565, 12636.178648387826, 12637.557685480964, 12656.303903285409, 10276.794464110675, 10281.280310378352, 10314.690559283234, 10325.432101234504, 10462.058414742709, 8147.75556733299, 8253.83492330162, 8285.544295063708, 8305.335573154132, 8331.166883311742, 3213.6786321368145, 3232.57976463063, 3264.542963985044, 3285.917852053718, 3286.145602143412, 865.1521508921167, 926.2636204217529, 955.1928620315822, 981.5877331520778, 985.1281615769952, 27338.589921151197, 28230.0, 28470.71529284722, 28681.42637147287, 28991.42017159687, 980.8724865767405, 1004.5931397783909, 1021.5709402051157, 1021.6271061062807, 1047.9266451348333, 14836.851631483763, 15485.535433937, 15519.0, 15545.22273886301, 15664.451744188898, 396051.0, 401417.0, 404373.0, 404874.0, 407065.0, 49626.75186624044, 49971.0, 50325.0, 50382.0, 50386.74806626017, 1199.0395703025615, 1225.4118023348842, 1236.7773800715777, 1240.2000709542294, 1247.8689737577606, 26722.0, 27905.58141627918, 28024.0, 28538.85730571417, 28611.0, 44234.77882610566, 44371.77814110909, 44406.0, 44649.0, 44651.0, 308701.0, 310880.0, 311475.0, 312041.0, 312576.0, 25662.0, 26262.86868565645, 26336.34159146037, 34617.134571635914, 35157.64842351646, 38128.428073579475, 38360.616393835706, 38647.42028869513, 39131.6086839128, 39321.2135757289, 33315.33369332648, 33411.0, 33833.66166338305, 33882.0, 34091.65908340885, 32229.194270143435, 32477.350452990337, 32773.18067048343, 33377.66622333746, 33420.0, 32546.349073018882, 32927.83536082304, 33938.0, 33989.49015764815, 35248.0, 28390.574141387482, 29625.5556166662, 32322.83838580792, 32634.34731305408, 32777.18057048593, 23046.42383940415, 24239.15162969358, 24919.875400623605, 25135.120270790434, 25368.746312537376], "value": 16029.445810293324, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.48508301086014, 375.234521575985, 375.8233630193809, 383.07678494827474, 384.8633735024065, 16056.51830445087, 16437.67124657506, 17251.654966900653, 17281.56796080097, 17305.22126504307, 16047.95688280261, 16551.0, 17237.655246895054, 17335.739963900553, 17380.044097574628, 5011.849644510661, 5157.690538567698, 5169.948300517003, 5203.375594928614, 5207.765650545734, 3655.3785856404475, 5139.203423469349, 5640.7461664225, 5997.0, 5998.820035398945, 5855.180274761537, 5901.114832775097, 5912.9113063304085, 5935.703214839241, 5962.195103661015, 5705.229793977802, 5931.0, 5939.88120237595, 5947.940520594782, 5970.253718285215, 4960.751962401901, 5177.896442071137, 5194.013137503862, 5220.034293655686, 5270.051390749663, 18727.344542940933, 19197.808021919882, 19202.61594768097, 19336.323228686928, 20357.898210509, 1836.6877630802796, 1926.6435709393807, 1941.6699161142499, 2042.60169266993, 2043.1725151313742, 9069.183773460354, 9126.908730912739, 9570.282228832795, 9612.75968100803, 9634.373765705206, 1759.0852756566642, 1793.3970831245022, 1808.7106063029853, 1837.724341348795, 1869.3457289948544, 66311.336886631, 67563.0, 68462.65768671174, 69148.6542567289, 70279.0, 9472.100150485692, 9700.514974251259, 9898.554565044591, 9928.751781205528, 10063.295569310078, 13367.799483007762, 13444.327783610976, 13445.798313025312, 13457.528986485426, 13467.86532134666, 6725.63009034498, 6788.830279243059, 6836.863262734718, 6910.516263861582, 6958.686859091353, 6440.903386449207, 6651.467882569383, 6792.796216113525, 6807.65961701913, 6874.106366172366, 3935.2719746846924, 4069.6744260459686, 4088.141490287073, 4129.793510324472, 4208.431861698693, 1706.5818874375857, 1726.818684038183, 1839.5768973136253, 1907.7138429235727, 1926.422073377981, 936.9250459963187, 939.7697564096703, 948.9098535639104, 958.9409782792868, 984.3995162950595, 15805.0, 16395.5901102471, 16416.83583164177, 16761.413350532916, 16771.2452939618, 892.4734406700078, 933.7385532051037, 934.0722262884555, 958.712386284112, 967.086103632075, 9210.585523651453, 9246.583903724348, 9294.0, 9350.859737103949, 9480.478573678514, 420328.0, 424490.0, 425388.0, 438160.0, 440990.0, 80468.0, 82564.0, 86249.0, 87496.0, 88169.0, 943.9386439881386, 983.3165949664914, 1003.4781913404988, 1005.6279176704666, 1018.3635227982511, 15108.773368399263, 15160.924195378953, 15223.16272604973, 15234.771478428054, 15578.29897654631, 35991.64008359988, 36342.63657363393, 36523.452148218326, 36994.630053700195, 37106.8144659275, 50101.49898500968, 50252.748736256086, 51956.74021629868, 52435.47564524306, 53247.0, 7173.282671732785, 7541.698332066875, 7578.696852126074, 7669.463137580539, 7676.884846727192, 9325.813483730422, 10860.076893464144, 10967.725806854893, 11219.439028048728, 11307.378094204898, 9314.627414903329, 9488.525573721425, 9594.136527712539, 9706.320557561185, 9912.752181195528, 9582.329236953346, 9612.0, 9612.567434465325, 9642.0, 9666.420014799134, 9092.136247056518, 9445.433274003582, 9450.763730906783, 9635.904740485126, 9678.0, 7304.659319883748, 7574.848503030019, 7584.393248540214, 7688.692452302069, 7754.88367674474, 8578.750955442641, 9739.464329461947, 9887.901120988698, 9933.751656208653, 10037.297389182688], "value": 8198.007949638357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.1448987852225, 1451.6516036151324, 1556.9766453503191, 1725.6893759123361, 1735.1064201935997, 6848.4178844798125, 7458.366038886701, 7465.813354666136, 7820.413468989827, 7821.2569805868425, 7465.290797374254, 7474.663640136193, 7490.5131166474275, 7556.168821429638, 7580.848383032336, 2167.111484291445, 2225.054351900444, 2230.2528652901296, 2230.933072007834, 2232.743234528034, 2174.684670722744, 2178.684090806832, 2205.2943058221376, 2209.812165965895, 2214.1918199857096, 2080.823130033949, 2118.8304935605115, 2119.014658183944, 2130.808227259546, 2152.7954844289766, 2127.7233959585233, 2151.526664133888, 2151.8601290916117, 2155.1056311630655, 2158.719366482363, 2130.158587358, 2182.4871155278497, 2194.9341519754435, 2210.071769856664, 2219.2676416782424, 7608.543487390719, 7687.231276872324, 7692.576908270043, 7695.0765908090825, 7715.729949451798, 4534.433195850519, 4666.673332866667, 4676.228422310314, 4705.929411058837, 4709.058188362307, 2781.624480695121, 2816.7887408444244, 2891.421715656856, 2915.825050496977, 2933.06142034549, 867.1285358215017, 903.9367244292837, 909.4043401571981, 910.544727636182, 920.8112336970905, 10551.103156231806, 10573.788524229549, 10578.259521833397, 10600.469976501221, 10657.893421065768, 4252.574742525722, 4310.073334233155, 4352.804123814436, 4353.325234588644, 4385.947372630546, 9081.364304498753, 9096.909030909606, 9147.588358523883, 9199.540022998957, 9210.0, 4715.198416269242, 4720.268358404453, 4732.148213321566, 4743.359646447685, 4744.288356746516, 3708.499352587366, 4093.488313960755, 4236.9788151059665, 4284.186004659105, 4316.6546676265825, 3680.429533422324, 3727.38498147808, 3784.243151369737, 3789.0906182515996, 3825.3305671507374, 1190.2025642819333, 1205.8070708686569, 1209.1415095282448, 1210.7881120803825, 1221.6396163131897, 859.3168431097292, 862.4652715316544, 863.727925703414, 875.4047247871508, 894.3828758156851, 5192.376914770176, 5296.3379577552805, 5408.350997880201, 5525.198846167284, 5656.981743286248, 877.9780505487414, 919.4667093085994, 925.6621333213328, 937.2361525356812, 941.2752180820867, 3594.353016457063, 3643.107438677541, 3645.179834537208, 3688.686461650736, 3719.9442008369897, 9428.340016198938, 9824.164945979672, 9887.456189909624, 9892.25808064398, 9932.503374831374, 9692.9030709692, 9712.61149554024, 9736.707898763048, 9761.219102471785, 9795.510224488748, 7292.0, 7509.586972716553, 7548.056492938383, 7553.660085296175, 7560.0, 5135.537801597874, 5253.369595648546, 5254.868628284324, 5260.079486089842, 5331.733413329395, 8417.410781245255, 8444.071152173134, 8559.95720021396, 8608.354373421893, 8686.305095592212, 8747.387682862138, 8748.037715851124, 8780.868286975572, 9012.279017678438, 9047.909520904706, 6300.0, 6666.633335166418, 6699.263081061177, 6829.726810927507, 6896.172459304916, 7394.223606521237, 7395.408367330493, 7454.4781865268915, 7462.44031697614, 7488.101427828696, 6544.0, 6806.863862722619, 6859.725610975505, 6861.382475577022, 6917.584944903322, 6785.457163426815, 6847.109875716125, 6853.4859885507785, 6915.343042410963, 6967.65161741921, 6346.650934198478, 6398.456131228898, 6409.230892292955, 6427.0, 6681.164854393201, 4727.881802954954, 4781.6891902026255, 4851.126797176542, 4877.365942427462, 4889.706617602955, 4649.093426781745, 4697.154512187839, 4741.83403580873, 4758.119747846659, 4799.136155491905], "value": 4179.857572220226, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.39370063023637, 310.9626844778627, 311.13659594624926, 315.471585094966, 316.2441764183603, 4947.183714687077, 4977.3529441172595, 4999.500049994998, 5036.622253331001, 5037.571806396456, 4931.654784165101, 4943.0, 4952.479989601094, 4955.851324460263, 4959.181735013718, 3715.368387374153, 3813.504244448218, 3924.0778417071965, 3932.4073750131242, 3956.3867600521967, 3936.547297060846, 3937.488126543545, 3946.289667859784, 3964.1278918637854, 3972.2849887020325, 3847.1920896611746, 3895.6493915547594, 3902.9804850975706, 3918.7648741075486, 3943.1127996200767, 3835.789031603261, 3893.299206142893, 3921.509811273591, 3939.9212015759667, 3950.4716981132096, 3469.5142680024815, 3473.583170019614, 3483.372992861284, 3484.26830365621, 3491.8603255869734, 4739.0, 4755.19584332536, 4778.283257511366, 4781.163296423147, 4817.542333478314, 4354.564543545652, 4447.977760111179, 4458.621017213541, 4465.843695470643, 4480.215962206601, 5111.4121875984365, 5129.84610461683, 5135.073008385222, 5142.897142057175, 5151.253068305112, 3757.210985693008, 3769.095417099904, 3779.7165212609166, 3792.50697409335, 3798.601146879593, 5403.78384864605, 5406.243125962368, 5415.483664573926, 5441.29263195786, 5441.700706461143, 3485.5991560970306, 3686.944695829565, 3723.627637236309, 3742.176721121349, 3743.9064023399087, 3751.780671281844, 3776.811159442072, 3780.640839120334, 3782.3002744492355, 3787.9431808522895, 4325.502567204749, 4345.239583072949, 4350.71720338177, 4355.412019377407, 4359.0, 5025.844055867171, 5128.358955130609, 5190.24741412493, 5197.870053248624, 5238.214267859851, 1387.6669599296097, 1404.1224234853216, 1405.2552147361914, 1407.4792326839136, 1415.610707055568, 867.0, 915.5651065743718, 938.9859152112724, 954.9904500954901, 963.7397902566267, 4478.619317358061, 4585.793639286173, 4598.241290187082, 4601.838935637236, 4616.853163279091, 5273.920891186635, 5331.147016477423, 5385.461453854583, 5393.892122157535, 5429.782808687687, 4457.7548234846745, 4573.49691533931, 4576.176288268077, 4593.058423023273, 4596.218642830727, 3031.1815809731247, 3049.4663433898977, 3057.5872257245433, 3061.1734831595345, 3065.203047207742, 5370.113931201387, 5378.408375078739, 5387.24578559002, 5407.809837016015, 5409.0, 5689.9146512802345, 5859.384764599741, 5870.119482077723, 5904.734286957011, 5921.644701317935, 5389.326334208224, 5389.595780316492, 5395.568354531707, 5405.270288511079, 5419.756110974937, 5738.0, 5753.252077229933, 5762.625429347079, 5778.711064446845, 5781.682007489629, 5054.82308119214, 5335.279737235423, 5351.384590772111, 5352.437994010728, 5353.770521288295, 5098.694078355311, 5122.590192784643, 5130.51260130287, 5137.691738495702, 5146.150885103916, 3778.981105094457, 3813.7521061130938, 3813.904652383713, 3821.8089095544556, 3833.386658134685, 5192.948070519246, 5378.005069062079, 5409.594280428905, 5424.53891419218, 5433.130699088127, 5223.399309079353, 5231.875146843447, 5255.605829562722, 5262.631615786858, 5271.446498117796, 4933.55597996182, 5214.556762675215, 5222.947770522246, 5238.449962753856, 5256.842294731164, 5117.616178786531, 5132.5124113209185, 5138.818071843422, 5140.0, 5171.844844654666, 4979.825706100269, 5011.922436676132, 5208.661437006583, 5220.686758794484, 5285.572895318166, 5091.643584949018, 5098.852758129391, 5110.853441554482, 5119.28330033803, 5137.922931155961], "value": 3977.8623214938843, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.6860001399285, 620.8758248350331, 633.1515768869716, 684.9075374824398, 702.4731451411442, 11071.612493562727, 11899.76200475991, 12336.136470447072, 12490.50037998479, 12539.937300313497, 12973.091883568153, 13378.063535552516, 13459.798103028437, 13461.730765384686, 13462.326883655802, 808.8746244332124, 811.9594020298962, 812.7317985064944, 813.9715109971153, 814.5601375257384, 807.2532907060975, 808.5835794565803, 809.7327881799022, 810.0522388805113, 811.4279432999721, 839.2488722593275, 839.6011894350196, 841.1504380575632, 844.6536919862857, 845.247729520727, 836.824266903951, 841.2134654098408, 842.7219017724167, 846.1411667157839, 846.1876598465481, 587.0724255676022, 605.4127496328555, 610.2920612089954, 610.3499772742016, 612.6171143035602, 12025.398730063462, 12262.26426414418, 12271.938640306742, 12318.5072597096, 12334.32161231132, 10528.947355263175, 10948.726281843017, 11470.311781293065, 11876.990455811267, 12082.69793255167, 9376.718698439057, 9795.902040979641, 10097.596096156145, 10121.067069057719, 10232.795344093076, 3918.3142949983926, 3936.7441116327345, 3950.032242100675, 3981.186707524818, 4067.8983025424304, 44409.223631054716, 44631.875768696205, 45558.31662525065, 45921.08157836858, 46836.297455538195, 8727.60725767342, 9019.0, 9044.186023257938, 9063.13900179482, 9163.404378715362, 16217.35130594763, 16248.268827902773, 16283.430079947146, 16343.754843677354, 16359.83640163607, 6259.342769009279, 6366.9681651591445, 6421.3578642136345, 6495.7076931538195, 6549.639769812611, 3743.344914639927, 3841.116543195025, 3847.1728578355787, 3852.2680690669245, 3878.26313000529, 2676.9196924092307, 2689.1125928443566, 2711.295063283521, 2724.3325385280336, 2737.507248695254, 485.83967290793953, 487.7146869081627, 488.8289098815457, 505.28502169429845, 512.3109417833009, 521.9321488206584, 569.5159114752428, 571.6770024935898, 589.3870374810149, 621.7233331167678, 7508.2491750825575, 7549.320561149523, 7659.310662040331, 7772.18392068836, 7836.804079898048, 568.6076607141142, 596.9253843269591, 615.3999850146162, 621.052894336141, 633.4457349818908, 3528.3825330567047, 3722.218334149859, 3731.7014638828828, 3731.981340093282, 3734.682551983112, 50670.239946400834, 51715.482845171064, 52332.73833630884, 53236.73381633144, 54169.1874621881, 44997.0, 46690.766546167055, 47060.29409558791, 48191.5180848187, 48206.5179348202, 43287.0, 44038.77980610076, 44204.336934946004, 44472.555274446844, 44532.3320150198, 7160.928390716234, 7192.676329565287, 7197.208307086321, 7211.531250468703, 7251.709931602677, 30305.69694303029, 30811.53782693306, 31494.0, 31593.0, 31651.683483164874, 36884.446733298486, 38980.2203955925, 39049.804750976065, 39105.217895641355, 40323.59676403316, 8778.692745754124, 8919.643214271357, 8974.955125224333, 8996.415233009833, 9006.594703238501, 10061.597536098767, 10333.379997200193, 10403.58385664565, 10425.341537907785, 10507.894921050998, 9194.724158275263, 9560.521973901137, 9576.090271424204, 9612.99063598312, 9742.853857192289, 9795.853062204214, 9811.460369679737, 9879.555420005972, 9940.353876997971, 10110.241731869992, 9447.338686291894, 9685.0, 9723.65967191145, 9768.85346719814, 9811.0, 7841.843163136591, 7919.802004949692, 8032.277095061472, 8038.276555110068, 8102.513849169069, 7401.259874012556, 7492.587907665131, 7619.580923049286, 7738.264864837832, 7971.1630278819885], "value": 5711.728455992041, "unit": "score"}], "name": "dromaeo_css", "value": 6211.560056072492, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 114.0, 113.0, 114.0, 126.0, 115.0, 112.0, 113.0, 112.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 139.0, 160.0, 191.0, 129.0, 161.0, 158.0, 140.0, 197.0, 135.0], "value": 157.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 167.0, 165.0, 162.0, 161.0, 164.0, 166.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 154.0, 78.0, 73.0, 77.0, 77.0, 157.0, 75.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 151.0, 93.0, 93.0, 93.0, 138.0, 94.0, 93.0, 144.0], "value": 108.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 65.0, 66.0, 65.0, 66.0, 67.0, 82.0, 65.0, 64.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 66.0, 65.0, 64.0, 65.0, 66.0, 65.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 90.0, 81.0, 81.0, 82.0, 82.0, 83.0, 82.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 138.0, 132.0, 137.0, 133.0, 131.0, 129.0, 136.0, 213.0, 142.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 177.0, 177.0, 179.0, 179.0, 176.0, 186.0, 173.0, 175.0, 175.0], "value": 178.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 75.0, 72.0, 74.0, 73.0, 70.0, 71.0, 74.0], "value": 73.4, "unit": "score"}], "name": "kraken", "value": 1605.3, "alertThreshold": 2.0}]} 03:06:16 INFO - Return code: 0 03:06:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:06:16 ERROR - # TBPL SUCCESS # 03:06:16 INFO - Running post-action listener: _resource_record_post_action 03:06:16 INFO - Running post-run listener: _resource_record_post_run 03:06:17 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 519012352; Read time: 0; Write time: 449760 03:06:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234692608; Read time: 0; Write time: 255456 03:06:17 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 284200960; Read time: 0; Write time: 194304 03:06:17 INFO - Running post-run listener: _upload_blobber_files 03:06:17 INFO - Blob upload gear active. 03:06:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:06:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:06:17 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'] 03:06:17 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 03:06:17 INFO - (blobuploader) - INFO - Open directory for files ... 03:06:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:06:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:06:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:18 INFO - (blobuploader) - INFO - Done attempting. 03:06:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:06:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:06:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:19 INFO - (blobuploader) - INFO - Done attempting. 03:06:19 INFO - (blobuploader) - INFO - Iteration through files over. 03:06:19 INFO - Return code: 0 03:06:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:06:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:06:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6b0bfd806e28c8f22df856b5a24cc12aed00b0d24cf440ffd1b6f7cf10ea1b203341f241083057ea58d73406e48404599fbc82bade9c396766157a7315098eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f68ba98c8184393583adf20287af0e936ad5f2a4b9a970c45cd63936a55a5f7df5ea65811b74bb061e2602053e5d6f40675e8648ebf780d8ebe79c47109f52c8"} 03:06:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:06:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:06:19 INFO - Contents: 03:06:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6b0bfd806e28c8f22df856b5a24cc12aed00b0d24cf440ffd1b6f7cf10ea1b203341f241083057ea58d73406e48404599fbc82bade9c396766157a7315098eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f68ba98c8184393583adf20287af0e936ad5f2a4b9a970c45cd63936a55a5f7df5ea65811b74bb061e2602053e5d6f40675e8648ebf780d8ebe79c47109f52c8"} 03:06:19 INFO - Running post-run listener: copy_logs_to_upload_dir 03:06:19 INFO - Copying logs to upload dir... 03:06:19 INFO - mkdir: /builds/slave/test/build/upload/logs 03:06:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.631420 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-29 03:06:18.739331) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 03:06:18.743708) ========= 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-1461922614.425881-1385736047 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/f6b0bfd806e28c8f22df856b5a24cc12aed00b0d24cf440ffd1b6f7cf10ea1b203341f241083057ea58d73406e48404599fbc82bade9c396766157a7315098eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f68ba98c8184393583adf20287af0e936ad5f2a4b9a970c45cd63936a55a5f7df5ea65811b74bb061e2602053e5d6f40675e8648ebf780d8ebe79c47109f52c8"} build_url:https://queue.taskcluster.net/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/WwSeEMb1RQmjFShfYSRL4w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6b0bfd806e28c8f22df856b5a24cc12aed00b0d24cf440ffd1b6f7cf10ea1b203341f241083057ea58d73406e48404599fbc82bade9c396766157a7315098eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f68ba98c8184393583adf20287af0e936ad5f2a4b9a970c45cd63936a55a5f7df5ea65811b74bb061e2602053e5d6f40675e8648ebf780d8ebe79c47109f52c8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 03:06:18.773181) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 03:06:18.773510) ========= 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-1461922614.425881-1385736047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004397 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 03:06:18.857715) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 03:06:18.858071) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 03:06:18.858417) ========= ========= Total master_lag: 0.19 =========