builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1462533485.59 results: success (0) buildid: 20160506025825 builduid: 7afa7bb42cf04cb2990e63e278f43027 revision: 25d777f7efb357fc5478251913548521986abaa0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 04:18:05.587506) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 04:18:05.587967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 04:18:05.588242) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 04:18:05.605335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:18:05.605682) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 04:18:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 107M=0s 2016-05-06 04:18:05 (107 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083576 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:18:05.702497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:18:05.702804) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020149 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:18:05.752661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:18:05.753012) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 25d777f7efb357fc5478251913548521986abaa0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 25d777f7efb357fc5478251913548521986abaa0 --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=4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 04:18:05,884 truncating revision to first 12 chars 2016-05-06 04:18:05,884 Setting DEBUG logging. 2016-05-06 04:18:05,884 attempt 1/10 2016-05-06 04:18:05,884 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/25d777f7efb3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 04:18:06,182 unpacking tar archive at: mozilla-central-25d777f7efb3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.581383 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:18:06.348381) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 04:18:06.348865) ========= script_repo_revision: 25d777f7efb357fc5478251913548521986abaa0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 04:18:06.349322) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 04:18:06.349606) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 04:18:06.357366) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-06 04:18:06.357685) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:18:06 INFO - MultiFileLogger online at 20160506 04:18:06 in /builds/slave/test 04:18:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:18:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:18:06 INFO - {'append_to_log': False, 04:18:06 INFO - 'base_work_dir': '/builds/slave/test', 04:18:06 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:18:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:18:06 INFO - 'branch': 'Firefox-Non-PGO', 04:18:06 INFO - 'buildbot_json_path': 'buildprops.json', 04:18:06 INFO - 'config_files': ('talos/linux_config.py',), 04:18:06 INFO - 'default_actions': ('clobber', 04:18:06 INFO - 'read-buildbot-config', 04:18:06 INFO - 'download-and-extract', 04:18:06 INFO - 'populate-webroot', 04:18:06 INFO - 'create-virtualenv', 04:18:06 INFO - 'install', 04:18:06 INFO - 'run-tests'), 04:18:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:18:06 INFO - 'download_minidump_stackwalk': True, 04:18:06 INFO - 'download_symbols': 'ondemand', 04:18:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:18:06 INFO - 'tooltool.py': '/tools/tooltool.py', 04:18:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:18:06 INFO - '/tools/misc-python/virtualenv.py')}, 04:18:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:18:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:18:06 INFO - 'installer_path': 'installer.exe', 04:18:06 INFO - 'log_level': 'info', 04:18:06 INFO - 'log_name': 'talos', 04:18:06 INFO - 'log_to_console': True, 04:18:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:18:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:18:06 INFO - 'opt_config_files': (), 04:18:06 INFO - 'pip_index': False, 04:18:06 INFO - 'sps_profile': False, 04:18:06 INFO - 'sps_profile_interval': 0, 04:18:06 INFO - 'suite': 'dromaeojs-e10s', 04:18:06 INFO - 'system_bits': '32', 04:18:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:18:06 INFO - 'title': 'talos-linux64-ix-030', 04:18:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:18:06 INFO - 'use_talos_json': True, 04:18:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:18:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:18:06 INFO - 'work_dir': 'build'} 04:18:06 INFO - ##### 04:18:06 INFO - ##### Running clobber step. 04:18:06 INFO - ##### 04:18:06 INFO - Running pre-action listener: _resource_record_pre_action 04:18:06 INFO - Running main action method: clobber 04:18:06 INFO - rmtree: /builds/slave/test/build 04:18:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:18:07 INFO - Running post-action listener: _resource_record_post_action 04:18:07 INFO - ##### 04:18:07 INFO - ##### Running read-buildbot-config step. 04:18:07 INFO - ##### 04:18:07 INFO - Running pre-action listener: _resource_record_pre_action 04:18:07 INFO - Running main action method: read_buildbot_config 04:18:07 INFO - Using buildbot properties: 04:18:07 INFO - { 04:18:07 INFO - "project": "", 04:18:07 INFO - "product": "firefox", 04:18:07 INFO - "script_repo_revision": "production", 04:18:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:18:07 INFO - "repository": "", 04:18:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:18:07 INFO - "buildid": "20160506025825", 04:18:07 INFO - "pgo_build": "False", 04:18:07 INFO - "basedir": "/builds/slave/test", 04:18:07 INFO - "buildnumber": 47, 04:18:07 INFO - "slavename": "talos-linux64-ix-030", 04:18:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:18:07 INFO - "platform": "ubuntu64_hw", 04:18:07 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:18:07 INFO - "branch": "mozilla-central", 04:18:07 INFO - "repo_path": "mozilla-central", 04:18:07 INFO - "revision": "25d777f7efb357fc5478251913548521986abaa0", 04:18:07 INFO - "stage_platform": "linux64", 04:18:07 INFO - "builduid": "7afa7bb42cf04cb2990e63e278f43027", 04:18:07 INFO - "slavebuilddir": "test" 04:18:07 INFO - } 04:18:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:18:07 INFO - Running post-action listener: _resource_record_post_action 04:18:07 INFO - ##### 04:18:07 INFO - ##### Running download-and-extract step. 04:18:07 INFO - ##### 04:18:07 INFO - Running pre-action listener: _resource_record_pre_action 04:18:07 INFO - Running main action method: download_and_extract 04:18:07 INFO - mkdir: /builds/slave/test/build/tests 04:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:07 INFO - https://queue.taskcluster.net/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:18:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:18:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:18:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/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 04:18:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/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 04:18:08 INFO - Downloaded 1361 bytes. 04:18:08 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:18:08 INFO - Using the following test package requirements: 04:18:08 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:18:08 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:18:08 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:18:08 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:08 INFO - u'jsshell-linux-x86_64.zip'], 04:18:08 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:18:08 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:18:08 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:18:08 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:18:08 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:18:08 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:18:08 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:08 INFO - https://queue.taskcluster.net/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:18:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:18:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:18:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/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 04:18:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/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 04:18:09 INFO - Downloaded 22321073 bytes. 04:18:09 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'] 04:18:09 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 04:18:10 INFO - Return code: 0 04:18:10 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 04:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:10 INFO - https://queue.taskcluster.net/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:18:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:18:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:18:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/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 04:18:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/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 04:18:12 INFO - Downloaded 22321073 bytes. 04:18:12 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'] 04:18:12 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 04:18:13 INFO - Return code: 0 04:18: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')]} 04:18:13 INFO - https://queue.taskcluster.net/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:18:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:18:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:18:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/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 04:18:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/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 04:18:14 INFO - Downloaded 10840152 bytes. 04:18:14 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'] 04:18:14 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 04:18:14 INFO - Return code: 0 04:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:14 INFO - https://queue.taskcluster.net/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:18:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:18:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:18:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/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 04:18:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/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 04:18:16 INFO - Downloaded 54838855 bytes. 04:18:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:18:16 INFO - mkdir: /builds/slave/test/properties 04:18:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:18:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:18:16 INFO - Contents: 04:18:16 INFO - build_url:https://queue.taskcluster.net/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:18:16 INFO - Running post-action listener: _resource_record_post_action 04:18:16 INFO - Running post-action listener: set_extra_try_arguments 04:18:16 INFO - ##### 04:18:16 INFO - ##### Running populate-webroot step. 04:18:16 INFO - ##### 04:18:16 INFO - Running pre-action listener: _resource_record_pre_action 04:18:16 INFO - Running main action method: populate_webroot 04:18:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:18:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:18:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:18:16 INFO - '--tppagecycles', 04:18:16 INFO - '7'], 04:18:16 INFO - 'tests': ['tsvgm']}}, 04:18:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:18:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:18:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:18:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:18:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:18:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:18:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:16 INFO - 'talos_options': ['--disable-e10s'], 04:18:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:16 INFO - 'talos_options': ['--disable-e10s'], 04:18:16 INFO - 'tests': ['damp', 'tps']}, 04:18:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:16 INFO - 'tests': ['damp', 'tps']}, 04:18:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:18:16 INFO - 'tests': ['dromaeo_dom']}, 04:18:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:18:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:18:16 INFO - 'tests': ['a11yr', 04:18:16 INFO - 'ts_paint', 04:18:16 INFO - 'tpaint', 04:18:16 INFO - 'sessionrestore', 04:18:16 INFO - 'sessionrestore_no_auto_restore', 04:18:16 INFO - 'tabpaint']}, 04:18:16 INFO - 'other-e10s': {'tests': ['a11yr', 04:18:16 INFO - 'ts_paint', 04:18:16 INFO - 'tpaint', 04:18:16 INFO - 'sessionrestore', 04:18:16 INFO - 'sessionrestore_no_auto_restore', 04:18:16 INFO - 'tabpaint']}, 04:18:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:18:16 INFO - 'ts_paint', 04:18:16 INFO - 'tpaint', 04:18:16 INFO - 'sessionrestore', 04:18:16 INFO - 'sessionrestore_no_auto_restore', 04:18:16 INFO - 'tabpaint']}, 04:18:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:18:16 INFO - 'ts_paint', 04:18:16 INFO - 'tpaint', 04:18:16 INFO - 'sessionrestore', 04:18:16 INFO - 'sessionrestore_no_auto_restore', 04:18:16 INFO - 'tabpaint']}, 04:18:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:18:16 INFO - 'tests': ['a11yr', 04:18:16 INFO - 'ts_paint', 04:18:16 INFO - 'tpaint', 04:18:16 INFO - 'sessionrestore', 04:18:16 INFO - 'sessionrestore_no_auto_restore', 04:18:16 INFO - 'tabpaint']}, 04:18:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:18:16 INFO - 'tests': ['a11yr', 04:18:16 INFO - 'ts_paint', 04:18:16 INFO - 'tpaint', 04:18:16 INFO - 'sessionrestore', 04:18:16 INFO - 'sessionrestore_no_auto_restore', 04:18:16 INFO - 'tabpaint']}, 04:18:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:18:16 INFO - 'tests': ['tsvgx', 04:18:16 INFO - 'tsvgr_opacity', 04:18:16 INFO - 'tart', 04:18:16 INFO - 'tscrollx', 04:18:16 INFO - 'cart']}, 04:18:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:18:16 INFO - 'tsvgr_opacity', 04:18:16 INFO - 'tart', 04:18:16 INFO - 'tscrollx', 04:18:16 INFO - 'cart']}, 04:18:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:16 INFO - 'talos_options': ['--disable-e10s'], 04:18:16 INFO - 'tests': ['tp5o']}, 04:18:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:16 INFO - 'tests': ['tp5o']}, 04:18:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:16 INFO - 'talos_options': ['--disable-e10s', 04:18:16 INFO - '--xperf_path', 04:18:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:16 INFO - 'tests': ['tp5n']}, 04:18:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:16 INFO - 'talos_options': ['--xperf_path', 04:18:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:16 INFO - 'tests': ['tp5n']}}, 04:18:16 INFO - 'talos.zip': {'path': '', 04:18:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:18:16 INFO - Running post-action listener: _resource_record_post_action 04:18:16 INFO - ##### 04:18:16 INFO - ##### Running create-virtualenv step. 04:18:16 INFO - ##### 04:18:16 INFO - Running pre-action listener: _resource_record_pre_action 04:18:16 INFO - Running main action method: create_virtualenv 04:18:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:18:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:18:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:18:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:18:17 INFO - Using real prefix '/usr' 04:18:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:18:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:18:19 INFO - Installing pip.................done. 04:18:19 INFO - Return code: 0 04:18:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:19 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 0x7f75c2884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b640>, '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 0x155c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155c9d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:18:19 INFO - Using env: {'DISPLAY': ':0', 04:18:19 INFO - 'HOME': '/home/cltbld', 04:18:19 INFO - 'LANG': 'en_US.UTF-8', 04:18:19 INFO - 'LANGUAGE': 'en_US:en', 04:18:19 INFO - 'LOGNAME': 'cltbld', 04:18:19 INFO - 'MAIL': '/var/mail/cltbld', 04:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:19 INFO - 'MOZ_NO_REMOTE': '1', 04:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:19 INFO - 'NO_EM_RESTART': '1', 04:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:19 INFO - 'PWD': '/builds/slave/test', 04:18:19 INFO - 'SHELL': '/bin/bash', 04:18:19 INFO - 'SHLVL': '1', 04:18:19 INFO - 'TERM': 'linux', 04:18:19 INFO - 'TMOUT': '86400', 04:18:19 INFO - 'USER': 'cltbld', 04:18:19 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 04:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:19 INFO - '_': '/tools/buildbot/bin/python'} 04:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:18:19 INFO - Cleaning up... 04:18:19 INFO - Return code: 0 04:18:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:19 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 0x7f75c2884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b640>, '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 0x155c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155c9d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:19 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 04:18:19 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 04:18:19 INFO - Using env: {'DISPLAY': ':0', 04:18:19 INFO - 'HOME': '/home/cltbld', 04:18:19 INFO - 'LANG': 'en_US.UTF-8', 04:18:19 INFO - 'LANGUAGE': 'en_US:en', 04:18:19 INFO - 'LOGNAME': 'cltbld', 04:18:19 INFO - 'MAIL': '/var/mail/cltbld', 04:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:19 INFO - 'MOZ_NO_REMOTE': '1', 04:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:19 INFO - 'NO_EM_RESTART': '1', 04:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:19 INFO - 'PWD': '/builds/slave/test', 04:18:19 INFO - 'SHELL': '/bin/bash', 04:18:19 INFO - 'SHLVL': '1', 04:18:19 INFO - 'TERM': 'linux', 04:18:19 INFO - 'TMOUT': '86400', 04:18:19 INFO - 'USER': 'cltbld', 04:18:19 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 04:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:19 INFO - '_': '/tools/buildbot/bin/python'} 04:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:20 INFO - Downloading/unpacking psutil>=0.7.1 04:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:18:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:22 INFO - Installing collected packages: psutil 04:18:22 INFO - Running setup.py install for psutil 04:18:22 INFO - building 'psutil._psutil_linux' extension 04:18:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:18:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:18:22 INFO - building 'psutil._psutil_posix' extension 04:18:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:18:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:18:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:22 INFO - Successfully installed psutil 04:18:22 INFO - Cleaning up... 04:18:22 INFO - Return code: 0 04:18:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:22 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 0x7f75c2884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b640>, '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 0x155c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155c9d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:22 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 04:18:22 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 04:18:22 INFO - Using env: {'DISPLAY': ':0', 04:18:22 INFO - 'HOME': '/home/cltbld', 04:18:22 INFO - 'LANG': 'en_US.UTF-8', 04:18:22 INFO - 'LANGUAGE': 'en_US:en', 04:18:22 INFO - 'LOGNAME': 'cltbld', 04:18:22 INFO - 'MAIL': '/var/mail/cltbld', 04:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:22 INFO - 'MOZ_NO_REMOTE': '1', 04:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:22 INFO - 'NO_EM_RESTART': '1', 04:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:22 INFO - 'PWD': '/builds/slave/test', 04:18:22 INFO - 'SHELL': '/bin/bash', 04:18:22 INFO - 'SHLVL': '1', 04:18:22 INFO - 'TERM': 'linux', 04:18:22 INFO - 'TMOUT': '86400', 04:18:22 INFO - 'USER': 'cltbld', 04:18:22 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 04:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:22 INFO - '_': '/tools/buildbot/bin/python'} 04:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:18:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:18:24 INFO - Installing collected packages: mozsystemmonitor 04:18:24 INFO - Running setup.py install for mozsystemmonitor 04:18:24 INFO - Successfully installed mozsystemmonitor 04:18:24 INFO - Cleaning up... 04:18:24 INFO - Return code: 0 04:18:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:24 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 0x7f75c2884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b640>, '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 0x155c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155c9d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:18:24 INFO - Using env: {'DISPLAY': ':0', 04:18:24 INFO - 'HOME': '/home/cltbld', 04:18:24 INFO - 'LANG': 'en_US.UTF-8', 04:18:24 INFO - 'LANGUAGE': 'en_US:en', 04:18:24 INFO - 'LOGNAME': 'cltbld', 04:18:24 INFO - 'MAIL': '/var/mail/cltbld', 04:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:24 INFO - 'MOZ_NO_REMOTE': '1', 04:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:24 INFO - 'NO_EM_RESTART': '1', 04:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:24 INFO - 'PWD': '/builds/slave/test', 04:18:24 INFO - 'SHELL': '/bin/bash', 04:18:24 INFO - 'SHLVL': '1', 04:18:24 INFO - 'TERM': 'linux', 04:18:24 INFO - 'TMOUT': '86400', 04:18:24 INFO - 'USER': 'cltbld', 04:18:24 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 04:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:24 INFO - '_': '/tools/buildbot/bin/python'} 04:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:25 INFO - Downloading/unpacking blobuploader==1.2.4 04:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:26 INFO - Downloading blobuploader-1.2.4.tar.gz 04:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:18:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:18:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:27 INFO - Downloading docopt-0.6.1.tar.gz 04:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:18:27 INFO - Installing collected packages: blobuploader, requests, docopt 04:18:27 INFO - Running setup.py install for blobuploader 04:18:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:18:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:18:27 INFO - Running setup.py install for requests 04:18:28 INFO - Running setup.py install for docopt 04:18:28 INFO - Successfully installed blobuploader requests docopt 04:18:28 INFO - Cleaning up... 04:18:28 INFO - Return code: 0 04:18:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:28 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 0x7f75c2884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b640>, '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 0x155c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155c9d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:18:28 INFO - Using env: {'DISPLAY': ':0', 04:18:28 INFO - 'HOME': '/home/cltbld', 04:18:28 INFO - 'LANG': 'en_US.UTF-8', 04:18:28 INFO - 'LANGUAGE': 'en_US:en', 04:18:28 INFO - 'LOGNAME': 'cltbld', 04:18:28 INFO - 'MAIL': '/var/mail/cltbld', 04:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:28 INFO - 'MOZ_NO_REMOTE': '1', 04:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:28 INFO - 'NO_EM_RESTART': '1', 04:18:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:28 INFO - 'PWD': '/builds/slave/test', 04:18:28 INFO - 'SHELL': '/bin/bash', 04:18:28 INFO - 'SHLVL': '1', 04:18:28 INFO - 'TERM': 'linux', 04:18:28 INFO - 'TMOUT': '86400', 04:18:28 INFO - 'USER': 'cltbld', 04:18:28 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 04:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:28 INFO - '_': '/tools/buildbot/bin/python'} 04:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:28 INFO - Running setup.py (path:/tmp/pip-kfGACG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:28 INFO - Running setup.py (path:/tmp/pip-9VeIor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:28 INFO - Running setup.py (path:/tmp/pip-ZYgonD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:28 INFO - Running setup.py (path:/tmp/pip-Qg63FK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:28 INFO - Running setup.py (path:/tmp/pip-4uzCS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:28 INFO - Running setup.py (path:/tmp/pip-bGlKiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:28 INFO - Running setup.py (path:/tmp/pip-vfTQ5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:28 INFO - Running setup.py (path:/tmp/pip-0QNUH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:29 INFO - Running setup.py (path:/tmp/pip-aoIWev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:29 INFO - Running setup.py (path:/tmp/pip-SFlp2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:29 INFO - Running setup.py (path:/tmp/pip-tL5bVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:29 INFO - Running setup.py (path:/tmp/pip-JLKvxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:29 INFO - Running setup.py (path:/tmp/pip-1f6xBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:29 INFO - Running setup.py (path:/tmp/pip-GORDXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:29 INFO - Running setup.py (path:/tmp/pip-eaoOo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:29 INFO - Running setup.py (path:/tmp/pip-lzDQaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:29 INFO - Running setup.py (path:/tmp/pip-mJQjoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:18:29 INFO - Running setup.py install for manifestparser 04:18:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:18:29 INFO - Running setup.py install for mozcrash 04:18:29 INFO - Running setup.py install for mozdebug 04:18:30 INFO - Running setup.py install for mozdevice 04:18:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:18:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:18:30 INFO - Running setup.py install for mozfile 04:18:30 INFO - Running setup.py install for mozhttpd 04:18:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:18:30 INFO - Running setup.py install for mozinfo 04:18:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:18:30 INFO - Running setup.py install for mozInstall 04:18:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:18:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:18:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:18:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:18:30 INFO - Running setup.py install for mozleak 04:18:30 INFO - Running setup.py install for mozlog 04:18:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:18:30 INFO - Running setup.py install for moznetwork 04:18:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:18:30 INFO - Running setup.py install for mozprocess 04:18:30 INFO - Running setup.py install for mozprofile 04:18:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:18:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:18:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:18:31 INFO - Running setup.py install for mozrunner 04:18:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:18:31 INFO - Running setup.py install for mozscreenshot 04:18:31 INFO - Running setup.py install for moztest 04:18:31 INFO - Running setup.py install for mozversion 04:18:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:18:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:18:31 INFO - Cleaning up... 04:18:31 INFO - Return code: 0 04:18:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:31 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 0x7f75c2884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b640>, '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 0x155c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155c9d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:18:31 INFO - Using env: {'DISPLAY': ':0', 04:18:31 INFO - 'HOME': '/home/cltbld', 04:18:31 INFO - 'LANG': 'en_US.UTF-8', 04:18:31 INFO - 'LANGUAGE': 'en_US:en', 04:18:31 INFO - 'LOGNAME': 'cltbld', 04:18:31 INFO - 'MAIL': '/var/mail/cltbld', 04:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:31 INFO - 'MOZ_NO_REMOTE': '1', 04:18:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:31 INFO - 'NO_EM_RESTART': '1', 04:18:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:31 INFO - 'PWD': '/builds/slave/test', 04:18:31 INFO - 'SHELL': '/bin/bash', 04:18:31 INFO - 'SHLVL': '1', 04:18:31 INFO - 'TERM': 'linux', 04:18:31 INFO - 'TMOUT': '86400', 04:18:31 INFO - 'USER': 'cltbld', 04:18:31 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 04:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:31 INFO - '_': '/tools/buildbot/bin/python'} 04:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:31 INFO - Running setup.py (path:/tmp/pip-CR0A9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:31 INFO - Running setup.py (path:/tmp/pip-hwZ7eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:31 INFO - Running setup.py (path:/tmp/pip-AXMMja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:31 INFO - Running setup.py (path:/tmp/pip-CgYz_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:32 INFO - Running setup.py (path:/tmp/pip-Bu8Kx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:32 INFO - Running setup.py (path:/tmp/pip-bkeD7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:32 INFO - Running setup.py (path:/tmp/pip-6dvJS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:32 INFO - Running setup.py (path:/tmp/pip-f6_z2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:32 INFO - Running setup.py (path:/tmp/pip-u4ug5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:32 INFO - Running setup.py (path:/tmp/pip-qMrnc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:32 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)) 04:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:32 INFO - Running setup.py (path:/tmp/pip-08QAVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:32 INFO - Running setup.py (path:/tmp/pip-leS0Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:32 INFO - Running setup.py (path:/tmp/pip-AUqv7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:32 INFO - Running setup.py (path:/tmp/pip-GgdeSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:32 INFO - Running setup.py (path:/tmp/pip-N35jzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:32 INFO - Running setup.py (path:/tmp/pip-U9QjAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:32 INFO - Running setup.py (path:/tmp/pip-6FFCse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:18:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:34 INFO - Downloading blessings-1.6.tar.gz 04:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:18:34 INFO - Installing collected packages: blessings 04:18:34 INFO - Running setup.py install for blessings 04:18:34 INFO - Successfully installed blessings 04:18:34 INFO - Cleaning up... 04:18:35 INFO - Return code: 0 04:18:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:18:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:18:35 INFO - Reading from file tmpfile_stdout 04:18:35 INFO - Current package versions: 04:18:35 INFO - argparse == 1.2.1 04:18:35 INFO - blessings == 1.6 04:18:35 INFO - blobuploader == 1.2.4 04:18:35 INFO - docopt == 0.6.1 04:18:35 INFO - manifestparser == 1.1 04:18:35 INFO - mozInstall == 1.12 04:18:35 INFO - mozcrash == 0.17 04:18:35 INFO - mozdebug == 0.1 04:18:35 INFO - mozdevice == 0.48 04:18:35 INFO - mozfile == 1.2 04:18:35 INFO - mozhttpd == 0.7 04:18:35 INFO - mozinfo == 0.9 04:18:35 INFO - mozleak == 0.1 04:18:35 INFO - mozlog == 3.1 04:18:35 INFO - moznetwork == 0.27 04:18:35 INFO - mozprocess == 0.22 04:18:35 INFO - mozprofile == 0.28 04:18:35 INFO - mozrunner == 6.11 04:18:35 INFO - mozscreenshot == 0.1 04:18:35 INFO - mozsystemmonitor == 0.0 04:18:35 INFO - moztest == 0.7 04:18:35 INFO - mozversion == 1.4 04:18:35 INFO - psutil == 3.1.1 04:18:35 INFO - requests == 1.2.3 04:18:35 INFO - wsgiref == 0.1.2 04:18:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18: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')]} 04:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18: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')]} 04:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:35 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 0x7f75c2884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b640>, '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 0x155c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155c9d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:18:35 INFO - Using env: {'DISPLAY': ':0', 04:18:35 INFO - 'HOME': '/home/cltbld', 04:18:35 INFO - 'LANG': 'en_US.UTF-8', 04:18:35 INFO - 'LANGUAGE': 'en_US:en', 04:18:35 INFO - 'LOGNAME': 'cltbld', 04:18:35 INFO - 'MAIL': '/var/mail/cltbld', 04:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:35 INFO - 'MOZ_NO_REMOTE': '1', 04:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:35 INFO - 'NO_EM_RESTART': '1', 04:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:35 INFO - 'PWD': '/builds/slave/test', 04:18:35 INFO - 'SHELL': '/bin/bash', 04:18:35 INFO - 'SHLVL': '1', 04:18:35 INFO - 'TERM': 'linux', 04:18:35 INFO - 'TMOUT': '86400', 04:18:35 INFO - 'USER': 'cltbld', 04:18:35 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 04:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:35 INFO - '_': '/tools/buildbot/bin/python'} 04:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:18:35 INFO - Cleaning up... 04:18:35 INFO - Return code: 0 04:18:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:18: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')]} 04:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18: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')]} 04:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:35 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 0x7f75c2884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b640>, '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 0x155c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155c9d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:18:35 INFO - Using env: {'DISPLAY': ':0', 04:18:35 INFO - 'HOME': '/home/cltbld', 04:18:35 INFO - 'LANG': 'en_US.UTF-8', 04:18:35 INFO - 'LANGUAGE': 'en_US:en', 04:18:35 INFO - 'LOGNAME': 'cltbld', 04:18:35 INFO - 'MAIL': '/var/mail/cltbld', 04:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:35 INFO - 'MOZ_NO_REMOTE': '1', 04:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:35 INFO - 'NO_EM_RESTART': '1', 04:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:35 INFO - 'PWD': '/builds/slave/test', 04:18:35 INFO - 'SHELL': '/bin/bash', 04:18:35 INFO - 'SHLVL': '1', 04:18:35 INFO - 'TERM': 'linux', 04:18:35 INFO - 'TMOUT': '86400', 04:18:35 INFO - 'USER': 'cltbld', 04:18:35 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 04:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:35 INFO - '_': '/tools/buildbot/bin/python'} 04:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:35 INFO - Downloading/unpacking jsonschema 04:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:18:37 INFO - Downloading/unpacking functools32 (from jsonschema) 04:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:37 INFO - Downloading functools32-3.2.3-2.tar.gz 04:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:18:37 INFO - warning: no files found matching '*.txt' 04:18:37 INFO - no previously-included directories found matching 'build' 04:18:37 INFO - no previously-included directories found matching 'dist' 04:18:37 INFO - no previously-included directories found matching '.git*' 04:18:37 INFO - Installing collected packages: jsonschema, functools32 04:18:37 INFO - Running setup.py install for functools32 04:18:37 INFO - warning: no files found matching '*.txt' 04:18:37 INFO - no previously-included directories found matching 'build' 04:18:37 INFO - no previously-included directories found matching 'dist' 04:18:37 INFO - no previously-included directories found matching '.git*' 04:18:37 INFO - Successfully installed jsonschema functools32 04:18:37 INFO - Cleaning up... 04:18:38 INFO - Return code: 0 04:18:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:38 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 0x7f75c2884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b640>, '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 0x155c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155c9d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:18:38 INFO - Using env: {'DISPLAY': ':0', 04:18:38 INFO - 'HOME': '/home/cltbld', 04:18:38 INFO - 'LANG': 'en_US.UTF-8', 04:18:38 INFO - 'LANGUAGE': 'en_US:en', 04:18:38 INFO - 'LOGNAME': 'cltbld', 04:18:38 INFO - 'MAIL': '/var/mail/cltbld', 04:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:38 INFO - 'MOZ_NO_REMOTE': '1', 04:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:38 INFO - 'NO_EM_RESTART': '1', 04:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:38 INFO - 'PWD': '/builds/slave/test', 04:18:38 INFO - 'SHELL': '/bin/bash', 04:18:38 INFO - 'SHLVL': '1', 04:18:38 INFO - 'TERM': 'linux', 04:18:38 INFO - 'TMOUT': '86400', 04:18:38 INFO - 'USER': 'cltbld', 04:18:38 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 04:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:38 INFO - '_': '/tools/buildbot/bin/python'} 04:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:38 INFO - Downloading/unpacking flake8 04:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:18:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:18:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:18:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:18:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:18:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:18:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:18:40 INFO - no previously-included directories found matching 'docs/_build' 04:18:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:18:40 INFO - Running setup.py install for pep8 04:18:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:18:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:18:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:18:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:18:40 INFO - no previously-included directories found matching 'docs/_build' 04:18:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:18:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:18:41 INFO - Cleaning up... 04:18:41 INFO - Return code: 0 04:18:41 INFO - Running post-action listener: _resource_record_post_action 04:18:41 INFO - Running post-action listener: _start_resource_monitoring 04:18:41 INFO - Starting resource monitoring. 04:18:41 INFO - ##### 04:18:41 INFO - ##### Running install step. 04:18:41 INFO - ##### 04:18:41 INFO - Running pre-action listener: _resource_record_pre_action 04:18:41 INFO - Running main action method: install 04:18:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:18:41 INFO - Reading from file tmpfile_stdout 04:18:41 INFO - Detecting whether we're running mozinstall >=1.0... 04:18:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:18:41 INFO - Reading from file tmpfile_stdout 04:18:41 INFO - Output received: 04:18:41 INFO - Usage: mozinstall [options] installer 04:18:41 INFO - Options: 04:18:41 INFO - -h, --help show this help message and exit 04:18:41 INFO - -d DEST, --destination=DEST 04:18:41 INFO - Directory to install application into. [default: 04:18:41 INFO - "/builds/slave/test"] 04:18:41 INFO - --app=APP Application being installed. [default: firefox] 04:18:41 INFO - mkdir: /builds/slave/test/build/application 04:18:41 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'] 04:18:41 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 04:18:57 INFO - Reading from file tmpfile_stdout 04:18:57 INFO - Output received: 04:18:57 INFO - /builds/slave/test/build/application/firefox/firefox 04:18:57 INFO - Running post-action listener: _resource_record_post_action 04:18:57 INFO - ##### 04:18:57 INFO - ##### Running run-tests step. 04:18:57 INFO - ##### 04:18:57 INFO - Running pre-action listener: _resource_record_pre_action 04:18:57 INFO - Running main action method: run_tests 04:18:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:18:57 INFO - Python 2.7.3 04:18:57 INFO - Return code: 0 04:18:57 INFO - grabbing minidump binary from tooltool 04:18: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')]} 04:18:57 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 0x155b640>, '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 0x155c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155c9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:18:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:18:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:18:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:18:57 INFO - Return code: 0 04:18:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:18:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:18:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:18:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:18:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:18:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:18:58 INFO - Return code: 0 04:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:18:58 INFO - Using env: {'DISPLAY': ':0', 04:18:58 INFO - 'HOME': '/home/cltbld', 04:18:58 INFO - 'LANG': 'en_US.UTF-8', 04:18:58 INFO - 'LANGUAGE': 'en_US:en', 04:18:58 INFO - 'LOGNAME': 'cltbld', 04:18:58 INFO - 'MAIL': '/var/mail/cltbld', 04:18:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:18:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:58 INFO - 'MOZ_NO_REMOTE': '1', 04:18:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:58 INFO - 'NO_EM_RESTART': '1', 04:18:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:58 INFO - 'PWD': '/builds/slave/test', 04:18:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:18:58 INFO - 'SHELL': '/bin/bash', 04:18:58 INFO - 'SHLVL': '1', 04:18:58 INFO - 'TERM': 'linux', 04:18:58 INFO - 'TMOUT': '86400', 04:18:58 INFO - 'USER': 'cltbld', 04:18:58 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670', 04:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:58 INFO - '_': '/tools/buildbot/bin/python'} 04:18:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:18:58 INFO - mozversion application_buildid: 20160506025825 04:18:58 INFO - mozversion application_changeset: 25d777f7efb357fc5478251913548521986abaa0 04:18:58 INFO - mozversion application_display_name: Nightly 04:18:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:18:58 INFO - mozversion application_name: Firefox 04:18:58 INFO - mozversion application_remotingname: firefox 04:18:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:18:58 INFO - mozversion application_vendor: Mozilla 04:18:58 INFO - mozversion application_version: 49.0a1 04:18:58 INFO - mozversion platform_buildid: 20160506025825 04:18:58 INFO - mozversion platform_changeset: 25d777f7efb357fc5478251913548521986abaa0 04:18:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:18:58 INFO - mozversion platform_version: 49.0a1 04:18:58 INFO - using testdate: 1462533538 04:18:58 INFO - actual date: 1462533538 04:18:58 INFO - starting webserver on 'localhost:34947' 04:18:58 INFO - SUITE-START | Running 2 tests 04:18:58 INFO - TEST-START | dromaeo_css 04:18:58 INFO - operating with platform_type : linux_ 04:18:58 INFO - Initialising browser for dromaeo_css test... 04:18:58 INFO - TEST-INFO | started process 19948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNIXo04/profile http://localhost:34947/getInfo.html) 04:19:02 INFO - PROCESS | 19948 | 04:19:02 INFO - PROCESS | 19948 | (process:20018): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:19:03 INFO - PROCESS | 19948 | __metrics Screen width/height:1600/1200 04:19:03 INFO - PROCESS | 19948 | colorDepth:24 04:19:03 INFO - PROCESS | 19948 | Browser inner width/height: 1024/697 04:19:03 INFO - PROCESS | 19948 | __metrics 04:19:04 ERROR - PROCESS | 19948 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:19:05 INFO - TEST-INFO | 19948: exit 0 04:19:05 INFO - Browser initialized. 04:19:05 INFO - Running cycle 1/1 for dromaeo_css test... 04:19:05 INFO - TEST-INFO | started process 20069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNIXo04/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:07 INFO - PROCESS | 20069 | 04:19:07 INFO - PROCESS | 20069 | (process:20130): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:19:17 INFO - PROCESS | 20069 | RSS: Main: 164216832 04:19:17 INFO - PROCESS | 20069 | 04:20:06 INFO - PROCESS | 20069 | 1462533606994 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:22:18 INFO - PROCESS | 20069 | Cycle 1(1): loaded http://localhost:34947/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34947/tests/dromaeo/cssquery-ext.html) 04:22:20 INFO - PROCESS | 20069 | RSS: Main: 168194048 04:22:20 INFO - PROCESS | 20069 | 04:25:22 INFO - PROCESS | 20069 | Cycle 1(1): loaded http://localhost:34947/tests/dromaeo/cssquery-ext.html (next: http://localhost:34947/tests/dromaeo/cssquery-jquery.html) 04:25:22 INFO - PROCESS | 20069 | RSS: Main: 167297024 04:25:22 INFO - PROCESS | 20069 | 04:28:24 INFO - PROCESS | 20069 | Cycle 1(1): loaded http://localhost:34947/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34947/tests/dromaeo/cssquery-mootools.html) 04:28:25 INFO - PROCESS | 20069 | RSS: Main: 168275968 04:28:25 INFO - PROCESS | 20069 | 04:31:27 INFO - PROCESS | 20069 | Cycle 1(1): loaded http://localhost:34947/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34947/tests/dromaeo/cssquery-prototype.html) 04:31:27 INFO - PROCESS | 20069 | RSS: Main: 166232064 04:31:27 INFO - PROCESS | 20069 | 04:34:30 INFO - PROCESS | 20069 | Cycle 1(1): loaded http://localhost:34947/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34947/tests/dromaeo/cssquery-yui.html) 04:34:31 INFO - PROCESS | 20069 | RSS: Main: 167555072 04:34:31 INFO - PROCESS | 20069 | 04:37:33 INFO - PROCESS | 20069 | Cycle 1(1): loaded http://localhost:34947/tests/dromaeo/cssquery-yui.html (next: http://localhost:34947/tests/dromaeo/cssquery-dojo.html) 04:37:34 INFO - PROCESS | 20069 | RSS: Main: 169701376 04:37:34 INFO - PROCESS | 20069 | 04:37:34 INFO - PROCESS | 20069 | __start_tp_report 04:37:34 INFO - PROCESS | 20069 | _x_x_mozilla_page_load 04:37:34 INFO - PROCESS | 20069 | _x_x_mozilla_page_load_details 04:37:34 INFO - PROCESS | 20069 | |i|pagename|runs| 04:37:34 INFO - PROCESS | 20069 | |0;dojo.html;2703.7431444012814;2744.9039283625075;2770.418212175443;2773.1541879726674;2785.791065670075;4803.471618122008;4823.08361411332;4853.902921941563;4924.285978533119;5000.799968001275;4726.787294571744;4733.952660473395;4738.241881298993;4772.594329481998;4863.489333619963;4418.2268103082;4465.553444655541;4561.429821272341;4574.176648203322;4579.313103034555;4500.099980004013;4588.609968152711;4590.357349971006;4613.492515823256;4635.281531362644;4334.566543345672;4419.779011049434;4436.157130145262;4452.10957808438;4508.481524624677;4418;4428.202923473774;4432.357308190294;4441.378207051015;4482.327650852366;4453.621442177418;4474.709143905636;4476.306172543261;4493.7977790999485;4500.437445319335;4654.232051711463;4704;4715.905681886377;4736.786844592001;4755.881102972418;5172.146595811687;5192;5195.9480405195845;5200.635955483118;5227.869303267449;5102.183650615921;5204.9739751301;5219.791208351661;5223.660462069954;5223.895522089537;4868.196747536652;4913.508649135058;4919.532644398776;4957.107720610289;4964.032013757283;5346.91979620306;5378.112611419072;5390.595705322116;5391.78432862689;5399.6490228135835;4959.7272150032095;4960.70235785854;5167.61242906776;5189.169732842727;5189.662671926313;5060.114479965991;5071.949280507148;5091.338126043591;5104.285400043997;5169.508896654812;4963.181075122637;5090.949090509122;5192.92210616841;5197.402298735618;5220.973895130576;4951.10880041596;5177.767000484987;5184.922226166611;5207.0366982108435;5223.5559977402345;4321.978390108029;4370.584794444522;4400.273954797422;4439.311906654474;4446.799894004777;3806.9428958565645;3819.5607505137264;3834.501514803058;3862.613738626115;3875.476810630585;4391.055922976575;4397.538258482878;4427.092446048617;4439;4490.887727806766;5008.57427118699;5198.324217851655;5222.321098257202;5255.6321057526375;5286.392064912584;4475.507694153641;4488.4613846338;4498.167838949805;4508.301213311942;4532.501424843264;4482.8655140345845;4688.64835137366;4718.2214934536105;4739.478657347689;4740.502247264057;4820.68665536739;4850.078485087822;4853.369062021915;4893;4896.804127834989;5172.094883395315;5186;5206.401263854706;5212.817551385683;5230.215467679726;4798.49615790351;4824.638152138674;4888.92666609994;4894.216925291937;4904.117258893433;5078.97460512695;5091.0581542414775;5093.261477085728;5097.362829646294;5136.9743151284;5160.819371321985;5161.354830646169;5166.586673066221;5168.3797944246935;5211.062008838294;4878.170710979071;5003.8498845033255;5017.67385119966;5053.545180933586;5072.137736584716;4909.754512274443;4977.900441991213;4980.277859710394;5052.595792336678;5063.544281014726;4981.6014718823135;4984.501549844987;4988.176950803077;4989.650724449254;5030.798768049237;4880.877978050577;5077.873053173553;5111.156659151347;5124.846254612367;5136.280920671184;5047.116754568009;5059.443461219336;5063;5065.594752419871;5101.69389836611 04:37:34 INFO - PROCESS | 20069 | |1;ext.html;560.7869009776284;606.2482521673126;612.0727098445856;612.9601575897568;637.0666972884728;35967.04362520121;40027;40148.79925600372;40161.19677606446;40196.79901600488;40703.59296407043;41204.58795412045;41376.17247655045;41382.99999999993;41561.37657935126;7834.804129896741;7908.367330613537;7952.125266220711;7958.403119766041;7966.44234903557;7915.881261781078;8006.319462845665;8009.559474228944;8023.037235531744;8027.117017128111;7986.800329991738;7999.760007199793;8029.437939344219;8033.799155021113;8039.07550631679;7988.400869934778;7994.680212791482;8016.158303378149;8036;8043.075046369684;8007;8007.159248278964;8021.077576078709;8044.396670249696;8047.557384343859;30856.228594285098;37801.62198378008;38132.61867381319;38257.617423825686;38327.61672383268;3130.3426280481126;3250.6261779895376;3385.458326667746;3474.2183008823067;3505.5442792437075;28473.430531389462;31076.378472430424;31111;31633.683663163305;32028.199295017577;3397.264643725839;3431.2108215110416;3484.4424892017155;3489.982550087259;3592.892213233607;254313;255080;258328;260553;260661;35279.29441411209;61870.38129618736;62847.37152628415;63024;63059;34717.82641086778;37033;37084.258314833554;37204.62795372012;37208.44187337192;14569.198694071927;14762.48331308399;14792.408303667948;14794.926025369805;14798.260086995608;10970.835437468444;11158.386288754034;11197;11201.271917325348;11212.719682007852;8528.957355213308;8611.13888611134;8612.224899759052;8627.827443451095;8648.2216600505;3368.1074515253476;3407.4888766685194;3442.621311655716;3463.965360346415;3467.5665541807275;935.4808081514689;951.7573018880141;985.3348989432104;1036.1192985961873;1110.5890820396505;29839.701602984125;29941.550876736866;29946.55080173799;29977;30172.396552068836;1013.6705570689555;1056.8837427882927;1059.147386353977;1077.6389909380289;1115.5482029777952;15698.76451853223;15954.920225398799;15977.360905563648;16027.759583606256;16175.514734557983;360320;361823;364517;364761;365519;51896.22155667668;51984;52128.21807672888;52181;52216.47783522192;1270.6505710929569;1296.9610911672664;1305.505196549945;1307;1309.7511472820133;26417.867910660323;28423.43153136967;28877.422451551272;29074.27314317159;29462.263443414085;46022.309665354376;46207.76896115498;46439;46627;46649.30026049544;300851;301428;301468;302374;302700;26617.467650647264;26839.865800670872;27420;27760.444791103662;27777.166684999484;44243.55756442394;45007;45334.77332613316;45459.31811022771;46519.76740116413;37900.81049594734;38362.42456363213;38412.23175536418;38999.610003900736;39346.213075738895;34389.828050859585;37213;38136.23727525489;38219.42670859995;38933.8053309743;33455.33089338248;34078.48882266718;37980;38200.235995279385;38263.61736382601;32349.676503234667;33181.50227746634;33689;34402.48396274108;34403.13992150116;26087.347816304744;26374;26386.604200936617;26440.73559264383;26552.8672356637 04:37:34 INFO - PROCESS | 20069 | |2;jquery.html;378.53440268469774;379.36456435470586;383.3999790328138;394.9506311711036;396.0297271684374;15769.369225230992;17406.477805665818;17660.29358825647;18127.274909003656;18175.272989080437;17066.573335666584;17393.39123130691;17718.379856705018;17739.29042838285;17750.28998840048;5140.948590514103;5261.289725886994;5299.311089558371;5299.947000529984;5318.734063296839;3692.9446058309145;5769.682667453289;6035.124906888498;6058.666773327465;6158.199434073565;5129.3844738631415;6018.037114061751;6057.606255593394;6069.0592958091565;6089.634621922699;5383.757730902099;5442.0476416627325;5450.5367043801325;5485.780568777244;5489.39616642169;5162.6128040397125;5386.5152136307925;5455.863603409907;5461.836144915659;5466.180072989044;11825.822612660817;12019.93990030053;12148.57479988205;12306.630801075982;12409.06931980105;1882.115405759291;2041.3773798991301;2084.1451108513434;2089.2374283386607;2091.309867743641;9088.136627020422;9162.267018638493;9291.256699464095;9331.72004839856;11036.006759391694;1693.1872701103416;1823.3435963053291;1851.5650370962478;1854.1563588567305;1872.447627949758;68546.65726671384;69053;69225.3077469224;69639.30360696379;70663.64668176626;9745.269104817025;9760.755981100387;10011.49942502872;10094.293399462114;10109.292349535463;14037;14038.719225615634;14047.438102475786;14096.71806563863;14141.080829746033;7417.109946806418;7485.288897554724;7504.137024242173;7536.1333446654335;7612.391008719289;7009.754658586925;7123.501354905211;7207.13514378278;7285.162206346232;7302.488825782144;4307.664623966581;4347.804348804311;4375.409319741858;4389.275769498061;4396;1695.711729006072;1770.7875054993483;1850.3338798032698;1858.2474097990334;1895.4313705888178;838.3125836813877;902.6615019367737;924.1451657217048;995.9691719070727;1000.7798284377425;15153.848461515465;16412.917935410245;16450.506484805475;16503.33986640545;17003.91498042502;913.5706218077493;958.5973890965672;959.4531117263233;967.8354679704468;969.4086607169621;9249.768755781024;9310.627574896927;9338.953305233566;9373.297002724823;9503.119207541982;375266;387052;387214;390882;392797;76901.61549192219;77207.61396192983;77916;78247.21752782399;78362.21637783549;920.9907900920905;935.1536859142487;953.8903026151943;956.7416797464646;968.4867020479157;14652.926735366254;14719.852801471849;14813.333399997242;14922.776158357416;15168.469103581321;32371.838140809145;33122;34054.48918266178;34140.14649633779;34695.82652086723;44776.328355074045;46044.769776150904;46777.29834052424;46799;47450.28824567565;7119.893201601876;7235.963820180866;7331.890021649573;7368.815779605553;7650.196729343339;9752.46361450127;10678.946605267234;10729.088027517748;10859.945700271765;10868.07621352194;9011.954940225258;9287.164155226063;9352.018038106173;9520.811472542902;9522.381045232038;9328.95335523318;9737.711637764978;9825.656102036395;10105.494725263854;10202.234832387452;9990.700278991642;10034.19726421899;10330.741731456774;10332.793344133226;10574.101201397967;7672.616369181407;7864.5281283123195;7885.921140788748;7893.881591776013;7997.480163789335;9591.136797688241;10006.299559030798;10186.541605627914;10302.381857088598;10310.43292618913 04:37:34 INFO - PROCESS | 20069 | |3;mootools.html;1517.2262146305384;1551.9767203491947;1748.4404990403077;1872.1668857358482;1877.2678655324435;6681.832954176148;7244;7461.776146715607;7678.308952194308;7699.692012319508;7507.436942229341;7755.340796032344;7777.805554861131;7791.532508049507;7812;2165.4694599823024;2191.3206905859233;2195.0232146694725;2203.801657850793;2207.569523942832;2110.3141479019305;2114.2177394364107;2157.385145233609;2167.9024443899984;2173.1307477009163;2098.6851972204217;2108.325335892515;2113.5138918048856;2117.1637203304685;2120.120150137691;2115.894205289737;2137.6472881974532;2152.2251989283845;2154.493693981913;2157.4067131538795;2075.5952589245103;2094.0472085201195;2109.377733568601;2116.767155612881;2119.872807631547;7683.7310694126;7692.576908270043;7731.613419329011;7732;7733.226677332278;4437.955620443819;4515.548445155491;4526.841560545398;4538.954610453886;4551.635869130495;2902.535594304922;2958.2604348912773;3022.894198703035;3027.10700343397;3034.317278612317;908.8500397434416;934.2339281788936;937.8358787212279;953.4088864903804;970.277143528069;10497.737556561147;10522.631707890187;10528.157747380268;10528.42093684847;10529.526171322308;4028.6575641070835;4249.957500425018;4257.489101307863;4270.807813648331;4274.487061552633;9041.141091596288;9052.366334356531;9066.95466522663;9079.68221112271;9110.772230694152;4642.698224615389;4661.790219440133;4662.906741865211;4662.95337046632;4664.253719404879;3480.7565307632462;4010.298197815429;4035.899102522402;4050.6151915567975;4170.791460426966;3676.7426280160666;3711.7030637548933;3791.696664266852;3816.5420149581673;3823.2926908522013;1191.1661836714334;1193.3555879824971;1226.1600803449664;1231.2673958994385;1232.6671798614325;917.8026724254318;939.6006697153682;942.8679984802134;944.7968686732248;952.9475878826593;5336.386315573681;5496.945030549723;5503.9174412383845;5523.7238138092935;5650.491455769001;406.7051387743862;410.517641770918;413.53683874061244;415.8690012646007;427.26510402108323;3678.264347130531;3701.0747313171705;3721.3859713147026;3786.2427514497213;3948.2893079245437;9298.488583127857;9497.810043799085;9505.714828555154;9678.612855485702;9701.51492425376;9407.247420206368;9530.142287194185;9542.379745316532;9560.235181185488;9573.18627916621;7281.308275713799;7445.925540744632;7477.663505142173;7485.139208990927;7490.363319117827;5242;5310.150375939831;5339.946600533945;5449.972750136224;5462.726863656881;8527.317814574695;8877.112288771072;8927.375083744075;8939.642414303615;8957.641694332415;8230.300424463749;8569.357298202534;8875.556222188736;8924.107589241024;8929.642814287356;5965.821025369246;6676.732930682719;6816.488763342868;6897.241303456515;7087.50387472872;7056.576605403692;7221.602811845399;7239.384652304613;7258.274172582911;7258.3104605062435;6489.643069631215;6575.243846957661;6621.139251897415;6631.933680663132;6753.189617245962;6505.219373675;6560.901586476302;6620.470362370903;6624.403803657501;6703.262641109376;6188.164597779242;6210.875782484415;6262.624242545462;6263.185785847811;6264.655443950626;4501.842435514741;4662.860114196579;4672.252439609646;4683.484816670231;4813.831515896927;4750.667453278375;4774.498677638798;4777.0684716479955;4789.712617242976;4835.371401717754 04:37:34 INFO - PROCESS | 20069 | |4;prototype.html;299.87255416448016;306.95395690646404;310.29098509904856;311.071451716626;314.6177394465724;4831.782569784359;4906.7546622668815;4945.975270123648;5004.92197298661;5017.272495488157;4926.45808961014;4959.603231741461;4962.330085438465;4981.352424184851;5019.774110165043;3936.4882565266616;3947.684185265172;3948.763074215556;3948.9802550987206;3959.7030222733265;3676.926461470769;3951.8221680024467;3956.188981258835;3958.940615890764;3966.345552983769;3853.807309634507;3867.7292589518743;3871.9032024199337;3881.068543549542;3896.5129358830145;3886.9010734203357;3889.572147063821;3899.2006638639295;3900.3564411872007;3903.98048009761;3449.9482507762405;3462.0998540379433;3476.4437689969736;3477.5826900771817;3482.8432720527635;4566.429196350457;4730.455997560256;4752.500987396343;4763.857084287442;4789.257665061921;4450.777461126931;4456.420665313489;4468.575485328888;4477.888052798674;4484.2376795944765;5184.14461613837;5196.29849970253;5198;5235.8219400634935;5254.369475662907;3699.1491956849804;3789.7157713171346;3794.520137146515;3800.2399520095814;3806.410006448977;5440.782368705247;5454.400015998237;5472.863178420572;5479.4520547944885;5515.931525677871;3871.264459752694;3874.593167717349;3876.244132394156;3877.86427475037;3884.397453706024;3916.2559113768293;3921.568627450978;3929.4891664083484;3934.940975885364;3938.310795610814;4266.701330906869;4420.248557745191;4427.1887351532005;4427.450392362712;4436.46762388509;5170.121079416433;5205.6356055075785;5238.790448382022;5243.4232234454175;5248.6588371755715;1258.3016425883538;1301.1477482249143;1317.9275139867207;1335.626024713082;1342.5502456677123;902.9413088149381;924.7872989212519;930.734740598926;934.1685899549407;938.6761567259284;4403.515613282536;4411.911761764747;4420.850578849458;4422.248217802981;4427.158839820424;5195.3115237547945;5204.5055719707325;5209.661372010807;5220.1647736362;5224.138017227191;4272.16692744918;4417.558244175557;4433.82264709408;4436.77988553144;4440.178566965057;2694.0301491463056;2741.232454912628;2743.7256274372403;2751.917442476729;2800.28592708862;4885.511448855086;4898.975505122523;4914.606831453475;4932.630052746058;4956.4547899731;5149.613778966593;5158.535731784157;5270.841874743764;5307.601929855199;5323.760430780624;4841.830535931366;4856.329019039585;4865.489123642037;4916.754162291871;4941.690452030215;5182.455842136521;5216.600363832679;5220.694826293427;5226.738663066755;5240.633155679066;5009.749512524432;5090.643654944267;5100.26046223303;5144.76848541824;5302.9469705304;5076.416212135652;5085.415177254663;5090.414602320632;5123.795048198031;5164.638475306692;3773.3773927301686;3773.566039905446;3777.490038844831;3787.8295476704166;3792.6207379261855;5204.531592156724;5408.675479471244;5443.401225865231;5456.290682211287;5465.180222966586;5243.528082472596;5263.73681315925;5275.894482110413;5284.093748438267;5289.259503669567;5247.501487358695;5257.342832145981;5280.6303558750515;5281.867953301198;5328.094223981855;5061.721605311596;5082.237664350377;5171.560417364566;5221.347331583552;5240.449752776056;5336.439673834191;5360.758765855468;5377.784888604412;5399.9190012149065;5419.701916394636;5220.138677118233;5222.9216561750845;5241.842744717665;5260.395579348336;5285.207218917039 04:37:34 INFO - PROCESS | 20069 | |5;yui.html;762.8169239382548;764.1403421151203;798.1818635898204;814.6578437056439;822.4366309078279;12938.935305323472;13284.269365184911;13397.129186602877;13427;13594.524191653294;14200;14320;14355;14378.281085945688;14401.92799036006;689.3347919257915;890.2210565754964;891.7725979875123;894.785251539629;898.8247291778106;861.9698310559131;884.9159329863653;887.0198430734043;891.9464832110094;892.3485855325583;918.334207699416;929.1126973740096;932.8554074118489;932.8600709893502;937.9577918993662;926.9860952085725;930.1349744737391;931.0177762460635;932.5803388475146;934.1919239857474;678.8472593666386;682.3654001778344;683.8734834055666;684.4797953555284;685.338648204485;12771.552995645108;12872;12962.935185324013;12987.675308117277;12991.675208119777;12314.384280785926;12492.75014499714;12549.309787961658;12567.434465449076;12777.552785652457;9929.90070099297;10092.747681307952;10191.694249172537;10455.634052808115;10565.101966332793;3300.3234336960863;3320.8339583020993;3350.279689866666;3358.126887009371;3435.9484607730906;46800.29799553009;46919.296210556866;46990.29514557285;47242.527574724154;48217.27674084857;9661.975627898544;9705.9029409705;9709.271804614682;9784;9913.950430247802;16756;17199.398021069203;17213.655726885394;17301.480955571355;17350.826491735173;7025.648717564101;7039.753608623673;7100.92899071013;7110.7511237106455;7223.927760722326;3710.239400922804;3781.4516895050615;3841.3277676407074;3878.127421330178;3880.553736320303;2859.885604575794;2941.6617089034607;2943.249471384783;2948.3071478202605;2952.291450051972;542.6662602499434;549.9890002199934;554.3071161048689;557.406362224238;563.760401829221;530.6524226631562;541.445018855676;642.0529718665025;653.053073044088;654.7348323928817;7804.605555195335;7827.686892524235;7881.842363152705;8105.797355066171;8257.339412846957;548.8298627425511;549.8955198512269;558.9860253493614;563.1608902734896;567.591334239347;3624.6012938576737;3629.673329400314;3659.908502287411;3754.2866855297407;3779.6598306152578;51553.742231289354;52320.21519677208;52552.73723631357;52615.21077183845;52945.7352713234;47034.294485582745;47647.04705905863;47824.521754782705;47982.76008620005;49251.26123108156;43318.133637327075;43661.12677746427;43971;44422.33366499505;44801.55198447974;7390.150132734804;7536.886946695914;7941.602919853869;8468.957655211685;8557.700480483154;26812.59781103324;26939.595906061815;27929.301767455163;28926.13221603355;29342;38142.80928595339;38348.80825595966;38717.22565548617;39047.41428878626;39605.80197098996;10686.89313106859;10696.251262411557;10898;11175.49710263024;11654.067674586182;11208.55165793359;11342.149338799789;11543;11814.350210738148;11901.285922844658;11368.147388945697;11386.772264554827;11760.235584686969;12399.25604463735;12495.93752031234;11769.529218831492;11795.705107372385;11947.103967202669;12116.515339386326;12326.445309961253;9516;11466.656000320003;11760.76478470443;11786.41067946582;12051.939740301243;9685;9912.256580756328;9948.204143668634;10115;10270.845937311096;9726.452860853418;9780.26648001417;9893.35693179941;10185.470944876392;10197.260763059003 04:37:34 INFO - PROCESS | 20069 | __end_tp_report 04:37:34 INFO - PROCESS | 20069 | __start_cc_report 04:37:34 INFO - PROCESS | 20069 | _x_x_mozilla_cycle_collect,375 04:37:34 INFO - PROCESS | 20069 | __end_cc_report 04:37:34 INFO - PROCESS | 20069 | __startTimestamp1462534654063__endTimestamp 04:37:34 INFO - PROCESS | 20069 | 04:37:34 INFO - PROCESS | 20069 | ------- Summary: start ------- 04:37:34 INFO - PROCESS | 20069 | Number of tests: 6 04:37:34 INFO - PROCESS | 20069 | 04:37:34 INFO - PROCESS | 20069 | [#0] dojo.html Cycles:165 Average:4791.20 Median:4913.51 stddev:494.05 (10.1%) stddev-sans-first:467.64 04:37:34 INFO - PROCESS | 20069 | Values: 2703.7 2744.9 2770.4 2773.2 2785.8 4803.5 4823.1 4853.9 4924.3 5000.8 4726.8 4734.0 4738.2 4772.6 4863.5 4418.2 4465.6 4561.4 4574.2 4579.3 4500.1 4588.6 4590.4 4613.5 4635.3 4334.6 4419.8 4436.2 4452.1 4508.5 4418.0 4428.2 4432.4 4441.4 4482.3 4453.6 4474.7 4476.3 4493.8 4500.4 4654.2 4704.0 4715.9 4736.8 4755.9 5172.1 5192.0 5195.9 5200.6 5227.9 5102.2 5205.0 5219.8 5223.7 5223.9 4868.2 4913.5 4919.5 4957.1 4964.0 5346.9 5378.1 5390.6 5391.8 5399.6 4959.7 4960.7 5167.6 5189.2 5189.7 5060.1 5071.9 5091.3 5104.3 5169.5 4963.2 5090.9 5192.9 5197.4 5221.0 4951.1 5177.8 5184.9 5207.0 5223.6 4322.0 4370.6 4400.3 4439.3 4446.8 3806.9 3819.6 3834.5 3862.6 3875.5 4391.1 4397.5 4427.1 4439.0 4490.9 5008.6 5198.3 5222.3 5255.6 5286.4 4475.5 4488.5 4498.2 4508.3 4532.5 4482.9 4688.6 4718.2 4739.5 4740.5 4820.7 4850.1 4853.4 4893.0 4896.8 5172.1 5186.0 5206.4 5212.8 5230.2 4798.5 4824.6 4888.9 4894.2 4904.1 5079.0 5091.1 5093.3 5097.4 5137.0 5160.8 5161.4 5166.6 5168.4 5211.1 4878.2 5003.8 5017.7 5053.5 5072.1 4909.8 4977.9 4980.3 5052.6 5063.5 4981.6 4984.5 4988.2 4989.7 5030.8 4880.9 5077.9 5111.2 5124.8 5136.3 5047.1 5059.4 5063.0 5065.6 5101.7 04:37:34 INFO - PROCESS | 20069 | 04:37:34 INFO - PROCESS | 20069 | [#1] ext.html Cycles:180 Average:46428.02 Median:363170.00 stddev:81658.60 (22.5%) stddev-sans-first:81815.06 04:37:34 INFO - PROCESS | 20069 | Values: 560.8 606.2 612.1 613.0 637.1 35967.0 40027.0 40148.8 40161.2 40196.8 40703.6 41204.6 41376.2 41383.0 41561.4 7834.8 7908.4 7952.1 7958.4 7966.4 7915.9 8006.3 8009.6 8023.0 8027.1 7986.8 7999.8 8029.4 8033.8 8039.1 7988.4 7994.7 8016.2 8036.0 8043.1 8007.0 8007.2 8021.1 8044.4 8047.6 30856.2 37801.6 38132.6 38257.6 38327.6 3130.3 3250.6 3385.5 3474.2 3505.5 28473.4 31076.4 31111.0 31633.7 32028.2 3397.3 3431.2 3484.4 3490.0 3592.9 254313.0 255080.0 258328.0 260553.0 260661.0 35279.3 61870.4 62847.4 63024.0 63059.0 34717.8 37033.0 37084.3 37204.6 37208.4 14569.2 14762.5 14792.4 14794.9 14798.3 10970.8 11158.4 11197.0 11201.3 11212.7 8529.0 8611.1 8612.2 8627.8 8648.2 3368.1 3407.5 3442.6 3464.0 3467.6 935.5 951.8 985.3 1036.1 1110.6 29839.7 29941.6 29946.6 29977.0 30172.4 1013.7 1056.9 1059.1 1077.6 1115.5 15698.8 15954.9 15977.4 16027.8 16175.5 360320.0 361823.0 364517.0 364761.0 365519.0 51896.2 51984.0 52128.2 52181.0 52216.5 1270.7 1297.0 1305.5 1307.0 1309.8 26417.9 28423.4 28877.4 29074.3 29462.3 46022.3 46207.8 46439.0 46627.0 46649.3 300851.0 301428.0 301468.0 302374.0 302700.0 26617.5 26839.9 27420.0 27760.4 27777.2 44243.6 45007.0 45334.8 45459.3 46519.8 37900.8 38362.4 38412.2 38999.6 39346.2 34389.8 37213.0 38136.2 38219.4 38933.8 33455.3 34078.5 37980.0 38200.2 38263.6 32349.7 33181.5 33689.0 34402.5 34403.1 26087.3 26374.0 26386.6 26440.7 26552.9 04:37:34 INFO - PROCESS | 20069 | 04:37:34 INFO - PROCESS | 20069 | [#2] jquery.html Cycles:180 Average:23772.72 Median:5135.17 stddev:63853.81 (1243.5%) stddev-sans-first:64008.78 04:37:34 INFO - PROCESS | 20069 | Values: 378.5 379.4 383.4 395.0 396.0 15769.4 17406.5 17660.3 18127.3 18175.3 17066.6 17393.4 17718.4 17739.3 17750.3 5140.9 5261.3 5299.3 5299.9 5318.7 3692.9 5769.7 6035.1 6058.7 6158.2 5129.4 6018.0 6057.6 6069.1 6089.6 5383.8 5442.0 5450.5 5485.8 5489.4 5162.6 5386.5 5455.9 5461.8 5466.2 11825.8 12019.9 12148.6 12306.6 12409.1 1882.1 2041.4 2084.1 2089.2 2091.3 9088.1 9162.3 9291.3 9331.7 11036.0 1693.2 1823.3 1851.6 1854.2 1872.4 68546.7 69053.0 69225.3 69639.3 70663.6 9745.3 9760.8 10011.5 10094.3 10109.3 14037.0 14038.7 14047.4 14096.7 14141.1 7417.1 7485.3 7504.1 7536.1 7612.4 7009.8 7123.5 7207.1 7285.2 7302.5 4307.7 4347.8 4375.4 4389.3 4396.0 1695.7 1770.8 1850.3 1858.2 1895.4 838.3 902.7 924.1 996.0 1000.8 15153.8 16412.9 16450.5 16503.3 17003.9 913.6 958.6 959.5 967.8 969.4 9249.8 9310.6 9339.0 9373.3 9503.1 375266.0 387052.0 387214.0 390882.0 392797.0 76901.6 77207.6 77916.0 78247.2 78362.2 921.0 935.2 953.9 956.7 968.5 14652.9 14719.9 14813.3 14922.8 15168.5 32371.8 33122.0 34054.5 34140.1 34695.8 44776.3 46044.8 46777.3 46799.0 47450.3 7119.9 7236.0 7331.9 7368.8 7650.2 9752.5 10678.9 10729.1 10859.9 10868.1 9012.0 9287.2 9352.0 9520.8 9522.4 9329.0 9737.7 9825.7 10105.5 10202.2 9990.7 10034.2 10330.7 10332.8 10574.1 7672.6 7864.5 7885.9 7893.9 7997.5 9591.1 10006.3 10186.5 10302.4 10310.4 04:37:34 INFO - PROCESS | 20069 | 04:37:34 INFO - PROCESS | 20069 | [#3] mootools.html Cycles:180 Average:5107.75 Median:5276.08 stddev:2832.58 (53.7%) stddev-sans-first:2827.68 04:37:34 INFO - PROCESS | 20069 | Values: 1517.2 1552.0 1748.4 1872.2 1877.3 6681.8 7244.0 7461.8 7678.3 7699.7 7507.4 7755.3 7777.8 7791.5 7812.0 2165.5 2191.3 2195.0 2203.8 2207.6 2110.3 2114.2 2157.4 2167.9 2173.1 2098.7 2108.3 2113.5 2117.2 2120.1 2115.9 2137.6 2152.2 2154.5 2157.4 2075.6 2094.0 2109.4 2116.8 2119.9 7683.7 7692.6 7731.6 7732.0 7733.2 4438.0 4515.5 4526.8 4539.0 4551.6 2902.5 2958.3 3022.9 3027.1 3034.3 908.9 934.2 937.8 953.4 970.3 10497.7 10522.6 10528.2 10528.4 10529.5 4028.7 4250.0 4257.5 4270.8 4274.5 9041.1 9052.4 9067.0 9079.7 9110.8 4642.7 4661.8 4662.9 4663.0 4664.3 3480.8 4010.3 4035.9 4050.6 4170.8 3676.7 3711.7 3791.7 3816.5 3823.3 1191.2 1193.4 1226.2 1231.3 1232.7 917.8 939.6 942.9 944.8 952.9 5336.4 5496.9 5503.9 5523.7 5650.5 406.7 410.5 413.5 415.9 427.3 3678.3 3701.1 3721.4 3786.2 3948.3 9298.5 9497.8 9505.7 9678.6 9701.5 9407.2 9530.1 9542.4 9560.2 9573.2 7281.3 7445.9 7477.7 7485.1 7490.4 5242.0 5310.2 5339.9 5450.0 5462.7 8527.3 8877.1 8927.4 8939.6 8957.6 8230.3 8569.4 8875.6 8924.1 8929.6 5965.8 6676.7 6816.5 6897.2 7087.5 7056.6 7221.6 7239.4 7258.3 7258.3 6489.6 6575.2 6621.1 6631.9 6753.2 6505.2 6560.9 6620.5 6624.4 6703.3 6188.2 6210.9 6262.6 6263.2 6264.7 4501.8 4662.9 4672.3 4683.5 4813.8 4750.7 4774.5 4777.1 4789.7 4835.4 04:37:34 INFO - PROCESS | 20069 | 04:37:34 INFO - PROCESS | 20069 | [#4] prototype.html Cycles:180 Average:4316.75 Median:4902.87 stddev:1245.94 (25.4%) stddev-sans-first:1212.41 04:37:34 INFO - PROCESS | 20069 | Values: 299.9 307.0 310.3 311.1 314.6 4831.8 4906.8 4946.0 5004.9 5017.3 4926.5 4959.6 4962.3 4981.4 5019.8 3936.5 3947.7 3948.8 3949.0 3959.7 3676.9 3951.8 3956.2 3958.9 3966.3 3853.8 3867.7 3871.9 3881.1 3896.5 3886.9 3889.6 3899.2 3900.4 3904.0 3449.9 3462.1 3476.4 3477.6 3482.8 4566.4 4730.5 4752.5 4763.9 4789.3 4450.8 4456.4 4468.6 4477.9 4484.2 5184.1 5196.3 5198.0 5235.8 5254.4 3699.1 3789.7 3794.5 3800.2 3806.4 5440.8 5454.4 5472.9 5479.5 5515.9 3871.3 3874.6 3876.2 3877.9 3884.4 3916.3 3921.6 3929.5 3934.9 3938.3 4266.7 4420.2 4427.2 4427.5 4436.5 5170.1 5205.6 5238.8 5243.4 5248.7 1258.3 1301.1 1317.9 1335.6 1342.6 902.9 924.8 930.7 934.2 938.7 4403.5 4411.9 4420.9 4422.2 4427.2 5195.3 5204.5 5209.7 5220.2 5224.1 4272.2 4417.6 4433.8 4436.8 4440.2 2694.0 2741.2 2743.7 2751.9 2800.3 4885.5 4899.0 4914.6 4932.6 4956.5 5149.6 5158.5 5270.8 5307.6 5323.8 4841.8 4856.3 4865.5 4916.8 4941.7 5182.5 5216.6 5220.7 5226.7 5240.6 5009.7 5090.6 5100.3 5144.8 5302.9 5076.4 5085.4 5090.4 5123.8 5164.6 3773.4 3773.6 3777.5 3787.8 3792.6 5204.5 5408.7 5443.4 5456.3 5465.2 5243.5 5263.7 5275.9 5284.1 5289.3 5247.5 5257.3 5280.6 5281.9 5328.1 5061.7 5082.2 5171.6 5221.3 5240.4 5336.4 5360.8 5377.8 5399.9 5419.7 5220.1 5222.9 5241.8 5260.4 5285.2 04:37:34 INFO - PROCESS | 20069 | 04:37:34 INFO - PROCESS | 20069 | [#5] yui.html Cycles:180 Average:13055.83 Median:44611.94 stddev:14636.60 (32.8%) stddev-sans-first:14648.55 04:37:34 INFO - PROCESS | 20069 | Values: 762.8 764.1 798.2 814.7 822.4 12938.9 13284.3 13397.1 13427.0 13594.5 14200.0 14320.0 14355.0 14378.3 14401.9 689.3 890.2 891.8 894.8 898.8 862.0 884.9 887.0 891.9 892.3 918.3 929.1 932.9 932.9 938.0 927.0 930.1 931.0 932.6 934.2 678.8 682.4 683.9 684.5 685.3 12771.6 12872.0 12962.9 12987.7 12991.7 12314.4 12492.8 12549.3 12567.4 12777.6 9929.9 10092.7 10191.7 10455.6 10565.1 3300.3 3320.8 3350.3 3358.1 3435.9 46800.3 46919.3 46990.3 47242.5 48217.3 9662.0 9705.9 9709.3 9784.0 9914.0 16756.0 17199.4 17213.7 17301.5 17350.8 7025.6 7039.8 7100.9 7110.8 7223.9 3710.2 3781.5 3841.3 3878.1 3880.6 2859.9 2941.7 2943.2 2948.3 2952.3 542.7 550.0 554.3 557.4 563.8 530.7 541.4 642.1 653.1 654.7 7804.6 7827.7 7881.8 8105.8 8257.3 548.8 549.9 559.0 563.2 567.6 3624.6 3629.7 3659.9 3754.3 3779.7 51553.7 52320.2 52552.7 52615.2 52945.7 47034.3 47647.0 47824.5 47982.8 49251.3 43318.1 43661.1 43971.0 44422.3 44801.6 7390.2 7536.9 7941.6 8469.0 8557.7 26812.6 26939.6 27929.3 28926.1 29342.0 38142.8 38348.8 38717.2 39047.4 39605.8 10686.9 10696.3 10898.0 11175.5 11654.1 11208.6 11342.1 11543.0 11814.4 11901.3 11368.1 11386.8 11760.2 12399.3 12495.9 11769.5 11795.7 11947.1 12116.5 12326.4 9516.0 11466.7 11760.8 11786.4 12051.9 9685.0 9912.3 9948.2 10115.0 10270.8 9726.5 9780.3 9893.4 10185.5 10197.3 04:37:34 INFO - PROCESS | 20069 | -------- Summary: end -------- 04:37:34 INFO - PROCESS | 20069 | 04:37:34 INFO - TEST-INFO | 20069: exit 0 04:37:34 INFO - TEST-OK | dromaeo_css | took 1116445ms 04:37:34 INFO - TEST-START | kraken 04:37:34 INFO - operating with platform_type : linux_ 04:37:34 INFO - Initialising browser for kraken test... 04:37:34 INFO - TEST-INFO | started process 20304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcnaYEg/profile http://localhost:34947/getInfo.html) 04:37:38 INFO - PROCESS | 20304 | 04:37:38 INFO - PROCESS | 20304 | (process:20370): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:37:39 INFO - PROCESS | 20304 | __metrics Screen width/height:1600/1200 04:37:39 INFO - PROCESS | 20304 | colorDepth:24 04:37:39 INFO - PROCESS | 20304 | Browser inner width/height: 1024/697 04:37:39 INFO - PROCESS | 20304 | __metrics 04:37:40 ERROR - PROCESS | 20304 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:37:41 INFO - TEST-INFO | 20304: exit 0 04:37:41 INFO - Browser initialized. 04:37:41 INFO - Running cycle 1/1 for kraken test... 04:37:41 INFO - TEST-INFO | started process 20421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcnaYEg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:43 INFO - PROCESS | 20421 | 04:37:43 INFO - PROCESS | 20421 | (process:20481): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:37:53 INFO - PROCESS | 20421 | RSS: Main: 164663296 04:37:53 INFO - PROCESS | 20421 | 04:37:55 INFO - PROCESS | 20421 | Cycle 1(1): loaded http://localhost:34947/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34947/tests/kraken/driver.html?testName=audio-beat-detection) 04:37:56 INFO - PROCESS | 20421 | RSS: Main: 168861696 04:37:56 INFO - PROCESS | 20421 | 04:37:59 INFO - PROCESS | 20421 | Cycle 1(1): loaded http://localhost:34947/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34947/tests/kraken/driver.html?testName=audio-dft) 04:38:00 INFO - PROCESS | 20421 | RSS: Main: 169512960 04:38:00 INFO - PROCESS | 20421 | 04:38:03 INFO - PROCESS | 20421 | Cycle 1(1): loaded http://localhost:34947/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34947/tests/kraken/driver.html?testName=audio-fft) 04:38:03 INFO - PROCESS | 20421 | RSS: Main: 164102144 04:38:03 INFO - PROCESS | 20421 | 04:38:06 INFO - PROCESS | 20421 | Cycle 1(1): loaded http://localhost:34947/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34947/tests/kraken/driver.html?testName=audio-oscillator) 04:38:06 INFO - PROCESS | 20421 | RSS: Main: 164438016 04:38:06 INFO - PROCESS | 20421 | 04:38:08 INFO - PROCESS | 20421 | Cycle 1(1): loaded http://localhost:34947/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34947/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:38:09 INFO - PROCESS | 20421 | RSS: Main: 164769792 04:38:09 INFO - PROCESS | 20421 | 04:38:12 INFO - PROCESS | 20421 | Cycle 1(1): loaded http://localhost:34947/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34947/tests/kraken/driver.html?testName=imaging-darkroom) 04:38:13 INFO - PROCESS | 20421 | RSS: Main: 164982784 04:38:13 INFO - PROCESS | 20421 | 04:38:16 INFO - PROCESS | 20421 | Cycle 1(1): loaded http://localhost:34947/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34947/tests/kraken/driver.html?testName=imaging-desaturate) 04:38:17 INFO - PROCESS | 20421 | RSS: Main: 163221504 04:38:17 INFO - PROCESS | 20421 | 04:38:20 INFO - PROCESS | 20421 | Cycle 1(1): loaded http://localhost:34947/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34947/tests/kraken/driver.html?testName=json-parse-financial) 04:38:20 INFO - PROCESS | 20421 | RSS: Main: 163594240 04:38:20 INFO - PROCESS | 20421 | 04:38:22 INFO - PROCESS | 20421 | Cycle 1(1): loaded http://localhost:34947/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34947/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:38:23 INFO - PROCESS | 20421 | RSS: Main: 164405248 04:38:23 INFO - PROCESS | 20421 | 04:38:25 INFO - PROCESS | 20421 | Cycle 1(1): loaded http://localhost:34947/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34947/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:38:25 INFO - PROCESS | 20421 | RSS: Main: 164061184 04:38:25 INFO - PROCESS | 20421 | 04:38:27 INFO - PROCESS | 20421 | Cycle 1(1): loaded http://localhost:34947/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34947/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:38:28 INFO - PROCESS | 20421 | RSS: Main: 164470784 04:38:28 INFO - PROCESS | 20421 | 04:38:31 INFO - PROCESS | 20421 | Cycle 1(1): loaded http://localhost:34947/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:38:32 INFO - PROCESS | 20421 | RSS: Main: 164388864 04:38:32 INFO - PROCESS | 20421 | 04:38:35 INFO - PROCESS | 20421 | Cycle 1(1): loaded http://localhost:34947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:38:35 INFO - PROCESS | 20421 | RSS: Main: 164712448 04:38:35 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | Cycle 1(1): loaded http://localhost:34947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34947/tests/kraken/driver.html?testName=ai-astar) 04:38:37 INFO - PROCESS | 20421 | RSS: Main: 165785600 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | __start_tp_report 04:38:37 INFO - PROCESS | 20421 | _x_x_mozilla_page_load 04:38:37 INFO - PROCESS | 20421 | _x_x_mozilla_page_load_details 04:38:37 INFO - PROCESS | 20421 | |i|pagename|runs| 04:38:37 INFO - PROCESS | 20421 | |0;ai-astar;114;118;107;114;117;114;109;114;114;114 04:38:37 INFO - PROCESS | 20421 | |1;audio-beat-detection;164;138;154;187;133;161;151;133;187;136 04:38:37 INFO - PROCESS | 20421 | |2;audio-dft;161;166;165;167;169;163;162;168;162;162 04:38:37 INFO - PROCESS | 20421 | |3;audio-fft;76;75;76;156;77;76;75;75;157;80 04:38:37 INFO - PROCESS | 20421 | |4;audio-oscillator;93;92;146;92;93;94;143;94;93;142 04:38:37 INFO - PROCESS | 20421 | |5;imaging-gaussian-blur;118;117;117;117;117;118;118;118;117;117 04:38:37 INFO - PROCESS | 20421 | |6;imaging-darkroom;147;146;148;148;149;147;147;147;147;147 04:38:37 INFO - PROCESS | 20421 | |7;imaging-desaturate;94;96;94;96;96;96;95;95;95;95 04:38:37 INFO - PROCESS | 20421 | |8;json-parse-financial;69;73;68;67;67;71;69;92;65;65 04:38:37 INFO - PROCESS | 20421 | |9;json-stringify-tinderbox;63;64;64;64;64;65;64;63;64;64 04:38:37 INFO - PROCESS | 20421 | |10;stanford-crypto-aes;82;80;81;84;89;83;85;84;83;82 04:38:37 INFO - PROCESS | 20421 | |11;stanford-crypto-ccm;165;135;140;137;136;144;133;153;173;143 04:38:37 INFO - PROCESS | 20421 | |12;stanford-crypto-pbkdf2;180;184;182;184;186;179;180;179;177;178 04:38:37 INFO - PROCESS | 20421 | |13;stanford-crypto-sha256-iterative;67;67;73;67;71;67;69;73;66;69 04:38:37 INFO - PROCESS | 20421 | __end_tp_report 04:38:37 INFO - PROCESS | 20421 | __start_cc_report 04:38:37 INFO - PROCESS | 20421 | _x_x_mozilla_cycle_collect,929 04:38:37 INFO - PROCESS | 20421 | __end_cc_report 04:38:37 INFO - PROCESS | 20421 | __startTimestamp1462534717741__endTimestamp 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | ------- Summary: start ------- 04:38:37 INFO - PROCESS | 20421 | Number of tests: 14 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:3.27 (2.9%) stddev-sans-first:3.47 04:38:37 INFO - PROCESS | 20421 | Values: 114.0 118.0 107.0 114.0 117.0 114.0 109.0 114.0 114.0 114.0 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | [#1] audio-beat-detection Cycles:10 Average:154.40 Median:157.50 stddev:20.54 (13.0%) stddev-sans-first:21.49 04:38:37 INFO - PROCESS | 20421 | Values: 164.0 138.0 154.0 187.0 133.0 161.0 151.0 133.0 187.0 136.0 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | [#2] audio-dft Cycles:10 Average:164.50 Median:165.50 stddev:2.88 (1.7%) stddev-sans-first:2.76 04:38:37 INFO - PROCESS | 20421 | Values: 161.0 166.0 165.0 167.0 169.0 163.0 162.0 168.0 162.0 162.0 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | [#3] audio-fft Cycles:10 Average:92.30 Median:76.00 stddev:33.87 (44.6%) stddev-sans-first:35.41 04:38:37 INFO - PROCESS | 20421 | Values: 76.0 75.0 76.0 156.0 77.0 76.0 75.0 75.0 157.0 80.0 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:93.00 stddev:24.50 (26.3%) stddev-sans-first:25.36 04:38:37 INFO - PROCESS | 20421 | Values: 93.0 92.0 146.0 92.0 93.0 94.0 143.0 94.0 93.0 142.0 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:38:37 INFO - PROCESS | 20421 | Values: 118.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 04:38:37 INFO - PROCESS | 20421 | Values: 147.0 146.0 148.0 148.0 149.0 147.0 147.0 147.0 147.0 147.0 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.50 stddev:0.79 (0.8%) stddev-sans-first:0.71 04:38:37 INFO - PROCESS | 20421 | Values: 94.0 96.0 94.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | [#8] json-parse-financial Cycles:10 Average:70.60 Median:69.00 stddev:7.92 (11.5%) stddev-sans-first:8.38 04:38:37 INFO - PROCESS | 20421 | Values: 69.0 73.0 68.0 67.0 67.0 71.0 69.0 92.0 65.0 65.0 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 04:38:37 INFO - PROCESS | 20421 | Values: 63.0 64.0 64.0 64.0 64.0 65.0 64.0 63.0 64.0 64.0 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:2.50 (3.0%) stddev-sans-first:2.60 04:38:37 INFO - PROCESS | 20421 | Values: 82.0 80.0 81.0 84.0 89.0 83.0 85.0 84.0 83.0 82.0 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:143.50 stddev:13.58 (9.5%) stddev-sans-first:12.52 04:38:37 INFO - PROCESS | 20421 | Values: 165.0 135.0 140.0 137.0 136.0 144.0 133.0 153.0 173.0 143.0 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.90 Median:181.00 stddev:2.96 (1.6%) stddev-sans-first:3.12 04:38:37 INFO - PROCESS | 20421 | Values: 180.0 184.0 182.0 184.0 186.0 179.0 180.0 179.0 177.0 178.0 04:38:37 INFO - PROCESS | 20421 | 04:38:37 INFO - PROCESS | 20421 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:2.60 (3.8%) stddev-sans-first:2.67 04:38:37 INFO - PROCESS | 20421 | Values: 67.0 67.0 73.0 67.0 71.0 67.0 69.0 73.0 66.0 69.0 04:38:37 INFO - PROCESS | 20421 | -------- Summary: end -------- 04:38:37 INFO - PROCESS | 20421 | 04:38:38 INFO - TEST-INFO | 20421: exit 0 04:38:38 INFO - TEST-OK | kraken | took 63973ms 04:38:38 INFO - SUITE-END | took 1180s 04:38:38 INFO - Completed test suite (00:19:40) 04:38:38 INFO - javascript benchmark 04:38:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2703.7431444012814, 2744.9039283625075, 2770.418212175443, 2773.1541879726674, 2785.791065670075, 4803.471618122008, 4823.08361411332, 4853.902921941563, 4924.285978533119, 5000.799968001275, 4726.787294571744, 4733.952660473395, 4738.241881298993, 4772.594329481998, 4863.489333619963, 4418.2268103082, 4465.553444655541, 4561.429821272341, 4574.176648203322, 4579.313103034555, 4500.099980004013, 4588.609968152711, 4590.357349971006, 4613.492515823256, 4635.281531362644, 4334.566543345672, 4419.779011049434, 4436.157130145262, 4452.10957808438, 4508.481524624677, 4418.0, 4428.202923473774, 4432.357308190294, 4441.378207051015, 4482.327650852366, 4453.621442177418, 4474.709143905636, 4476.306172543261, 4493.7977790999485, 4500.437445319335, 4654.232051711463, 4704.0, 4715.905681886377, 4736.786844592001, 4755.881102972418, 5172.146595811687, 5192.0, 5195.9480405195845, 5200.635955483118, 5227.869303267449, 5102.183650615921, 5204.9739751301, 5219.791208351661, 5223.660462069954, 5223.895522089537, 4868.196747536652, 4913.508649135058, 4919.532644398776, 4957.107720610289, 4964.032013757283, 5346.91979620306, 5378.112611419072, 5390.595705322116, 5391.78432862689, 5399.6490228135835, 4959.7272150032095, 4960.70235785854, 5167.61242906776, 5189.169732842727, 5189.662671926313, 5060.114479965991, 5071.949280507148, 5091.338126043591, 5104.285400043997, 5169.508896654812, 4963.181075122637, 5090.949090509122, 5192.92210616841, 5197.402298735618, 5220.973895130576, 4951.10880041596, 5177.767000484987, 5184.922226166611, 5207.0366982108435, 5223.5559977402345, 4321.978390108029, 4370.584794444522, 4400.273954797422, 4439.311906654474, 4446.799894004777, 3806.9428958565645, 3819.5607505137264, 3834.501514803058, 3862.613738626115, 3875.476810630585, 4391.055922976575, 4397.538258482878, 4427.092446048617, 4439.0, 4490.887727806766, 5008.57427118699, 5198.324217851655, 5222.321098257202, 5255.6321057526375, 5286.392064912584, 4475.507694153641, 4488.4613846338, 4498.167838949805, 4508.301213311942, 4532.501424843264, 4482.8655140345845, 4688.64835137366, 4718.2214934536105, 4739.478657347689, 4740.502247264057, 4820.68665536739, 4850.078485087822, 4853.369062021915, 4893.0, 4896.804127834989, 5172.094883395315, 5186.0, 5206.401263854706, 5212.817551385683, 5230.215467679726, 4798.49615790351, 4824.638152138674, 4888.92666609994, 4894.216925291937, 4904.117258893433, 5078.97460512695, 5091.0581542414775, 5093.261477085728, 5097.362829646294, 5136.9743151284, 5160.819371321985, 5161.354830646169, 5166.586673066221, 5168.3797944246935, 5211.062008838294, 4878.170710979071, 5003.8498845033255, 5017.67385119966, 5053.545180933586, 5072.137736584716, 4909.754512274443, 4977.900441991213, 4980.277859710394, 5052.595792336678, 5063.544281014726, 4981.6014718823135, 4984.501549844987, 4988.176950803077, 4989.650724449254, 5030.798768049237, 4880.877978050577, 5077.873053173553, 5111.156659151347, 5124.846254612367, 5136.280920671184, 5047.116754568009, 5059.443461219336, 5063.0, 5065.594752419871, 5101.69389836611], "value": 4760.52836265413, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.7869009776284, 606.2482521673126, 612.0727098445856, 612.9601575897568, 637.0666972884728, 35967.04362520121, 40027.0, 40148.79925600372, 40161.19677606446, 40196.79901600488, 40703.59296407043, 41204.58795412045, 41376.17247655045, 41382.99999999993, 41561.37657935126, 7834.804129896741, 7908.367330613537, 7952.125266220711, 7958.403119766041, 7966.44234903557, 7915.881261781078, 8006.319462845665, 8009.559474228944, 8023.037235531744, 8027.117017128111, 7986.800329991738, 7999.760007199793, 8029.437939344219, 8033.799155021113, 8039.07550631679, 7988.400869934778, 7994.680212791482, 8016.158303378149, 8036.0, 8043.075046369684, 8007.0, 8007.159248278964, 8021.077576078709, 8044.396670249696, 8047.557384343859, 30856.228594285098, 37801.62198378008, 38132.61867381319, 38257.617423825686, 38327.61672383268, 3130.3426280481126, 3250.6261779895376, 3385.458326667746, 3474.2183008823067, 3505.5442792437075, 28473.430531389462, 31076.378472430424, 31111.0, 31633.683663163305, 32028.199295017577, 3397.264643725839, 3431.2108215110416, 3484.4424892017155, 3489.982550087259, 3592.892213233607, 254313.0, 255080.0, 258328.0, 260553.0, 260661.0, 35279.29441411209, 61870.38129618736, 62847.37152628415, 63024.0, 63059.0, 34717.82641086778, 37033.0, 37084.258314833554, 37204.62795372012, 37208.44187337192, 14569.198694071927, 14762.48331308399, 14792.408303667948, 14794.926025369805, 14798.260086995608, 10970.835437468444, 11158.386288754034, 11197.0, 11201.271917325348, 11212.719682007852, 8528.957355213308, 8611.13888611134, 8612.224899759052, 8627.827443451095, 8648.2216600505, 3368.1074515253476, 3407.4888766685194, 3442.621311655716, 3463.965360346415, 3467.5665541807275, 935.4808081514689, 951.7573018880141, 985.3348989432104, 1036.1192985961873, 1110.5890820396505, 29839.701602984125, 29941.550876736866, 29946.55080173799, 29977.0, 30172.396552068836, 1013.6705570689555, 1056.8837427882927, 1059.147386353977, 1077.6389909380289, 1115.5482029777952, 15698.76451853223, 15954.920225398799, 15977.360905563648, 16027.759583606256, 16175.514734557983, 360320.0, 361823.0, 364517.0, 364761.0, 365519.0, 51896.22155667668, 51984.0, 52128.21807672888, 52181.0, 52216.47783522192, 1270.6505710929569, 1296.9610911672664, 1305.505196549945, 1307.0, 1309.7511472820133, 26417.867910660323, 28423.43153136967, 28877.422451551272, 29074.27314317159, 29462.263443414085, 46022.309665354376, 46207.76896115498, 46439.0, 46627.0, 46649.30026049544, 300851.0, 301428.0, 301468.0, 302374.0, 302700.0, 26617.467650647264, 26839.865800670872, 27420.0, 27760.444791103662, 27777.166684999484, 44243.55756442394, 45007.0, 45334.77332613316, 45459.31811022771, 46519.76740116413, 37900.81049594734, 38362.42456363213, 38412.23175536418, 38999.610003900736, 39346.213075738895, 34389.828050859585, 37213.0, 38136.23727525489, 38219.42670859995, 38933.8053309743, 33455.33089338248, 34078.48882266718, 37980.0, 38200.235995279385, 38263.61736382601, 32349.676503234667, 33181.50227746634, 33689.0, 34402.48396274108, 34403.13992150116, 26087.347816304744, 26374.0, 26386.604200936617, 26440.73559264383, 26552.8672356637], "value": 17230.39102866814, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.53440268469774, 379.36456435470586, 383.3999790328138, 394.9506311711036, 396.0297271684374, 15769.369225230992, 17406.477805665818, 17660.29358825647, 18127.274909003656, 18175.272989080437, 17066.573335666584, 17393.39123130691, 17718.379856705018, 17739.29042838285, 17750.28998840048, 5140.948590514103, 5261.289725886994, 5299.311089558371, 5299.947000529984, 5318.734063296839, 3692.9446058309145, 5769.682667453289, 6035.124906888498, 6058.666773327465, 6158.199434073565, 5129.3844738631415, 6018.037114061751, 6057.606255593394, 6069.0592958091565, 6089.634621922699, 5383.757730902099, 5442.0476416627325, 5450.5367043801325, 5485.780568777244, 5489.39616642169, 5162.6128040397125, 5386.5152136307925, 5455.863603409907, 5461.836144915659, 5466.180072989044, 11825.822612660817, 12019.93990030053, 12148.57479988205, 12306.630801075982, 12409.06931980105, 1882.115405759291, 2041.3773798991301, 2084.1451108513434, 2089.2374283386607, 2091.309867743641, 9088.136627020422, 9162.267018638493, 9291.256699464095, 9331.72004839856, 11036.006759391694, 1693.1872701103416, 1823.3435963053291, 1851.5650370962478, 1854.1563588567305, 1872.447627949758, 68546.65726671384, 69053.0, 69225.3077469224, 69639.30360696379, 70663.64668176626, 9745.269104817025, 9760.755981100387, 10011.49942502872, 10094.293399462114, 10109.292349535463, 14037.0, 14038.719225615634, 14047.438102475786, 14096.71806563863, 14141.080829746033, 7417.109946806418, 7485.288897554724, 7504.137024242173, 7536.1333446654335, 7612.391008719289, 7009.754658586925, 7123.501354905211, 7207.13514378278, 7285.162206346232, 7302.488825782144, 4307.664623966581, 4347.804348804311, 4375.409319741858, 4389.275769498061, 4396.0, 1695.711729006072, 1770.7875054993483, 1850.3338798032698, 1858.2474097990334, 1895.4313705888178, 838.3125836813877, 902.6615019367737, 924.1451657217048, 995.9691719070727, 1000.7798284377425, 15153.848461515465, 16412.917935410245, 16450.506484805475, 16503.33986640545, 17003.91498042502, 913.5706218077493, 958.5973890965672, 959.4531117263233, 967.8354679704468, 969.4086607169621, 9249.768755781024, 9310.627574896927, 9338.953305233566, 9373.297002724823, 9503.119207541982, 375266.0, 387052.0, 387214.0, 390882.0, 392797.0, 76901.61549192219, 77207.61396192983, 77916.0, 78247.21752782399, 78362.21637783549, 920.9907900920905, 935.1536859142487, 953.8903026151943, 956.7416797464646, 968.4867020479157, 14652.926735366254, 14719.852801471849, 14813.333399997242, 14922.776158357416, 15168.469103581321, 32371.838140809145, 33122.0, 34054.48918266178, 34140.14649633779, 34695.82652086723, 44776.328355074045, 46044.769776150904, 46777.29834052424, 46799.0, 47450.28824567565, 7119.893201601876, 7235.963820180866, 7331.890021649573, 7368.815779605553, 7650.196729343339, 9752.46361450127, 10678.946605267234, 10729.088027517748, 10859.945700271765, 10868.07621352194, 9011.954940225258, 9287.164155226063, 9352.018038106173, 9520.811472542902, 9522.381045232038, 9328.95335523318, 9737.711637764978, 9825.656102036395, 10105.494725263854, 10202.234832387452, 9990.700278991642, 10034.19726421899, 10330.741731456774, 10332.793344133226, 10574.101201397967, 7672.616369181407, 7864.5281283123195, 7885.921140788748, 7893.881591776013, 7997.480163789335, 9591.136797688241, 10006.299559030798, 10186.541605627914, 10302.381857088598, 10310.43292618913], "value": 8120.294239308049, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.2262146305384, 1551.9767203491947, 1748.4404990403077, 1872.1668857358482, 1877.2678655324435, 6681.832954176148, 7244.0, 7461.776146715607, 7678.308952194308, 7699.692012319508, 7507.436942229341, 7755.340796032344, 7777.805554861131, 7791.532508049507, 7812.0, 2165.4694599823024, 2191.3206905859233, 2195.0232146694725, 2203.801657850793, 2207.569523942832, 2110.3141479019305, 2114.2177394364107, 2157.385145233609, 2167.9024443899984, 2173.1307477009163, 2098.6851972204217, 2108.325335892515, 2113.5138918048856, 2117.1637203304685, 2120.120150137691, 2115.894205289737, 2137.6472881974532, 2152.2251989283845, 2154.493693981913, 2157.4067131538795, 2075.5952589245103, 2094.0472085201195, 2109.377733568601, 2116.767155612881, 2119.872807631547, 7683.7310694126, 7692.576908270043, 7731.613419329011, 7732.0, 7733.226677332278, 4437.955620443819, 4515.548445155491, 4526.841560545398, 4538.954610453886, 4551.635869130495, 2902.535594304922, 2958.2604348912773, 3022.894198703035, 3027.10700343397, 3034.317278612317, 908.8500397434416, 934.2339281788936, 937.8358787212279, 953.4088864903804, 970.277143528069, 10497.737556561147, 10522.631707890187, 10528.157747380268, 10528.42093684847, 10529.526171322308, 4028.6575641070835, 4249.957500425018, 4257.489101307863, 4270.807813648331, 4274.487061552633, 9041.141091596288, 9052.366334356531, 9066.95466522663, 9079.68221112271, 9110.772230694152, 4642.698224615389, 4661.790219440133, 4662.906741865211, 4662.95337046632, 4664.253719404879, 3480.7565307632462, 4010.298197815429, 4035.899102522402, 4050.6151915567975, 4170.791460426966, 3676.7426280160666, 3711.7030637548933, 3791.696664266852, 3816.5420149581673, 3823.2926908522013, 1191.1661836714334, 1193.3555879824971, 1226.1600803449664, 1231.2673958994385, 1232.6671798614325, 917.8026724254318, 939.6006697153682, 942.8679984802134, 944.7968686732248, 952.9475878826593, 5336.386315573681, 5496.945030549723, 5503.9174412383845, 5523.7238138092935, 5650.491455769001, 406.7051387743862, 410.517641770918, 413.53683874061244, 415.8690012646007, 427.26510402108323, 3678.264347130531, 3701.0747313171705, 3721.3859713147026, 3786.2427514497213, 3948.2893079245437, 9298.488583127857, 9497.810043799085, 9505.714828555154, 9678.612855485702, 9701.51492425376, 9407.247420206368, 9530.142287194185, 9542.379745316532, 9560.235181185488, 9573.18627916621, 7281.308275713799, 7445.925540744632, 7477.663505142173, 7485.139208990927, 7490.363319117827, 5242.0, 5310.150375939831, 5339.946600533945, 5449.972750136224, 5462.726863656881, 8527.317814574695, 8877.112288771072, 8927.375083744075, 8939.642414303615, 8957.641694332415, 8230.300424463749, 8569.357298202534, 8875.556222188736, 8924.107589241024, 8929.642814287356, 5965.821025369246, 6676.732930682719, 6816.488763342868, 6897.241303456515, 7087.50387472872, 7056.576605403692, 7221.602811845399, 7239.384652304613, 7258.274172582911, 7258.3104605062435, 6489.643069631215, 6575.243846957661, 6621.139251897415, 6631.933680663132, 6753.189617245962, 6505.219373675, 6560.901586476302, 6620.470362370903, 6624.403803657501, 6703.262641109376, 6188.164597779242, 6210.875782484415, 6262.624242545462, 6263.185785847811, 6264.655443950626, 4501.842435514741, 4662.860114196579, 4672.252439609646, 4683.484816670231, 4813.831515896927, 4750.667453278375, 4774.498677638798, 4777.0684716479955, 4789.712617242976, 4835.371401717754], "value": 4079.430967056086, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.87255416448016, 306.95395690646404, 310.29098509904856, 311.071451716626, 314.6177394465724, 4831.782569784359, 4906.7546622668815, 4945.975270123648, 5004.92197298661, 5017.272495488157, 4926.45808961014, 4959.603231741461, 4962.330085438465, 4981.352424184851, 5019.774110165043, 3936.4882565266616, 3947.684185265172, 3948.763074215556, 3948.9802550987206, 3959.7030222733265, 3676.926461470769, 3951.8221680024467, 3956.188981258835, 3958.940615890764, 3966.345552983769, 3853.807309634507, 3867.7292589518743, 3871.9032024199337, 3881.068543549542, 3896.5129358830145, 3886.9010734203357, 3889.572147063821, 3899.2006638639295, 3900.3564411872007, 3903.98048009761, 3449.9482507762405, 3462.0998540379433, 3476.4437689969736, 3477.5826900771817, 3482.8432720527635, 4566.429196350457, 4730.455997560256, 4752.500987396343, 4763.857084287442, 4789.257665061921, 4450.777461126931, 4456.420665313489, 4468.575485328888, 4477.888052798674, 4484.2376795944765, 5184.14461613837, 5196.29849970253, 5198.0, 5235.8219400634935, 5254.369475662907, 3699.1491956849804, 3789.7157713171346, 3794.520137146515, 3800.2399520095814, 3806.410006448977, 5440.782368705247, 5454.400015998237, 5472.863178420572, 5479.4520547944885, 5515.931525677871, 3871.264459752694, 3874.593167717349, 3876.244132394156, 3877.86427475037, 3884.397453706024, 3916.2559113768293, 3921.568627450978, 3929.4891664083484, 3934.940975885364, 3938.310795610814, 4266.701330906869, 4420.248557745191, 4427.1887351532005, 4427.450392362712, 4436.46762388509, 5170.121079416433, 5205.6356055075785, 5238.790448382022, 5243.4232234454175, 5248.6588371755715, 1258.3016425883538, 1301.1477482249143, 1317.9275139867207, 1335.626024713082, 1342.5502456677123, 902.9413088149381, 924.7872989212519, 930.734740598926, 934.1685899549407, 938.6761567259284, 4403.515613282536, 4411.911761764747, 4420.850578849458, 4422.248217802981, 4427.158839820424, 5195.3115237547945, 5204.5055719707325, 5209.661372010807, 5220.1647736362, 5224.138017227191, 4272.16692744918, 4417.558244175557, 4433.82264709408, 4436.77988553144, 4440.178566965057, 2694.0301491463056, 2741.232454912628, 2743.7256274372403, 2751.917442476729, 2800.28592708862, 4885.511448855086, 4898.975505122523, 4914.606831453475, 4932.630052746058, 4956.4547899731, 5149.613778966593, 5158.535731784157, 5270.841874743764, 5307.601929855199, 5323.760430780624, 4841.830535931366, 4856.329019039585, 4865.489123642037, 4916.754162291871, 4941.690452030215, 5182.455842136521, 5216.600363832679, 5220.694826293427, 5226.738663066755, 5240.633155679066, 5009.749512524432, 5090.643654944267, 5100.26046223303, 5144.76848541824, 5302.9469705304, 5076.416212135652, 5085.415177254663, 5090.414602320632, 5123.795048198031, 5164.638475306692, 3773.3773927301686, 3773.566039905446, 3777.490038844831, 3787.8295476704166, 3792.6207379261855, 5204.531592156724, 5408.675479471244, 5443.401225865231, 5456.290682211287, 5465.180222966586, 5243.528082472596, 5263.73681315925, 5275.894482110413, 5284.093748438267, 5289.259503669567, 5247.501487358695, 5257.342832145981, 5280.6303558750515, 5281.867953301198, 5328.094223981855, 5061.721605311596, 5082.237664350377, 5171.560417364566, 5221.347331583552, 5240.449752776056, 5336.439673834191, 5360.758765855468, 5377.784888604412, 5399.9190012149065, 5419.701916394636, 5220.138677118233, 5222.9216561750845, 5241.842744717665, 5260.395579348336, 5285.207218917039], "value": 3922.75777783236, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.8169239382548, 764.1403421151203, 798.1818635898204, 814.6578437056439, 822.4366309078279, 12938.935305323472, 13284.269365184911, 13397.129186602877, 13427.0, 13594.524191653294, 14200.0, 14320.0, 14355.0, 14378.281085945688, 14401.92799036006, 689.3347919257915, 890.2210565754964, 891.7725979875123, 894.785251539629, 898.8247291778106, 861.9698310559131, 884.9159329863653, 887.0198430734043, 891.9464832110094, 892.3485855325583, 918.334207699416, 929.1126973740096, 932.8554074118489, 932.8600709893502, 937.9577918993662, 926.9860952085725, 930.1349744737391, 931.0177762460635, 932.5803388475146, 934.1919239857474, 678.8472593666386, 682.3654001778344, 683.8734834055666, 684.4797953555284, 685.338648204485, 12771.552995645108, 12872.0, 12962.935185324013, 12987.675308117277, 12991.675208119777, 12314.384280785926, 12492.75014499714, 12549.309787961658, 12567.434465449076, 12777.552785652457, 9929.90070099297, 10092.747681307952, 10191.694249172537, 10455.634052808115, 10565.101966332793, 3300.3234336960863, 3320.8339583020993, 3350.279689866666, 3358.126887009371, 3435.9484607730906, 46800.29799553009, 46919.296210556866, 46990.29514557285, 47242.527574724154, 48217.27674084857, 9661.975627898544, 9705.9029409705, 9709.271804614682, 9784.0, 9913.950430247802, 16756.0, 17199.398021069203, 17213.655726885394, 17301.480955571355, 17350.826491735173, 7025.648717564101, 7039.753608623673, 7100.92899071013, 7110.7511237106455, 7223.927760722326, 3710.239400922804, 3781.4516895050615, 3841.3277676407074, 3878.127421330178, 3880.553736320303, 2859.885604575794, 2941.6617089034607, 2943.249471384783, 2948.3071478202605, 2952.291450051972, 542.6662602499434, 549.9890002199934, 554.3071161048689, 557.406362224238, 563.760401829221, 530.6524226631562, 541.445018855676, 642.0529718665025, 653.053073044088, 654.7348323928817, 7804.605555195335, 7827.686892524235, 7881.842363152705, 8105.797355066171, 8257.339412846957, 548.8298627425511, 549.8955198512269, 558.9860253493614, 563.1608902734896, 567.591334239347, 3624.6012938576737, 3629.673329400314, 3659.908502287411, 3754.2866855297407, 3779.6598306152578, 51553.742231289354, 52320.21519677208, 52552.73723631357, 52615.21077183845, 52945.7352713234, 47034.294485582745, 47647.04705905863, 47824.521754782705, 47982.76008620005, 49251.26123108156, 43318.133637327075, 43661.12677746427, 43971.0, 44422.33366499505, 44801.55198447974, 7390.150132734804, 7536.886946695914, 7941.602919853869, 8468.957655211685, 8557.700480483154, 26812.59781103324, 26939.595906061815, 27929.301767455163, 28926.13221603355, 29342.0, 38142.80928595339, 38348.80825595966, 38717.22565548617, 39047.41428878626, 39605.80197098996, 10686.89313106859, 10696.251262411557, 10898.0, 11175.49710263024, 11654.067674586182, 11208.55165793359, 11342.149338799789, 11543.0, 11814.350210738148, 11901.285922844658, 11368.147388945697, 11386.772264554827, 11760.235584686969, 12399.25604463735, 12495.93752031234, 11769.529218831492, 11795.705107372385, 11947.103967202669, 12116.515339386326, 12326.445309961253, 9516.0, 11466.656000320003, 11760.76478470443, 11786.41067946582, 12051.939740301243, 9685.0, 9912.256580756328, 9948.204143668634, 10115.0, 10270.845937311096, 9726.452860853418, 9780.26648001417, 9893.35693179941, 10185.470944876392, 10197.260763059003], "value": 6153.374549771506, "unit": "score"}], "name": "dromaeo_css", "value": 6350.564087472767, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 107.0, 114.0, 117.0, 114.0, 109.0, 114.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 138.0, 154.0, 187.0, 133.0, 161.0, 151.0, 133.0, 187.0, 136.0], "value": 154.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 165.0, 167.0, 169.0, 163.0, 162.0, 168.0, 162.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 156.0, 77.0, 76.0, 75.0, 75.0, 157.0, 80.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 146.0, 92.0, 93.0, 94.0, 143.0, 94.0, 93.0, 142.0], "value": 108.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 148.0, 149.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 68.0, 67.0, 67.0, 71.0, 69.0, 92.0, 65.0, 65.0], "value": 70.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 63.0, 64.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 81.0, 84.0, 89.0, 83.0, 85.0, 84.0, 83.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 135.0, 140.0, 137.0, 136.0, 144.0, 133.0, 153.0, 173.0, 143.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 184.0, 182.0, 184.0, 186.0, 179.0, 180.0, 179.0, 177.0, 178.0], "value": 180.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 73.0, 67.0, 71.0, 67.0, 69.0, 73.0, 66.0, 69.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1606.3000000000002, "alertThreshold": 2.0}]} 04:38:38 INFO - Return code: 0 04:38:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:38:39 ERROR - # TBPL SUCCESS # 04:38:39 INFO - Running post-action listener: _resource_record_post_action 04:38:39 INFO - Running post-run listener: _resource_record_post_run 04:38:40 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 519647232; Read time: 20; Write time: 510516 04:38:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 235020288; Read time: 0; Write time: 250920 04:38:40 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284626944; Read time: 20; Write time: 259596 04:38:40 INFO - Running post-run listener: _upload_blobber_files 04:38:40 INFO - Blob upload gear active. 04:38:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:38:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:38:40 INFO - (blobuploader) - INFO - Open directory for files ... 04:38:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:38:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:38:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:38:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:38:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:38:41 INFO - (blobuploader) - INFO - Done attempting. 04:38:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:38:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:38:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:38:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:38:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:38:42 INFO - (blobuploader) - INFO - Done attempting. 04:38:42 INFO - (blobuploader) - INFO - Iteration through files over. 04:38:42 INFO - Return code: 0 04:38:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:38:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:38:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/faf75022443fbf54df326233032b9e783abe1d6ddf7d6e43052fbef7f06851f1265a59f2477049f099c95146f14b83b0fce397ce8f18d426b071a0fe11d2b3e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/488201fb9e08d3f615bd41a973d8116a8ceb4d0ad43ef31a5b2faf4455275cecc0e5f162b004c0734aa06c31e805a3b96f5a5d518909546e0a83207830217d12"} 04:38:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:38:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:38:42 INFO - Contents: 04:38:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/faf75022443fbf54df326233032b9e783abe1d6ddf7d6e43052fbef7f06851f1265a59f2477049f099c95146f14b83b0fce397ce8f18d426b071a0fe11d2b3e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/488201fb9e08d3f615bd41a973d8116a8ceb4d0ad43ef31a5b2faf4455275cecc0e5f162b004c0734aa06c31e805a3b96f5a5d518909546e0a83207830217d12"} 04:38:42 INFO - Running post-run listener: copy_logs_to_upload_dir 04:38:42 INFO - Copying logs to upload dir... 04:38:42 INFO - mkdir: /builds/slave/test/build/upload/logs 04:38:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.674322 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-06 04:38:42.073874) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 04:38:42.078889) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670 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/Firefox-Non-PGO/sha512/faf75022443fbf54df326233032b9e783abe1d6ddf7d6e43052fbef7f06851f1265a59f2477049f099c95146f14b83b0fce397ce8f18d426b071a0fe11d2b3e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/488201fb9e08d3f615bd41a973d8116a8ceb4d0ad43ef31a5b2faf4455275cecc0e5f162b004c0734aa06c31e805a3b96f5a5d518909546e0a83207830217d12"} build_url:https://queue.taskcluster.net/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/eJpOw_cdRJ-3OSPr5ocCLw/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/Firefox-Non-PGO/sha512/faf75022443fbf54df326233032b9e783abe1d6ddf7d6e43052fbef7f06851f1265a59f2477049f099c95146f14b83b0fce397ce8f18d426b071a0fe11d2b3e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/488201fb9e08d3f615bd41a973d8116a8ceb4d0ad43ef31a5b2faf4455275cecc0e5f162b004c0734aa06c31e805a3b96f5a5d518909546e0a83207830217d12"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 04:38:42.106167) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:38:42.106512) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462533485.9329-439588670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:38:42.156471) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 04:38:42.156799) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 04:38:42.157091) ========= ========= Total master_lag: 0.16 =========