builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1465290625.92 results: success (0) buildid: 20160606194329 builduid: 3d31ab4f42854c829e06ac6160cc676b revision: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:10:25.920081) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:10:25.920537) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:10:25.920819) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:10:25.935439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:10:25.935763) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 02:10:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 27.2M=0s 2016-06-07 02:10:26 (27.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097442 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:10:26.047193) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:10:26.047576) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023293 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:10:26.097538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 02:10:26.097885) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 02:10:26,130 truncating revision to first 12 chars 2016-06-07 02:10:26,130 Setting DEBUG logging. 2016-06-07 02:10:26,130 attempt 1/10 2016-06-07 02:10:26,130 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1f9f6bdee31c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 02:10:26,766 unpacking tar archive at: mozilla-beta-1f9f6bdee31c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.986586 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 02:10:27.098999) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:10:27.099341) ========= script_repo_revision: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:10:27.099853) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:10:27.100285) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:10:27.110220) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-07 02:10:27.110655) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:10:27 INFO - MultiFileLogger online at 20160607 02:10:27 in /builds/slave/test 02:10:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 02:10:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:10:27 INFO - {'append_to_log': False, 02:10:27 INFO - 'base_work_dir': '/builds/slave/test', 02:10:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:10:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:10:27 INFO - 'branch': 'Mozilla-Beta', 02:10:27 INFO - 'buildbot_json_path': 'buildprops.json', 02:10:27 INFO - 'config_files': ('talos/linux_config.py',), 02:10:27 INFO - 'default_actions': ('clobber', 02:10:27 INFO - 'read-buildbot-config', 02:10:27 INFO - 'download-and-extract', 02:10:27 INFO - 'populate-webroot', 02:10:27 INFO - 'create-virtualenv', 02:10:27 INFO - 'install', 02:10:27 INFO - 'run-tests'), 02:10:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:10:27 INFO - 'download_minidump_stackwalk': True, 02:10:27 INFO - 'download_symbols': 'ondemand', 02:10:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:10:27 INFO - 'tooltool.py': '/tools/tooltool.py', 02:10:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:10:27 INFO - '/tools/misc-python/virtualenv.py')}, 02:10:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:10:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:10:27 INFO - 'installer_path': 'installer.exe', 02:10:27 INFO - 'log_level': 'info', 02:10:27 INFO - 'log_name': 'talos', 02:10:27 INFO - 'log_to_console': True, 02:10:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:10:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:10:27 INFO - 'opt_config_files': (), 02:10:27 INFO - 'pip_index': False, 02:10:27 INFO - 'sps_profile': False, 02:10:27 INFO - 'sps_profile_interval': 0, 02:10:27 INFO - 'suite': 'dromaeojs-e10s', 02:10:27 INFO - 'system_bits': '32', 02:10:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:10:27 INFO - 'title': 'talos-linux64-ix-006', 02:10:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:10:27 INFO - 'use_talos_json': True, 02:10:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:10:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:10:27 INFO - 'work_dir': 'build'} 02:10:27 INFO - ##### 02:10:27 INFO - ##### Running clobber step. 02:10:27 INFO - ##### 02:10:27 INFO - Running pre-action listener: _resource_record_pre_action 02:10:27 INFO - Running main action method: clobber 02:10:27 INFO - rmtree: /builds/slave/test/build 02:10:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:10:28 INFO - Running post-action listener: _resource_record_post_action 02:10:28 INFO - ##### 02:10:28 INFO - ##### Running read-buildbot-config step. 02:10:28 INFO - ##### 02:10:28 INFO - Running pre-action listener: _resource_record_pre_action 02:10:28 INFO - Running main action method: read_buildbot_config 02:10:28 INFO - Using buildbot properties: 02:10:28 INFO - { 02:10:28 INFO - "project": "", 02:10:28 INFO - "product": "firefox", 02:10:28 INFO - "script_repo_revision": "production", 02:10:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 02:10:28 INFO - "repository": "", 02:10:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 02:10:28 INFO - "buildid": "20160606194329", 02:10:28 INFO - "pgo_build": "True", 02:10:28 INFO - "basedir": "/builds/slave/test", 02:10:28 INFO - "buildnumber": 32, 02:10:28 INFO - "slavename": "talos-linux64-ix-006", 02:10:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:10:28 INFO - "platform": "ubuntu64_hw", 02:10:28 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 02:10:28 INFO - "branch": "mozilla-beta", 02:10:28 INFO - "repo_path": "releases/mozilla-beta", 02:10:28 INFO - "revision": "1f9f6bdee31c14fd5a39485e8ae326de2928ef7d", 02:10:28 INFO - "stage_platform": "linux64-pgo", 02:10:28 INFO - "builduid": "3d31ab4f42854c829e06ac6160cc676b", 02:10:28 INFO - "slavebuilddir": "test" 02:10:28 INFO - } 02:10:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 02:10:28 INFO - Running post-action listener: _resource_record_post_action 02:10:28 INFO - ##### 02:10:28 INFO - ##### Running download-and-extract step. 02:10:28 INFO - ##### 02:10:28 INFO - Running pre-action listener: _resource_record_pre_action 02:10:28 INFO - Running main action method: download_and_extract 02:10:28 INFO - mkdir: /builds/slave/test/build/tests 02:10: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')]} 02:10:28 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:10:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:10:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:10:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:10:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:10:28 INFO - Downloaded 1327 bytes. 02:10:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:10:28 INFO - Using the following test package requirements: 02:10:28 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 02:10:28 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:10:28 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 02:10:28 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:10:28 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 02:10:28 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:10:28 INFO - u'jsshell-linux-x86_64.zip'], 02:10:28 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:10:28 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 02:10:28 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 02:10:28 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:10:28 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 02:10:28 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:10:28 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 02:10:28 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:10:28 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 02:10:28 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:10:28 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 02:10:28 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:10: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')]} 02:10:28 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:10:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:10:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:10:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:10:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:10:30 INFO - Downloaded 24176679 bytes. 02:10:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:10:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:10:32 INFO - Return code: 0 02:10:32 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:32 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:10:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:10:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:10:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:10:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:10:33 INFO - Downloaded 24176679 bytes. 02:10:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:10:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:10:34 INFO - Return code: 0 02:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:34 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:10:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 02:10:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 02:10:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 02:10:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:10:36 INFO - Downloaded 10840145 bytes. 02:10:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:10:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:10:36 INFO - Return code: 0 02:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:36 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:10:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:10:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:10:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:10:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:10:39 INFO - Downloaded 55996763 bytes. 02:10:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:10:39 INFO - mkdir: /builds/slave/test/properties 02:10:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:10:39 INFO - Writing to file /builds/slave/test/properties/build_url 02:10:39 INFO - Contents: 02:10:39 INFO - build_url:https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:10:40 INFO - Running post-action listener: _resource_record_post_action 02:10:40 INFO - Running post-action listener: set_extra_try_arguments 02:10:40 INFO - ##### 02:10:40 INFO - ##### Running populate-webroot step. 02:10:40 INFO - ##### 02:10:40 INFO - Running pre-action listener: _resource_record_pre_action 02:10:40 INFO - Running main action method: populate_webroot 02:10:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:10:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:10:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:10:40 INFO - '--tppagecycles', 02:10:40 INFO - '7'], 02:10:40 INFO - 'tests': ['tsvgm']}}, 02:10:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:10:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:10:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:10:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:10:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:10:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:10:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:40 INFO - 'talos_options': ['--disable-e10s'], 02:10:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:40 INFO - 'talos_options': ['--disable-e10s'], 02:10:40 INFO - 'tests': ['damp', 'tps']}, 02:10:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:40 INFO - 'tests': ['damp', 'tps']}, 02:10:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:10:40 INFO - 'tests': ['dromaeo_dom']}, 02:10:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:10:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:10:40 INFO - 'tests': ['a11yr', 02:10:40 INFO - 'ts_paint', 02:10:40 INFO - 'tpaint', 02:10:40 INFO - 'sessionrestore', 02:10:40 INFO - 'sessionrestore_no_auto_restore', 02:10:40 INFO - 'tabpaint']}, 02:10:40 INFO - 'other-e10s': {'tests': ['a11yr', 02:10:40 INFO - 'ts_paint', 02:10:40 INFO - 'tpaint', 02:10:40 INFO - 'sessionrestore', 02:10:40 INFO - 'sessionrestore_no_auto_restore', 02:10:40 INFO - 'tabpaint']}, 02:10:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:10:40 INFO - 'ts_paint', 02:10:40 INFO - 'tpaint', 02:10:40 INFO - 'sessionrestore', 02:10:40 INFO - 'sessionrestore_no_auto_restore', 02:10:40 INFO - 'tabpaint']}, 02:10:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:10:40 INFO - 'ts_paint', 02:10:40 INFO - 'tpaint', 02:10:40 INFO - 'sessionrestore', 02:10:40 INFO - 'sessionrestore_no_auto_restore', 02:10:40 INFO - 'tabpaint']}, 02:10:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:10:40 INFO - 'tests': ['a11yr', 02:10:40 INFO - 'ts_paint', 02:10:40 INFO - 'tpaint', 02:10:40 INFO - 'sessionrestore', 02:10:40 INFO - 'sessionrestore_no_auto_restore', 02:10:40 INFO - 'tabpaint']}, 02:10:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:10:40 INFO - 'tests': ['a11yr', 02:10:40 INFO - 'ts_paint', 02:10:40 INFO - 'tpaint', 02:10:40 INFO - 'sessionrestore', 02:10:40 INFO - 'sessionrestore_no_auto_restore', 02:10:40 INFO - 'tabpaint']}, 02:10:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:10:40 INFO - 'tests': ['tsvgx', 02:10:40 INFO - 'tsvgr_opacity', 02:10:40 INFO - 'tart', 02:10:40 INFO - 'tscrollx', 02:10:40 INFO - 'cart']}, 02:10:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:10:40 INFO - 'tsvgr_opacity', 02:10:40 INFO - 'tart', 02:10:40 INFO - 'tscrollx', 02:10:40 INFO - 'cart']}, 02:10:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:40 INFO - 'talos_options': ['--disable-e10s'], 02:10:40 INFO - 'tests': ['tp5o']}, 02:10:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:40 INFO - 'tests': ['tp5o']}, 02:10:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:40 INFO - 'talos_options': ['--disable-e10s', 02:10:40 INFO - '--xperf_path', 02:10:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:40 INFO - 'tests': ['tp5n']}, 02:10:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:40 INFO - 'talos_options': ['--xperf_path', 02:10:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:40 INFO - 'tests': ['tp5n']}}, 02:10:40 INFO - 'talos.zip': {'path': '', 02:10:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:10:40 INFO - Running post-action listener: _resource_record_post_action 02:10:40 INFO - ##### 02:10:40 INFO - ##### Running create-virtualenv step. 02:10:40 INFO - ##### 02:10:40 INFO - Running pre-action listener: _resource_record_pre_action 02:10:40 INFO - Running main action method: create_virtualenv 02:10:40 INFO - Creating virtualenv /builds/slave/test/build/venv 02:10:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:10:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:10:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:10:40 INFO - Using real prefix '/usr' 02:10:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:10:41 INFO - Installing distribute.............................................................................................................................................................................................done. 02:10:43 INFO - Installing pip.................done. 02:10:43 INFO - Return code: 0 02:10:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe580b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797410>, '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 0x2798310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:10:43 INFO - Using env: {'DISPLAY': ':0', 02:10:43 INFO - 'HOME': '/home/cltbld', 02:10:43 INFO - 'LANG': 'en_US.UTF-8', 02:10:43 INFO - 'LANGUAGE': 'en_US:en', 02:10:43 INFO - 'LOGNAME': 'cltbld', 02:10:43 INFO - 'MAIL': '/var/mail/cltbld', 02:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:43 INFO - 'MOZ_NO_REMOTE': '1', 02:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:43 INFO - 'NO_EM_RESTART': '1', 02:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:43 INFO - 'PWD': '/builds/slave/test', 02:10:43 INFO - 'SHELL': '/bin/bash', 02:10:43 INFO - 'SHLVL': '1', 02:10:43 INFO - 'TERM': 'linux', 02:10:43 INFO - 'TMOUT': '86400', 02:10:43 INFO - 'USER': 'cltbld', 02:10:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 02:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:43 INFO - '_': '/tools/buildbot/bin/python'} 02:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:10:43 INFO - Cleaning up... 02:10:43 INFO - Return code: 0 02:10:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe580b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797410>, '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 0x2798310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:10:43 INFO - Using env: {'DISPLAY': ':0', 02:10:43 INFO - 'HOME': '/home/cltbld', 02:10:43 INFO - 'LANG': 'en_US.UTF-8', 02:10:43 INFO - 'LANGUAGE': 'en_US:en', 02:10:43 INFO - 'LOGNAME': 'cltbld', 02:10:43 INFO - 'MAIL': '/var/mail/cltbld', 02:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:43 INFO - 'MOZ_NO_REMOTE': '1', 02:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:43 INFO - 'NO_EM_RESTART': '1', 02:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:43 INFO - 'PWD': '/builds/slave/test', 02:10:43 INFO - 'SHELL': '/bin/bash', 02:10:43 INFO - 'SHLVL': '1', 02:10:43 INFO - 'TERM': 'linux', 02:10:43 INFO - 'TMOUT': '86400', 02:10:43 INFO - 'USER': 'cltbld', 02:10:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 02:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:43 INFO - '_': '/tools/buildbot/bin/python'} 02:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:43 INFO - Downloading/unpacking psutil>=0.7.1 02:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:10:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:45 INFO - Installing collected packages: psutil 02:10:45 INFO - Running setup.py install for psutil 02:10:45 INFO - building 'psutil._psutil_linux' extension 02:10:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:10:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:10:45 INFO - building 'psutil._psutil_posix' extension 02:10:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:10:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:10:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:46 INFO - Successfully installed psutil 02:10:46 INFO - Cleaning up... 02:10:46 INFO - Return code: 0 02:10:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe580b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797410>, '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 0x2798310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:10:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:10:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:10:46 INFO - Using env: {'DISPLAY': ':0', 02:10:46 INFO - 'HOME': '/home/cltbld', 02:10:46 INFO - 'LANG': 'en_US.UTF-8', 02:10:46 INFO - 'LANGUAGE': 'en_US:en', 02:10:46 INFO - 'LOGNAME': 'cltbld', 02:10:46 INFO - 'MAIL': '/var/mail/cltbld', 02:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:46 INFO - 'MOZ_NO_REMOTE': '1', 02:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:46 INFO - 'NO_EM_RESTART': '1', 02:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:46 INFO - 'PWD': '/builds/slave/test', 02:10:46 INFO - 'SHELL': '/bin/bash', 02:10:46 INFO - 'SHLVL': '1', 02:10:46 INFO - 'TERM': 'linux', 02:10:46 INFO - 'TMOUT': '86400', 02:10:46 INFO - 'USER': 'cltbld', 02:10:46 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 02:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:46 INFO - '_': '/tools/buildbot/bin/python'} 02:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:10:48 INFO - Installing collected packages: mozsystemmonitor 02:10:48 INFO - Running setup.py install for mozsystemmonitor 02:10:48 INFO - Successfully installed mozsystemmonitor 02:10:48 INFO - Cleaning up... 02:10:48 INFO - Return code: 0 02:10:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe580b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797410>, '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 0x2798310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:10:48 INFO - Using env: {'DISPLAY': ':0', 02:10:48 INFO - 'HOME': '/home/cltbld', 02:10:48 INFO - 'LANG': 'en_US.UTF-8', 02:10:48 INFO - 'LANGUAGE': 'en_US:en', 02:10:48 INFO - 'LOGNAME': 'cltbld', 02:10:48 INFO - 'MAIL': '/var/mail/cltbld', 02:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:48 INFO - 'MOZ_NO_REMOTE': '1', 02:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:48 INFO - 'NO_EM_RESTART': '1', 02:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:48 INFO - 'PWD': '/builds/slave/test', 02:10:48 INFO - 'SHELL': '/bin/bash', 02:10:48 INFO - 'SHLVL': '1', 02:10:48 INFO - 'TERM': 'linux', 02:10:48 INFO - 'TMOUT': '86400', 02:10:48 INFO - 'USER': 'cltbld', 02:10:48 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 02:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:48 INFO - '_': '/tools/buildbot/bin/python'} 02:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:48 INFO - Downloading/unpacking blobuploader==1.2.4 02:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:50 INFO - Downloading blobuploader-1.2.4.tar.gz 02:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:10:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:10:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:51 INFO - Downloading docopt-0.6.1.tar.gz 02:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:10:51 INFO - Installing collected packages: blobuploader, requests, docopt 02:10:51 INFO - Running setup.py install for blobuploader 02:10:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:10:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:10:51 INFO - Running setup.py install for requests 02:10:51 INFO - Running setup.py install for docopt 02:10:51 INFO - Successfully installed blobuploader requests docopt 02:10:51 INFO - Cleaning up... 02:10:51 INFO - Return code: 0 02:10:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe580b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797410>, '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 0x2798310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:10:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:10:51 INFO - Using env: {'DISPLAY': ':0', 02:10:51 INFO - 'HOME': '/home/cltbld', 02:10:51 INFO - 'LANG': 'en_US.UTF-8', 02:10:51 INFO - 'LANGUAGE': 'en_US:en', 02:10:51 INFO - 'LOGNAME': 'cltbld', 02:10:51 INFO - 'MAIL': '/var/mail/cltbld', 02:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:51 INFO - 'MOZ_NO_REMOTE': '1', 02:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:51 INFO - 'NO_EM_RESTART': '1', 02:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:51 INFO - 'PWD': '/builds/slave/test', 02:10:51 INFO - 'SHELL': '/bin/bash', 02:10:51 INFO - 'SHLVL': '1', 02:10:51 INFO - 'TERM': 'linux', 02:10:51 INFO - 'TMOUT': '86400', 02:10:51 INFO - 'USER': 'cltbld', 02:10:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 02:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:51 INFO - '_': '/tools/buildbot/bin/python'} 02:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:52 INFO - Running setup.py (path:/tmp/pip-h6IUVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:52 INFO - Running setup.py (path:/tmp/pip-5QAgbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:52 INFO - Running setup.py (path:/tmp/pip-Di6jhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:52 INFO - Running setup.py (path:/tmp/pip-pMLlQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:52 INFO - Running setup.py (path:/tmp/pip-VIO4Pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:52 INFO - Running setup.py (path:/tmp/pip-E9gEoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:52 INFO - Running setup.py (path:/tmp/pip-_Qzixz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:52 INFO - Running setup.py (path:/tmp/pip-nDk5rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:52 INFO - Running setup.py (path:/tmp/pip-f6po8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:52 INFO - Running setup.py (path:/tmp/pip-UO_b0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:52 INFO - Running setup.py (path:/tmp/pip-NWGa8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:52 INFO - Running setup.py (path:/tmp/pip-KBk_8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:53 INFO - Running setup.py (path:/tmp/pip-e_etxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:53 INFO - Running setup.py (path:/tmp/pip-DzJgq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:53 INFO - Running setup.py (path:/tmp/pip-WCgGfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:53 INFO - Running setup.py (path:/tmp/pip-O8rYFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:53 INFO - Running setup.py (path:/tmp/pip-67bEAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:10:53 INFO - Running setup.py install for manifestparser 02:10:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:10:53 INFO - Running setup.py install for mozcrash 02:10:53 INFO - Running setup.py install for mozdebug 02:10:53 INFO - Running setup.py install for mozdevice 02:10:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:10:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:10:53 INFO - Running setup.py install for mozfile 02:10:53 INFO - Running setup.py install for mozhttpd 02:10:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Running setup.py install for mozinfo 02:10:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Running setup.py install for mozInstall 02:10:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Running setup.py install for mozleak 02:10:54 INFO - Running setup.py install for mozlog 02:10:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Running setup.py install for moznetwork 02:10:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Running setup.py install for mozprocess 02:10:54 INFO - Running setup.py install for mozprofile 02:10:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Running setup.py install for mozrunner 02:10:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Running setup.py install for mozscreenshot 02:10:54 INFO - Running setup.py install for moztest 02:10:55 INFO - Running setup.py install for mozversion 02:10:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:10:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:10:55 INFO - Cleaning up... 02:10:55 INFO - Return code: 0 02:10:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:55 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 0x7fe580b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797410>, '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 0x2798310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:10:55 INFO - Using env: {'DISPLAY': ':0', 02:10:55 INFO - 'HOME': '/home/cltbld', 02:10:55 INFO - 'LANG': 'en_US.UTF-8', 02:10:55 INFO - 'LANGUAGE': 'en_US:en', 02:10:55 INFO - 'LOGNAME': 'cltbld', 02:10:55 INFO - 'MAIL': '/var/mail/cltbld', 02:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:55 INFO - 'MOZ_NO_REMOTE': '1', 02:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:55 INFO - 'NO_EM_RESTART': '1', 02:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:55 INFO - 'PWD': '/builds/slave/test', 02:10:55 INFO - 'SHELL': '/bin/bash', 02:10:55 INFO - 'SHLVL': '1', 02:10:55 INFO - 'TERM': 'linux', 02:10:55 INFO - 'TMOUT': '86400', 02:10:55 INFO - 'USER': 'cltbld', 02:10:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 02:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:55 INFO - '_': '/tools/buildbot/bin/python'} 02:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:55 INFO - Running setup.py (path:/tmp/pip-xHkkVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:55 INFO - Running setup.py (path:/tmp/pip-jEvXPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:55 INFO - Running setup.py (path:/tmp/pip-VamuZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:55 INFO - Running setup.py (path:/tmp/pip-MBGSjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:55 INFO - Running setup.py (path:/tmp/pip-zoo5S5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:55 INFO - Running setup.py (path:/tmp/pip-KtRiUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:55 INFO - Running setup.py (path:/tmp/pip-FIh54X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:55 INFO - Running setup.py (path:/tmp/pip-qpAbmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:55 INFO - Running setup.py (path:/tmp/pip-csynpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:56 INFO - Running setup.py (path:/tmp/pip-2qfZ0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:56 INFO - Running setup.py (path:/tmp/pip-HKsDL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:56 INFO - Running setup.py (path:/tmp/pip-dxWwQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:56 INFO - Running setup.py (path:/tmp/pip-kLOjPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:56 INFO - Running setup.py (path:/tmp/pip-zQ1WFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:56 INFO - Running setup.py (path:/tmp/pip-38Vfuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:56 INFO - Running setup.py (path:/tmp/pip-vKl4zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:56 INFO - Running setup.py (path:/tmp/pip-tio9nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:10:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:58 INFO - Downloading blessings-1.6.tar.gz 02:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:10:58 INFO - Installing collected packages: blessings 02:10:58 INFO - Running setup.py install for blessings 02:10:58 INFO - Successfully installed blessings 02:10:58 INFO - Cleaning up... 02:10:58 INFO - Return code: 0 02:10:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:10:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:58 INFO - Reading from file tmpfile_stdout 02:10:58 INFO - Current package versions: 02:10:58 INFO - argparse == 1.2.1 02:10:58 INFO - blessings == 1.6 02:10:58 INFO - blobuploader == 1.2.4 02:10:58 INFO - docopt == 0.6.1 02:10:58 INFO - manifestparser == 1.1 02:10:58 INFO - mozInstall == 1.12 02:10:58 INFO - mozcrash == 0.17 02:10:58 INFO - mozdebug == 0.1 02:10:58 INFO - mozdevice == 0.48 02:10:58 INFO - mozfile == 1.2 02:10:58 INFO - mozhttpd == 0.7 02:10:58 INFO - mozinfo == 0.9 02:10:59 INFO - mozleak == 0.1 02:10:59 INFO - mozlog == 3.1 02:10:59 INFO - moznetwork == 0.27 02:10:59 INFO - mozprocess == 0.22 02:10:59 INFO - mozprofile == 0.28 02:10:59 INFO - mozrunner == 6.11 02:10:59 INFO - mozscreenshot == 0.1 02:10:59 INFO - mozsystemmonitor == 0.0 02:10:59 INFO - moztest == 0.7 02:10:59 INFO - mozversion == 1.4 02:10:59 INFO - psutil == 3.1.1 02:10:59 INFO - requests == 1.2.3 02:10:59 INFO - wsgiref == 0.1.2 02:10:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:59 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 0x7fe580b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797410>, '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 0x2798310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:10:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:10:59 INFO - Using env: {'DISPLAY': ':0', 02:10:59 INFO - 'HOME': '/home/cltbld', 02:10:59 INFO - 'LANG': 'en_US.UTF-8', 02:10:59 INFO - 'LANGUAGE': 'en_US:en', 02:10:59 INFO - 'LOGNAME': 'cltbld', 02:10:59 INFO - 'MAIL': '/var/mail/cltbld', 02:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:59 INFO - 'MOZ_NO_REMOTE': '1', 02:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:59 INFO - 'NO_EM_RESTART': '1', 02:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:59 INFO - 'PWD': '/builds/slave/test', 02:10:59 INFO - 'SHELL': '/bin/bash', 02:10:59 INFO - 'SHLVL': '1', 02:10:59 INFO - 'TERM': 'linux', 02:10:59 INFO - 'TMOUT': '86400', 02:10:59 INFO - 'USER': 'cltbld', 02:10:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 02:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:59 INFO - '_': '/tools/buildbot/bin/python'} 02:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:10:59 INFO - Cleaning up... 02:10:59 INFO - Return code: 0 02:10:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe580b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797410>, '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 0x2798310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:10:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:10:59 INFO - Using env: {'DISPLAY': ':0', 02:10:59 INFO - 'HOME': '/home/cltbld', 02:10:59 INFO - 'LANG': 'en_US.UTF-8', 02:10:59 INFO - 'LANGUAGE': 'en_US:en', 02:10:59 INFO - 'LOGNAME': 'cltbld', 02:10:59 INFO - 'MAIL': '/var/mail/cltbld', 02:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:59 INFO - 'MOZ_NO_REMOTE': '1', 02:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:59 INFO - 'NO_EM_RESTART': '1', 02:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:59 INFO - 'PWD': '/builds/slave/test', 02:10:59 INFO - 'SHELL': '/bin/bash', 02:10:59 INFO - 'SHLVL': '1', 02:10:59 INFO - 'TERM': 'linux', 02:10:59 INFO - 'TMOUT': '86400', 02:10:59 INFO - 'USER': 'cltbld', 02:10:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 02:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:59 INFO - '_': '/tools/buildbot/bin/python'} 02:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:59 INFO - Downloading/unpacking jsonschema 02:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:11:01 INFO - Downloading/unpacking functools32 (from jsonschema) 02:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:01 INFO - Downloading functools32-3.2.3-2.tar.gz 02:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:11:01 INFO - warning: no files found matching '*.txt' 02:11:01 INFO - no previously-included directories found matching 'build' 02:11:01 INFO - no previously-included directories found matching 'dist' 02:11:01 INFO - no previously-included directories found matching '.git*' 02:11:01 INFO - Installing collected packages: jsonschema, functools32 02:11:01 INFO - Running setup.py install for functools32 02:11:01 INFO - warning: no files found matching '*.txt' 02:11:01 INFO - no previously-included directories found matching 'build' 02:11:01 INFO - no previously-included directories found matching 'dist' 02:11:01 INFO - no previously-included directories found matching '.git*' 02:11:01 INFO - Successfully installed jsonschema functools32 02:11:01 INFO - Cleaning up... 02:11:01 INFO - Return code: 0 02:11:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:01 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 0x7fe580b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797410>, '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 0x2798310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:11:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:11:01 INFO - Using env: {'DISPLAY': ':0', 02:11:01 INFO - 'HOME': '/home/cltbld', 02:11:01 INFO - 'LANG': 'en_US.UTF-8', 02:11:01 INFO - 'LANGUAGE': 'en_US:en', 02:11:01 INFO - 'LOGNAME': 'cltbld', 02:11:01 INFO - 'MAIL': '/var/mail/cltbld', 02:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:01 INFO - 'MOZ_NO_REMOTE': '1', 02:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:01 INFO - 'NO_EM_RESTART': '1', 02:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:01 INFO - 'PWD': '/builds/slave/test', 02:11:01 INFO - 'SHELL': '/bin/bash', 02:11:01 INFO - 'SHLVL': '1', 02:11:01 INFO - 'TERM': 'linux', 02:11:01 INFO - 'TMOUT': '86400', 02:11:01 INFO - 'USER': 'cltbld', 02:11:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 02:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:01 INFO - '_': '/tools/buildbot/bin/python'} 02:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:01 INFO - Downloading/unpacking flake8 02:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:11:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:11:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:11:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:11:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:11:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:11:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:11:04 INFO - no previously-included directories found matching 'docs/_build' 02:11:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:11:04 INFO - Running setup.py install for pep8 02:11:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:11:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:11:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:11:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:11:04 INFO - no previously-included directories found matching 'docs/_build' 02:11:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:11:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:11:04 INFO - Cleaning up... 02:11:05 INFO - Return code: 0 02:11:05 INFO - Running post-action listener: _resource_record_post_action 02:11:05 INFO - Running post-action listener: _start_resource_monitoring 02:11:05 INFO - Starting resource monitoring. 02:11:05 INFO - ##### 02:11:05 INFO - ##### Running install step. 02:11:05 INFO - ##### 02:11:05 INFO - Running pre-action listener: _resource_record_pre_action 02:11:05 INFO - Running main action method: install 02:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:11:05 INFO - Reading from file tmpfile_stdout 02:11:05 INFO - Detecting whether we're running mozinstall >=1.0... 02:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:11:05 INFO - Reading from file tmpfile_stdout 02:11:05 INFO - Output received: 02:11:05 INFO - Usage: mozinstall [options] installer 02:11:05 INFO - Options: 02:11:05 INFO - -h, --help show this help message and exit 02:11:05 INFO - -d DEST, --destination=DEST 02:11:05 INFO - Directory to install application into. [default: 02:11:05 INFO - "/builds/slave/test"] 02:11:05 INFO - --app=APP Application being installed. [default: firefox] 02:11:05 INFO - mkdir: /builds/slave/test/build/application 02:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:11:18 INFO - Reading from file tmpfile_stdout 02:11:18 INFO - Output received: 02:11:18 INFO - /builds/slave/test/build/application/firefox/firefox 02:11:18 INFO - Running post-action listener: _resource_record_post_action 02:11:18 INFO - ##### 02:11:18 INFO - ##### Running run-tests step. 02:11:18 INFO - ##### 02:11:18 INFO - Running pre-action listener: _resource_record_pre_action 02:11:18 INFO - Running main action method: run_tests 02:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:11:18 INFO - Python 2.7.3 02:11:18 INFO - Return code: 0 02:11:18 INFO - grabbing minidump binary from tooltool 02:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797410>, '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 0x2798310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27987a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:11:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:11:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:11:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:11:18 INFO - Return code: 0 02:11:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:11:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:11:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:11:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:11:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:11:19 INFO - Return code: 0 02:11:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:11:19 INFO - Using env: {'DISPLAY': ':0', 02:11:19 INFO - 'HOME': '/home/cltbld', 02:11:19 INFO - 'LANG': 'en_US.UTF-8', 02:11:19 INFO - 'LANGUAGE': 'en_US:en', 02:11:19 INFO - 'LOGNAME': 'cltbld', 02:11:19 INFO - 'MAIL': '/var/mail/cltbld', 02:11:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:11:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:19 INFO - 'MOZ_NO_REMOTE': '1', 02:11:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:19 INFO - 'NO_EM_RESTART': '1', 02:11:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:19 INFO - 'PWD': '/builds/slave/test', 02:11:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:11:19 INFO - 'SHELL': '/bin/bash', 02:11:19 INFO - 'SHLVL': '1', 02:11:19 INFO - 'TERM': 'linux', 02:11:19 INFO - 'TMOUT': '86400', 02:11:19 INFO - 'USER': 'cltbld', 02:11:19 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097', 02:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:19 INFO - '_': '/tools/buildbot/bin/python'} 02:11:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:11:19 INFO - mozversion application_buildid: 20160606194329 02:11:19 INFO - mozversion application_changeset: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d 02:11:19 INFO - mozversion application_display_name: Firefox 02:11:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:11:19 INFO - mozversion application_name: Firefox 02:11:19 INFO - mozversion application_remotingname: firefox 02:11:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:11:19 INFO - mozversion application_vendor: Mozilla 02:11:19 INFO - mozversion application_version: 48.0 02:11:19 INFO - mozversion platform_buildid: 20160606194329 02:11:19 INFO - mozversion platform_changeset: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d 02:11:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:11:19 INFO - mozversion platform_version: 48.0 02:11:19 INFO - using testdate: 1465290679 02:11:19 INFO - actual date: 1465290679 02:11:19 INFO - starting webserver on 'localhost:46516' 02:11:19 INFO - SUITE-START | Running 2 tests 02:11:19 INFO - TEST-START | dromaeo_css 02:11:19 INFO - operating with platform_type : linux_ 02:11:19 INFO - Initialising browser for dromaeo_css test... 02:11:19 INFO - TEST-INFO | started process 11775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMTZZdq/profile http://localhost:46516/getInfo.html) 02:11:23 INFO - PROCESS | 11775 | 02:11:23 INFO - PROCESS | 11775 | (process:11851): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:11:24 INFO - PROCESS | 11775 | __metrics Screen width/height:1600/1200 02:11:24 INFO - PROCESS | 11775 | colorDepth:24 02:11:24 INFO - PROCESS | 11775 | Browser inner width/height: 1024/697 02:11:24 INFO - PROCESS | 11775 | __metrics 02:11:25 ERROR - PROCESS | 11775 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 02:11:25 INFO - TEST-INFO | 11775: exit 0 02:11:25 INFO - Browser initialized. 02:11:25 INFO - Running cycle 1/1 for dromaeo_css test... 02:11:25 INFO - TEST-INFO | started process 11902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMTZZdq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:27 INFO - PROCESS | 11902 | 02:11:27 INFO - PROCESS | 11902 | (process:11971): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:11:37 INFO - PROCESS | 11902 | RSS: Main: 151199744 02:11:37 INFO - PROCESS | 11902 | 02:12:27 INFO - PROCESS | 11902 | 1465290747354 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:14:34 INFO - PROCESS | 11902 | Cycle 1(1): loaded http://localhost:46516/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46516/tests/dromaeo/cssquery-ext.html) 02:14:35 INFO - PROCESS | 11902 | RSS: Main: 155934720 02:14:35 INFO - PROCESS | 11902 | 02:17:37 INFO - PROCESS | 11902 | Cycle 1(1): loaded http://localhost:46516/tests/dromaeo/cssquery-ext.html (next: http://localhost:46516/tests/dromaeo/cssquery-jquery.html) 02:17:38 INFO - PROCESS | 11902 | RSS: Main: 153010176 02:17:38 INFO - PROCESS | 11902 | 02:20:39 INFO - PROCESS | 11902 | Cycle 1(1): loaded http://localhost:46516/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46516/tests/dromaeo/cssquery-mootools.html) 02:20:40 INFO - PROCESS | 11902 | RSS: Main: 152416256 02:20:40 INFO - PROCESS | 11902 | 02:23:41 INFO - PROCESS | 11902 | Cycle 1(1): loaded http://localhost:46516/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46516/tests/dromaeo/cssquery-prototype.html) 02:23:42 INFO - PROCESS | 11902 | RSS: Main: 153841664 02:23:42 INFO - PROCESS | 11902 | 02:26:44 INFO - PROCESS | 11902 | Cycle 1(1): loaded http://localhost:46516/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46516/tests/dromaeo/cssquery-yui.html) 02:26:45 INFO - PROCESS | 11902 | RSS: Main: 152383488 02:26:45 INFO - PROCESS | 11902 | 02:29:47 INFO - PROCESS | 11902 | Cycle 1(1): loaded http://localhost:46516/tests/dromaeo/cssquery-yui.html (next: http://localhost:46516/tests/dromaeo/cssquery-dojo.html) 02:29:47 INFO - PROCESS | 11902 | RSS: Main: 156205056 02:29:47 INFO - PROCESS | 11902 | 02:29:47 INFO - PROCESS | 11902 | __start_tp_report 02:29:47 INFO - PROCESS | 11902 | _x_x_mozilla_page_load 02:29:47 INFO - PROCESS | 11902 | _x_x_mozilla_page_load_details 02:29:47 INFO - PROCESS | 11902 | |i|pagename|runs| 02:29:47 INFO - PROCESS | 11902 | |0;dojo.html;3324.069260607031;3335.6997870191685;3338.365710515002;3365.983170084149;3374.544436501073;5709.200711900332;5711.086226203808;5712.828615141542;5723.656580605167;5741.138829175626;5677.9716101419535;5727.971360143193;5733.655980641164;5734.541236701064;5746.0806270996645;5162.251473536335;5172.12073947428;5209.088409528336;5252;5258.526732594066;5162.354705661793;5219.478052194788;5346.946530534703;5348.759305831247;5350.598705097113;5184.818531351403;5224.686518808865;5241.9213711794355;5243.895122097556;5309.097453432925;5121.052605268019;5122.897542049175;5137.255098010804;5148.382194136709;5168.457311982263;4865;5038.319826823368;5045.697258164522;5110.8466745997675;5122.436531981479;5504.779808807642;5505.724713764296;5524.723763811833;5545.916811247795;5570.470805273492;6028.638281703112;6043.939560604382;6063.636181829104;6076.696165191723;6077.270727512727;5828.708564571754;6050.27396712393;6103.389661033861;6109.725062372204;6121.846953826145;5588.692621905793;5590.468905453975;5591.524720398771;5595.692236926968;5622.49397554218;6105.267367915879;6110.297315808739;6112.541559383064;6119.204503414528;6119.663418512025;5821.068629019422;5862.560307976919;5992.820215393545;6032.366601506867;6083.7870674526175;5973.940260597426;5979.760809567656;5986.790462333797;5991.071383935497;5997.640141591519;5877.500412464989;5893.057110862327;5931.822045338647;5962.940370596325;5965.940340596625;5907.734151963172;6005.399460054047;6074.3925607438905;6077.270727512639;6105.572609917352;4580.88547786308;4600.746958917225;4605.263157894788;4626.259798432235;4633.397658304399;4063.146739184804;4119.464469618991;4119.876403707894;4141.399497072907;4161.750294982311;5652.378238393773;5812.389699081536;5829.358770535323;5878.059510478303;5915.349311575723;6162.661053642003;6186.133941248228;6199.3490683477585;6208.161898143783;6221.035739460301;5651.773929042874;5932.614380065282;5947.821565353046;5953.136795164677;6007.789727359522;4944.060628480577;4976.154053810861;5015.398152221684;5016.573591244785;5041.59667226621;6345.777897773556;6372.522060845455;6397.26431460388;6408.455281301141;6425.839354016187;6043;6134.987697083657;6150.969245153656;6156.26124865019;6163.537734669828;6395.136656551492;6397.392247736458;6463.095166676575;6464.191976003;6466.482681385572;6013.849653758691;6046;6082.178905847654;6084.452399284086;6089.69551522431;5911.438413350725;6034.577579569564;6119.173911521888;6165.290991536031;6199.969000154971;5767.826965191051;5816.82549523515;5821.039528477754;5834.883302333845;5879.529637629065;5822.505087067647;5824.796132135355;5826.82519524415;5834.737436815439;5853.560982926383;5764.59647824665;5802.47777700009;5865.442782935615;5927.40725927421;5991.580589358703;6052.818415447544;6065.787697430569;6069.241344831896;6099.725512351866;6102.542309326907;5876.3536011039605;5912.556558258234;5924.703764811656;5935.970320148372;5949.077892926603 02:29:47 INFO - PROCESS | 11902 | |1;ext.html;648.8183308673573;671.4695390641393;687.2852233676975;729.8722723523385;746.6826598695553;40366;41236.38145427817;41421;41434;41445.79277103618;44039.55960440395;44368;44370.112597748026;44532.3320150198;44561.108777824425;8880.822383552326;9025.729228123168;9027.954860225722;9080.137386948229;9088.182063614273;8828;8938.061503542132;8950.731478055668;8950.820983580325;8951.776205594848;9207.309451791109;9217.861732074025;9248.445093294424;9270.768230794216;9277.211437027827;9105.043970383114;9142.177204051668;9147.039560846115;9148.908510914873;9194.632214711404;9137.543122843897;9211.40125891815;9212.769680757967;9221.723348299562;9251;44129.11741765179;44575.77712111451;44728.3290750639;44852;44856.775716121534;3861.6910647148443;3862.9613703862883;3933.8623148189677;4077.5718549552166;4224.4508213931995;32829.507557386656;33153.50269745956;33427.49858752121;33584;33721;4502.459704835408;4618.35343051973;4664.13713463007;4700.929486057712;4725.31482934976;319883;320337;320490;320959;322978;62922.37077629257;63022.16400261999;63486.682566586875;63521;63638;72515.63742181256;73421;73740.63129684317;73927;74117;17164.828351716573;17272;17308.91345543264;17316.65366692659;17328.82671173272;12224.1443098984;12260.570880019335;12285.815712764315;12291.07816913735;12322.075844311712;21106.155753769985;21217.469563260733;21339.57320853574;21371.252006179708;21436.892815535823;7947.165547617533;7969.481983671043;8050.59747012647;8108.135128920381;8172.141925097898;1135.7444574970566;1155.572438197872;1215.3558613934629;1228.1832581333313;1283.018490854497;33616.327673446394;33661.65612472629;33666.49500257498;33811.4928276076;33872;1205.2166092040245;1212.1514939542355;1257.5535684831752;1297.5004623220127;1333.919964802115;17523;17892;18008.279668813102;18144.909275453803;18154.54613634643;519095;528231;543709;553597;571513;58346;59231.703841480514;59367;59380;59401;1540.8151021877447;1545.0412460138932;1556.8053993250844;1566.2090644224822;1581.9446319378767;32354.676453235166;33252.50121248135;33684.66315336913;34090;34662.65337346695;55439.44560554504;55965.16052259138;56258.71870640621;56428.7178564121;56492.45783939815;472960;474866;475054;475270;479858;30855.845720771253;31233.531497027107;31694.683053169174;31824.52263216007;31869.521957170196;50397.24404134014;50515.74742126413;51090.744546277034;51348;51671.224931626806;42693.57306426896;42824.57175428206;43597.782011089745;43797.34303985379;44244.55755442404;42169.57830421779;42657.78671106625;43060.56939430691;43565.56434435615;43813.78093109514;43922.560774393125;43932.34101488544;44654.77672611746;44807.10385792331;45064;36557.817210913774;36695.08262293464;36837.26325473529;37331.626683732815;37675.2464950694;29435.705642943296;29803.85098074496;29863.552046718884;29959.400811984073;30127.397452051275 02:29:47 INFO - PROCESS | 11902 | |2;jquery.html;401.8834537983985;411.2084237842153;411.5246889842233;415.99376009359867;418.8304582263872;18514.907425462872;18668.06659667018;19078.523036924085;19318.806811931878;19320.516987075312;20006.799932000675;20236.29172978946;20370.59258814823;21103.050362733677;21119.472013199676;5641.576881733876;5642.802501912434;5891.793787217448;5915.260592425947;5920.378360272174;5761.9135712964335;5848.532117430616;5849.766009359641;5878.470937615613;5888.911666324987;5643.6049476536655;5818.359980402152;5847.649141051551;5854.824355269348;5864.032434648278;5750.712464376807;5765.365809760923;5780.797672081478;5780.971095144519;5782.335031471372;5141.331626888481;5175.844724658266;5187.19598462239;5206.713630750307;5219.269302297681;23379.532409351887;23742.762572374228;24097.277081687404;24148.63777043346;24245.757542424526;2513.6983561972497;2691.044679138897;2905.5496398058335;2939.1623387334507;3289.7203737682325;9784.11942925133;10320.225983051301;10436.79126417475;14629.341679624442;15584.298706558233;1966.3707613563665;2042.1218875883364;2118.8940552972444;2134.6050980568643;2145.281330754199;63094;70582.99999999949;71338;82703.58648206781;84868.57565712131;10382;10442.425666588411;11142.944285278521;11211.439428028565;11260;15548.22258887051;15816.683666326839;15818.60453488649;15825.287862046236;15842.683146337009;8253.669853205925;8486.575671216415;8488.448250863674;8586.484810911365;8615.827683446421;8094.838103237902;8460.576971151419;8512.957435212784;8516.659333626585;8563.657453701906;4563.201439748031;4739.573438390561;4774.665773395829;4803.135435621622;4901.632377571696;1967.8524110691756;2013.7281467001767;2032.4106009257446;2045.509077821312;2052.8049835265624;1063.9361638301727;1069.534752382716;1115.6987613344352;1146.4382452598334;1162.6279590530949;19087.2365105397;19239.422817315502;19334.226630934885;19724.30964916221;19792.01039947997;1080.9459527023616;1088.894771806617;1097.8517900083546;1117.754094099297;1141.1156353825852;10807.83788243177;11109.112350342839;11153.94423027896;11208.47626037927;11227.66317010491;529964;534577;539803;542870;545461;93608;97184;97970;98069;105071.4746426263;1110.1507346879644;1138.203257719583;1141.3380239461092;1147.9655610331704;1152.7175841918615;17433.128343583023;18056.729149063038;18086;18153;18347.541311466786;40105;41024.58975410327;41147.7942610285;41216.79391603143;42248.57751422447;61832.69083654553;62174;62279.06581401373;62836.37163628305;63255.683721581096;8019.599020048858;8307.958460207661;8308.376871734765;8361.540115293717;8561.400701951054;9165.633374665205;9725.756856078655;10087.00516437087;12632.242065475733;14172.43310267619;12559.120861539604;12666.430010649727;12875.678108047;12935;13103.803442948554;11999.820002699791;12171.878281217429;12352.444140013542;12509.687257818627;12881.549145779853;12565.434555444845;12797.744045119232;12842.67893302675;12943;13177.143485673401;8856.512891791013;9054.139856713602;9073.863892041756;9228.907710923073;9277.16505514507;12712.74574508523;12760.617181484571;12811.487540498276;12888.162269452456;13101.737965240833 02:29:47 INFO - PROCESS | 11902 | |3;mootools.html;1598.8561029507343;1608.5656872644386;1814.628001259742;1905.6188762247536;1919.1267973072245;7595;8224.588770561462;8375.455595386296;8384.413091083627;8531.744047678563;8484.533350665712;8589.09814469481;8662.610182541785;8665.17680820321;8670.479771213715;2407.2176542623674;2410.3251089694913;2434.610462326028;2436.0864675746593;2441.8168637352182;2367.490989437271;2383.285014495644;2423.6001059825107;2443.8778061096964;2458.1887976967646;2431.720352159498;2437.317551085699;2451.2768733223743;2468.148488771371;2472.110040385469;2415.903363865443;2416.891239894209;2429.125514814665;2447.1068060158004;2451.669024681663;2344.284993077111;2357.10430036585;2359.10354065454;2365.621500559902;2376.097083108425;8588.69939552119;8625.568721563897;8635;8665.306775457948;8685.609147588373;5263.078961181816;5356.758945847446;5370.43610420904;5380.219868119101;5387;3528.700060494861;3529.594096678889;3529.6293889141784;3606.7114630829733;3691.575468821093;1114.4260705736551;1126.6901602059418;1146.7362506623524;1172.2790483852455;1178.1281851429965;12090.939545302304;12140.696482587917;12144.3320617366;12157.392130393446;12171.878281217163;4565.885852853705;4612.74629895359;4614.238650622677;4622.607078398307;4647.976760116246;10411.479426028669;10416.947915260374;10431.895681043245;10433.16534677224;10466.21503387249;5342.679439233659;5348.893022139536;5406.999705054577;5411.02601531728;5420.322459692538;4775.808967641256;4876.829310974099;4881.219004959189;4923.359963204761;4938.333325001151;3753.343164946178;3822.50307460034;3823.9426408603895;3868.5551161616213;3888.6111388860886;1138.7665528566624;1142.0349804415255;1157.346099453806;1166.5042356998242;1193.5345215366015;1061.9946900265604;1069.1126365116934;1069.4973362519604;1075.6611667324767;1084.9783004340027;6083.543734219951;6129.754809807647;6165.568410211242;6183.659898705614;6223.875522489616;470.6117453101205;473.637667184604;476.6972972162632;482.67660667352254;485.4805358266621;4054.2702313583836;4055.7769322687536;4125.133721918371;4127.484064491939;4128.979355103205;10090.49547522621;10266.384016958857;10311.1235544978;10393;10411;10225.130863876653;10241.641542546124;10271.7432064199;10280.07479326864;10332.380057196593;7599.354054905284;7768.300852923264;7831.725889593837;8100.756977290691;8137.79655508617;6001;6003.939960600513;6049.153118563493;6066.910205747361;6164.599301045418;9430.151286384258;9560.713178604654;9700.514974251118;9706.320557560903;9714.951425242829;9505.42967421957;9576.712698618774;9735.269854761063;9745.561449734922;9936;7143.964280178566;7193.892091618734;7247.456440767069;7612.695492180251;7821.217878212134;7852.764417067498;7923.049234091715;7925.841483170419;7955.403344749051;7978.0825205102155;7042.295770422917;7262.3826974707745;7294.562326260441;7348.412127029718;7365.447591430771;7083.114610673666;7107.573545587281;7154.892676609751;7175.067241258603;7217.4586905983315;6512.479001679949;6538.1500404947055;6538.574992625464;6554.508411869034;6579.96710016466;5111.182210846247;5187.481251874782;5199.142141546754;5241.31862857826;5245.396779370269;5175.197844334134;5240.34495688039;5256.579473642023;5260.500252476008;5299.364076310713 02:29:47 INFO - PROCESS | 11902 | |4;prototype.html;319.436195115621;333.7080054951917;335.72302850148634;336.20822961924665;340.1106107528813;6556.770513032045;6560.803175904719;6684.699188536515;6703.76536821212;6743.123393958791;6546.279909209983;6666.100076489673;6667.666616669159;6692.933070669292;6704.56420332678;4844.539768721975;4866;4869.293952376921;4869.610431165516;4872.9756351218375;4843.079814835188;4862.586680132193;4862.829800956967;4869.561739443449;4876.585490233334;4817.253325734499;4822.276658501218;4823.493533179018;4827.420709514846;4830.879228019293;4703.835365762182;4824.782884770194;4831.106245344605;4840.75796210188;4845.63657725672;4172.91654166918;4187.790610469464;4190.245755763961;4204.873853784391;4205.705600607958;6297.370262973666;6299.244090709099;6323.114763933053;6368.649724265164;6377.234731832164;5620.325560932673;5666.57500687446;5667;5676.687782171979;5692.37383887772;6882.208546017222;6900.7929762107215;6906.205786334585;6906.689198986058;6921.826954326182;4478.3730277760815;4643.628509719214;4663.720176789404;4666.066786642651;4672.556107169813;7224.4942854000765;7267.418606511466;7333.303336183108;7338.816529586749;7345.412367010626;4715.528447155326;4715.882102947454;4720.527947205321;4722.197226471508;4733.692309999908;4761.166795810719;4795.520447955177;4799.112164249625;4800.303955926371;4801.4718380978065;5588.580856435784;5598.44015598445;5655.066913959151;5657.066584013592;5657.632253903483;6845.5550389224545;6963.1296087989;7007.194172670106;7008.369246767714;7009.579425234502;1672.105423598369;1684.5030715938829;1697.1514242878561;1703.4463799265288;1706.931722731077;1071.4428497181423;1076.1337123615408;1083.6911480228098;1086.9293495922739;1094.950727217277;6664.266930637626;6789.762358317435;7020.052292940388;7020.9648951755935;7027.191872934575;7383.593902335316;7394.223606521346;7398.186199518049;7401.444891633149;7401.629918504053;6858.6570671466225;6908.930910690829;6908.9309106909295;6920.619365934922;6931.826704332331;3873.6126387361037;3881.7865017423746;3925.3130702127014;3949.0917089069676;3950.48643676326;7649.120351159577;7666.808329791688;7669.923300767033;7671.079470463468;7685;7426.257374262638;7455.515391499535;7500.212477689873;7502.887456688154;7506.474546781782;7666.195049519832;7682.654280557388;7689.307962283421;7694.923050769421;7705.460617756703;7091.787246382617;7296.598687072262;7308.744193953186;7310.451716121419;7320.718874196888;7066.505344625827;7108;7143.178534468395;7149.14210294768;7150.5352152109945;7625.351845093229;7626.733064342721;7631.732889348847;7636.961815190888;7645.61771911391;4598.4711758146905;4647.488776234679;4647.86056418308;4649.163150632919;4662.347271381941;7147.428205743424;7256.600886951268;7278.818029549304;7284.235155308616;7288.344049035612;7016;7032.5077244592385;7034.085568876013;7038.683259253244;7049.7885063448175;6993.720251189896;7006.229314775473;7014.579125252501;7024.227334993045;7032.12098487689;6889.242183359726;6898.655067246718;6907.6891539881835;6908.3437073477935;6918.308169183041;6921.7231310747;7061.1173603299585;7083.858322833617;7115.964420177866;7124.857502850017;6715.227748808754;6927.861442771217;6933.2026816916705;6943.916824952595;6946.9780645419405 02:29:47 INFO - PROCESS | 11902 | |5;yui.html;899.3434792601405;900.1493588558811;905.194377004466;909.354358405532;915.8397280475915;14784.926075369622;14917.179555124478;14995.625109372257;15093.547193584183;15124.168170750605;14007.509737159202;14070.437182512687;14091.78862317066;14093.71812563748;14095.295235238224;741.5995362504241;889.8576227803553;914.2548822709471;921.1295325917011;921.5023887100991;905.0361365146131;905.1265528764741;909.231699214163;910.1853840812469;910.7358865928873;958.3100167879115;963.3593660215948;963.86987756653;963.9759006024835;964.5177411294353;949.02724707175;949.4635530925005;953.5422996961463;954.1651055326589;955.7323949294208;703.1070540413646;704.5138854190643;704.8907419350008;705.044664479633;707.1196360531171;14750.852491475056;14879.47921822731;14955;14956.102633842005;14974.925125374304;14200.431982720678;14282.57152285433;14345.13929164243;14360.353784079742;14599;12137.878621213851;12197.634070977885;12259.509619615204;12350.197237179555;12465.626031219077;4055.6755459563165;4076.9100894834614;4085.407615895708;4089.795510224477;4161.4382058422025;55297.44702552963;55316;55607;55702.721486392715;55960.72019639916;11292;11349.432528373549;11424.42877856104;11541.653750387502;11763.823542646867;20365;20567.38297851067;20654.690179647318;20742.792572074388;20757.792422075887;8600.913990860012;8704.60829262672;8846;8883.866741998876;8983.101689830964;4718.221493453541;4800.255960326155;4816.109019831342;4986.202207646759;5039.823606173766;3647.3799454092336;3662.0661731258892;3684.1158122050515;3696.5748938872375;3698.4637227602384;665.9200895892524;668.5253470036231;679.6465837764433;702.4520873718508;711.7580022792275;827.3381294964005;829.8008477965366;831.5717405536154;845.809692819123;852.2329903087148;9507.286953478517;9870.851937220947;9982.251331150193;10037.297389182833;10218.897811021943;727.989080163798;736.5580651608992;750.2909750285927;801.5911884938723;841.1588411588411;4504.144212599595;4512.255477846119;4555.749433781108;4601.12578610063;4661.883452913704;69671.65164174249;70161;71650.64174679198;72070;72590.27409725836;58696;59216.703916481005;60229.698851506335;60725.39274607286;60885.69557152186;52149.217761733606;52343.21485177725;52473.7376313116;52888.735556321975;53000.73499632477;8791.07693692153;8948.821023579361;8990.86513702282;9068.546572671208;9281;39382.01544961399;39878;40427.1914561713;40899.795501023495;41332.173356533305;48893.51106489032;50937.49062509476;51415;51510.74244628753;51977.740111300714;11209.43952802373;11344.773104538028;11550.364729939934;11598.362090085126;11859;12936.09447338715;13010.674733131747;13026.348682565644;13187.868121318665;13216.603501894959;11511.942440287745;11629.53481860716;11909.166358354832;12180.147389682637;12622.55821046259;12258.448369823202;12370.81443778362;12493.625191244277;12877.8068328977;12968.610941671765;11712.531498739954;12059.397030148282;12216.938915305367;12551.623451296477;12588.559400420942;9968.850467242852;10021.448820314952;10122.544485498318;10175.135113515435;10248.436336001592;9748.658796942073;9914.752131196778;9937.503124843874;9948.403095814274;10047.447390393598 02:29:47 INFO - PROCESS | 11902 | __end_tp_report 02:29:47 INFO - PROCESS | 11902 | __start_cc_report 02:29:47 INFO - PROCESS | 11902 | _x_x_mozilla_cycle_collect,344 02:29:47 INFO - PROCESS | 11902 | __end_cc_report 02:29:47 INFO - PROCESS | 11902 | __startTimestamp1465291787815__endTimestamp 02:29:47 INFO - PROCESS | 11902 | 02:29:47 INFO - PROCESS | 11902 | ------- Summary: start ------- 02:29:47 INFO - PROCESS | 11902 | Number of tests: 6 02:29:47 INFO - PROCESS | 11902 | 02:29:47 INFO - PROCESS | 11902 | [#0] dojo.html Cycles:165 Average:5643.13 Median:5862.56 stddev:650.58 (11.1%) stddev-sans-first:626.62 02:29:47 INFO - PROCESS | 11902 | Values: 3324.1 3335.7 3338.4 3366.0 3374.5 5709.2 5711.1 5712.8 5723.7 5741.1 5678.0 5728.0 5733.7 5734.5 5746.1 5162.3 5172.1 5209.1 5252.0 5258.5 5162.4 5219.5 5346.9 5348.8 5350.6 5184.8 5224.7 5241.9 5243.9 5309.1 5121.1 5122.9 5137.3 5148.4 5168.5 4865.0 5038.3 5045.7 5110.8 5122.4 5504.8 5505.7 5524.7 5545.9 5570.5 6028.6 6043.9 6063.6 6076.7 6077.3 5828.7 6050.3 6103.4 6109.7 6121.8 5588.7 5590.5 5591.5 5595.7 5622.5 6105.3 6110.3 6112.5 6119.2 6119.7 5821.1 5862.6 5992.8 6032.4 6083.8 5973.9 5979.8 5986.8 5991.1 5997.6 5877.5 5893.1 5931.8 5962.9 5965.9 5907.7 6005.4 6074.4 6077.3 6105.6 4580.9 4600.7 4605.3 4626.3 4633.4 4063.1 4119.5 4119.9 4141.4 4161.8 5652.4 5812.4 5829.4 5878.1 5915.3 6162.7 6186.1 6199.3 6208.2 6221.0 5651.8 5932.6 5947.8 5953.1 6007.8 4944.1 4976.2 5015.4 5016.6 5041.6 6345.8 6372.5 6397.3 6408.5 6425.8 6043.0 6135.0 6151.0 6156.3 6163.5 6395.1 6397.4 6463.1 6464.2 6466.5 6013.8 6046.0 6082.2 6084.5 6089.7 5911.4 6034.6 6119.2 6165.3 6200.0 5767.8 5816.8 5821.0 5834.9 5879.5 5822.5 5824.8 5826.8 5834.7 5853.6 5764.6 5802.5 5865.4 5927.4 5991.6 6052.8 6065.8 6069.2 6099.7 6102.5 5876.4 5912.6 5924.7 5936.0 5949.1 02:29:47 INFO - PROCESS | 11902 | 02:29:47 INFO - PROCESS | 11902 | [#1] ext.html Cycles:180 Average:62189.02 Median:43985.95 stddev:120963.84 (275.0%) stddev-sans-first:121214.93 02:29:47 INFO - PROCESS | 11902 | Values: 648.8 671.5 687.3 729.9 746.7 40366.0 41236.4 41421.0 41434.0 41445.8 44039.6 44368.0 44370.1 44532.3 44561.1 8880.8 9025.7 9028.0 9080.1 9088.2 8828.0 8938.1 8950.7 8950.8 8951.8 9207.3 9217.9 9248.4 9270.8 9277.2 9105.0 9142.2 9147.0 9148.9 9194.6 9137.5 9211.4 9212.8 9221.7 9251.0 44129.1 44575.8 44728.3 44852.0 44856.8 3861.7 3863.0 3933.9 4077.6 4224.5 32829.5 33153.5 33427.5 33584.0 33721.0 4502.5 4618.4 4664.1 4700.9 4725.3 319883.0 320337.0 320490.0 320959.0 322978.0 62922.4 63022.2 63486.7 63521.0 63638.0 72515.6 73421.0 73740.6 73927.0 74117.0 17164.8 17272.0 17308.9 17316.7 17328.8 12224.1 12260.6 12285.8 12291.1 12322.1 21106.2 21217.5 21339.6 21371.3 21436.9 7947.2 7969.5 8050.6 8108.1 8172.1 1135.7 1155.6 1215.4 1228.2 1283.0 33616.3 33661.7 33666.5 33811.5 33872.0 1205.2 1212.2 1257.6 1297.5 1333.9 17523.0 17892.0 18008.3 18144.9 18154.5 519095.0 528231.0 543709.0 553597.0 571513.0 58346.0 59231.7 59367.0 59380.0 59401.0 1540.8 1545.0 1556.8 1566.2 1581.9 32354.7 33252.5 33684.7 34090.0 34662.7 55439.4 55965.2 56258.7 56428.7 56492.5 472960.0 474866.0 475054.0 475270.0 479858.0 30855.8 31233.5 31694.7 31824.5 31869.5 50397.2 50515.7 51090.7 51348.0 51671.2 42693.6 42824.6 43597.8 43797.3 44244.6 42169.6 42657.8 43060.6 43565.6 43813.8 43922.6 43932.3 44654.8 44807.1 45064.0 36557.8 36695.1 36837.3 37331.6 37675.2 29435.7 29803.9 29863.6 29959.4 30127.4 02:29:47 INFO - PROCESS | 11902 | 02:29:47 INFO - PROCESS | 11902 | [#2] jquery.html Cycles:180 Average:30728.02 Median:24122.96 stddev:88587.34 (367.2%) stddev-sans-first:88806.58 02:29:47 INFO - PROCESS | 11902 | Values: 401.9 411.2 411.5 416.0 418.8 18514.9 18668.1 19078.5 19318.8 19320.5 20006.8 20236.3 20370.6 21103.1 21119.5 5641.6 5642.8 5891.8 5915.3 5920.4 5761.9 5848.5 5849.8 5878.5 5888.9 5643.6 5818.4 5847.6 5854.8 5864.0 5750.7 5765.4 5780.8 5781.0 5782.3 5141.3 5175.8 5187.2 5206.7 5219.3 23379.5 23742.8 24097.3 24148.6 24245.8 2513.7 2691.0 2905.5 2939.2 3289.7 9784.1 10320.2 10436.8 14629.3 15584.3 1966.4 2042.1 2118.9 2134.6 2145.3 63094.0 70583.0 71338.0 82703.6 84868.6 10382.0 10442.4 11142.9 11211.4 11260.0 15548.2 15816.7 15818.6 15825.3 15842.7 8253.7 8486.6 8488.4 8586.5 8615.8 8094.8 8460.6 8513.0 8516.7 8563.7 4563.2 4739.6 4774.7 4803.1 4901.6 1967.9 2013.7 2032.4 2045.5 2052.8 1063.9 1069.5 1115.7 1146.4 1162.6 19087.2 19239.4 19334.2 19724.3 19792.0 1080.9 1088.9 1097.9 1117.8 1141.1 10807.8 11109.1 11153.9 11208.5 11227.7 529964.0 534577.0 539803.0 542870.0 545461.0 93608.0 97184.0 97970.0 98069.0 105071.5 1110.2 1138.2 1141.3 1148.0 1152.7 17433.1 18056.7 18086.0 18153.0 18347.5 40105.0 41024.6 41147.8 41216.8 42248.6 61832.7 62174.0 62279.1 62836.4 63255.7 8019.6 8308.0 8308.4 8361.5 8561.4 9165.6 9725.8 10087.0 12632.2 14172.4 12559.1 12666.4 12875.7 12935.0 13103.8 11999.8 12171.9 12352.4 12509.7 12881.5 12565.4 12797.7 12842.7 12943.0 13177.1 8856.5 9054.1 9073.9 9228.9 9277.2 12712.7 12760.6 12811.5 12888.2 13101.7 02:29:47 INFO - PROCESS | 11902 | 02:29:47 INFO - PROCESS | 11902 | [#3] mootools.html Cycles:180 Average:5672.69 Median:2681.15 stddev:3134.65 (116.9%) stddev-sans-first:3128.49 02:29:47 INFO - PROCESS | 11902 | Values: 1598.9 1608.6 1814.6 1905.6 1919.1 7595.0 8224.6 8375.5 8384.4 8531.7 8484.5 8589.1 8662.6 8665.2 8670.5 2407.2 2410.3 2434.6 2436.1 2441.8 2367.5 2383.3 2423.6 2443.9 2458.2 2431.7 2437.3 2451.3 2468.1 2472.1 2415.9 2416.9 2429.1 2447.1 2451.7 2344.3 2357.1 2359.1 2365.6 2376.1 8588.7 8625.6 8635.0 8665.3 8685.6 5263.1 5356.8 5370.4 5380.2 5387.0 3528.7 3529.6 3529.6 3606.7 3691.6 1114.4 1126.7 1146.7 1172.3 1178.1 12090.9 12140.7 12144.3 12157.4 12171.9 4565.9 4612.7 4614.2 4622.6 4648.0 10411.5 10416.9 10431.9 10433.2 10466.2 5342.7 5348.9 5407.0 5411.0 5420.3 4775.8 4876.8 4881.2 4923.4 4938.3 3753.3 3822.5 3823.9 3868.6 3888.6 1138.8 1142.0 1157.3 1166.5 1193.5 1062.0 1069.1 1069.5 1075.7 1085.0 6083.5 6129.8 6165.6 6183.7 6223.9 470.6 473.6 476.7 482.7 485.5 4054.3 4055.8 4125.1 4127.5 4129.0 10090.5 10266.4 10311.1 10393.0 10411.0 10225.1 10241.6 10271.7 10280.1 10332.4 7599.4 7768.3 7831.7 8100.8 8137.8 6001.0 6003.9 6049.2 6066.9 6164.6 9430.2 9560.7 9700.5 9706.3 9715.0 9505.4 9576.7 9735.3 9745.6 9936.0 7144.0 7193.9 7247.5 7612.7 7821.2 7852.8 7923.0 7925.8 7955.4 7978.1 7042.3 7262.4 7294.6 7348.4 7365.4 7083.1 7107.6 7154.9 7175.1 7217.5 6512.5 6538.2 6538.6 6554.5 6580.0 5111.2 5187.5 5199.1 5241.3 5245.4 5175.2 5240.3 5256.6 5260.5 5299.4 02:29:47 INFO - PROCESS | 11902 | 02:29:47 INFO - PROCESS | 11902 | [#4] prototype.html Cycles:180 Average:5824.59 Median:6729.18 stddev:1843.33 (27.4%) stddev-sans-first:1801.59 02:29:47 INFO - PROCESS | 11902 | Values: 319.4 333.7 335.7 336.2 340.1 6556.8 6560.8 6684.7 6703.8 6743.1 6546.3 6666.1 6667.7 6692.9 6704.6 4844.5 4866.0 4869.3 4869.6 4873.0 4843.1 4862.6 4862.8 4869.6 4876.6 4817.3 4822.3 4823.5 4827.4 4830.9 4703.8 4824.8 4831.1 4840.8 4845.6 4172.9 4187.8 4190.2 4204.9 4205.7 6297.4 6299.2 6323.1 6368.6 6377.2 5620.3 5666.6 5667.0 5676.7 5692.4 6882.2 6900.8 6906.2 6906.7 6921.8 4478.4 4643.6 4663.7 4666.1 4672.6 7224.5 7267.4 7333.3 7338.8 7345.4 4715.5 4715.9 4720.5 4722.2 4733.7 4761.2 4795.5 4799.1 4800.3 4801.5 5588.6 5598.4 5655.1 5657.1 5657.6 6845.6 6963.1 7007.2 7008.4 7009.6 1672.1 1684.5 1697.2 1703.4 1706.9 1071.4 1076.1 1083.7 1086.9 1095.0 6664.3 6789.8 7020.1 7021.0 7027.2 7383.6 7394.2 7398.2 7401.4 7401.6 6858.7 6908.9 6908.9 6920.6 6931.8 3873.6 3881.8 3925.3 3949.1 3950.5 7649.1 7666.8 7669.9 7671.1 7685.0 7426.3 7455.5 7500.2 7502.9 7506.5 7666.2 7682.7 7689.3 7694.9 7705.5 7091.8 7296.6 7308.7 7310.5 7320.7 7066.5 7108.0 7143.2 7149.1 7150.5 7625.4 7626.7 7631.7 7637.0 7645.6 4598.5 4647.5 4647.9 4649.2 4662.3 7147.4 7256.6 7278.8 7284.2 7288.3 7016.0 7032.5 7034.1 7038.7 7049.8 6993.7 7006.2 7014.6 7024.2 7032.1 6889.2 6898.7 6907.7 6908.3 6918.3 6921.7 7061.1 7083.9 7116.0 7124.9 6715.2 6927.9 6933.2 6943.9 6947.0 02:29:47 INFO - PROCESS | 11902 | 02:29:47 INFO - PROCESS | 11902 | [#5] yui.html Cycles:180 Average:15758.69 Median:26939.86 stddev:18807.58 (69.8%) stddev-sans-first:18827.24 02:29:47 INFO - PROCESS | 11902 | Values: 899.3 900.1 905.2 909.4 915.8 14784.9 14917.2 14995.6 15093.5 15124.2 14007.5 14070.4 14091.8 14093.7 14095.3 741.6 889.9 914.3 921.1 921.5 905.0 905.1 909.2 910.2 910.7 958.3 963.4 963.9 964.0 964.5 949.0 949.5 953.5 954.2 955.7 703.1 704.5 704.9 705.0 707.1 14750.9 14879.5 14955.0 14956.1 14974.9 14200.4 14282.6 14345.1 14360.4 14599.0 12137.9 12197.6 12259.5 12350.2 12465.6 4055.7 4076.9 4085.4 4089.8 4161.4 55297.4 55316.0 55607.0 55702.7 55960.7 11292.0 11349.4 11424.4 11541.7 11763.8 20365.0 20567.4 20654.7 20742.8 20757.8 8600.9 8704.6 8846.0 8883.9 8983.1 4718.2 4800.3 4816.1 4986.2 5039.8 3647.4 3662.1 3684.1 3696.6 3698.5 665.9 668.5 679.6 702.5 711.8 827.3 829.8 831.6 845.8 852.2 9507.3 9870.9 9982.3 10037.3 10218.9 728.0 736.6 750.3 801.6 841.2 4504.1 4512.3 4555.7 4601.1 4661.9 69671.7 70161.0 71650.6 72070.0 72590.3 58696.0 59216.7 60229.7 60725.4 60885.7 52149.2 52343.2 52473.7 52888.7 53000.7 8791.1 8948.8 8990.9 9068.5 9281.0 39382.0 39878.0 40427.2 40899.8 41332.2 48893.5 50937.5 51415.0 51510.7 51977.7 11209.4 11344.8 11550.4 11598.4 11859.0 12936.1 13010.7 13026.3 13187.9 13216.6 11511.9 11629.5 11909.2 12180.1 12622.6 12258.4 12370.8 12493.6 12877.8 12968.6 11712.5 12059.4 12216.9 12551.6 12588.6 9968.9 10021.4 10122.5 10175.1 10248.4 9748.7 9914.8 9937.5 9948.4 10047.4 02:29:47 INFO - PROCESS | 11902 | -------- Summary: end -------- 02:29:47 INFO - PROCESS | 11902 | 02:29:48 INFO - TEST-INFO | 11902: exit 0 02:29:48 INFO - TEST-OK | dromaeo_css | took 1108492ms 02:29:48 INFO - TEST-START | kraken 02:29:48 INFO - operating with platform_type : linux_ 02:29:48 INFO - Initialising browser for kraken test... 02:29:48 INFO - TEST-INFO | started process 12146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd_ADsd/profile http://localhost:46516/getInfo.html) 02:29:52 INFO - PROCESS | 12146 | 02:29:52 INFO - PROCESS | 12146 | (process:12227): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:29:52 INFO - PROCESS | 12146 | __metrics Screen width/height:1600/1200 02:29:52 INFO - PROCESS | 12146 | colorDepth:24 02:29:52 INFO - PROCESS | 12146 | Browser inner width/height: 1024/697 02:29:52 INFO - PROCESS | 12146 | __metrics 02:29:53 ERROR - PROCESS | 12146 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 02:29:54 INFO - TEST-INFO | 12146: exit 0 02:29:54 INFO - Browser initialized. 02:29:54 INFO - Running cycle 1/1 for kraken test... 02:29:54 INFO - TEST-INFO | started process 12277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd_ADsd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:56 INFO - PROCESS | 12277 | 02:29:56 INFO - PROCESS | 12277 | (process:12346): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:30:06 INFO - PROCESS | 12277 | RSS: Main: 151183360 02:30:06 INFO - PROCESS | 12277 | 02:30:08 INFO - PROCESS | 12277 | Cycle 1(1): loaded http://localhost:46516/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46516/tests/kraken/driver.html?testName=audio-beat-detection) 02:30:09 INFO - PROCESS | 12277 | RSS: Main: 156430336 02:30:09 INFO - PROCESS | 12277 | 02:30:12 INFO - PROCESS | 12277 | Cycle 1(1): loaded http://localhost:46516/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46516/tests/kraken/driver.html?testName=audio-dft) 02:30:12 INFO - PROCESS | 12277 | RSS: Main: 156680192 02:30:12 INFO - PROCESS | 12277 | 02:30:15 INFO - PROCESS | 12277 | Cycle 1(1): loaded http://localhost:46516/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46516/tests/kraken/driver.html?testName=audio-fft) 02:30:16 INFO - PROCESS | 12277 | RSS: Main: 156606464 02:30:16 INFO - PROCESS | 12277 | 02:30:18 INFO - PROCESS | 12277 | Cycle 1(1): loaded http://localhost:46516/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46516/tests/kraken/driver.html?testName=audio-oscillator) 02:30:18 INFO - PROCESS | 12277 | RSS: Main: 156639232 02:30:18 INFO - PROCESS | 12277 | 02:30:21 INFO - PROCESS | 12277 | Cycle 1(1): loaded http://localhost:46516/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46516/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:30:21 INFO - PROCESS | 12277 | RSS: Main: 156647424 02:30:21 INFO - PROCESS | 12277 | 02:30:24 INFO - PROCESS | 12277 | Cycle 1(1): loaded http://localhost:46516/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46516/tests/kraken/driver.html?testName=imaging-darkroom) 02:30:25 INFO - PROCESS | 12277 | RSS: Main: 157188096 02:30:25 INFO - PROCESS | 12277 | 02:30:28 INFO - PROCESS | 12277 | Cycle 1(1): loaded http://localhost:46516/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46516/tests/kraken/driver.html?testName=imaging-desaturate) 02:30:29 INFO - PROCESS | 12277 | RSS: Main: 157884416 02:30:29 INFO - PROCESS | 12277 | 02:30:32 INFO - PROCESS | 12277 | Cycle 1(1): loaded http://localhost:46516/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46516/tests/kraken/driver.html?testName=json-parse-financial) 02:30:32 INFO - PROCESS | 12277 | RSS: Main: 157126656 02:30:32 INFO - PROCESS | 12277 | 02:30:34 INFO - PROCESS | 12277 | Cycle 1(1): loaded http://localhost:46516/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46516/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:30:34 INFO - PROCESS | 12277 | RSS: Main: 156921856 02:30:34 INFO - PROCESS | 12277 | 02:30:36 INFO - PROCESS | 12277 | Cycle 1(1): loaded http://localhost:46516/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46516/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:30:37 INFO - PROCESS | 12277 | RSS: Main: 156725248 02:30:37 INFO - PROCESS | 12277 | 02:30:39 INFO - PROCESS | 12277 | Cycle 1(1): loaded http://localhost:46516/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46516/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:30:39 INFO - PROCESS | 12277 | RSS: Main: 157065216 02:30:39 INFO - PROCESS | 12277 | 02:30:42 INFO - PROCESS | 12277 | Cycle 1(1): loaded http://localhost:46516/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:30:42 INFO - PROCESS | 12277 | RSS: Main: 157450240 02:30:42 INFO - PROCESS | 12277 | 02:30:45 INFO - PROCESS | 12277 | Cycle 1(1): loaded http://localhost:46516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:30:46 INFO - PROCESS | 12277 | RSS: Main: 157601792 02:30:46 INFO - PROCESS | 12277 | 02:30:47 INFO - PROCESS | 12277 | Cycle 1(1): loaded http://localhost:46516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46516/tests/kraken/driver.html?testName=ai-astar) 02:30:48 INFO - PROCESS | 12277 | RSS: Main: 158863360 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | __start_tp_report 02:30:48 INFO - PROCESS | 12277 | _x_x_mozilla_page_load 02:30:48 INFO - PROCESS | 12277 | _x_x_mozilla_page_load_details 02:30:48 INFO - PROCESS | 12277 | |i|pagename|runs| 02:30:48 INFO - PROCESS | 12277 | |0;ai-astar;108;110;107;109;111;112;101;110;111;111 02:30:48 INFO - PROCESS | 12277 | |1;audio-beat-detection;152;127;159;181;129;153;153;133;173;126 02:30:48 INFO - PROCESS | 12277 | |2;audio-dft;162;165;161;165;164;162;161;161;164;162 02:30:48 INFO - PROCESS | 12277 | |3;audio-fft;76;76;79;166;76;76;76;76;175;75 02:30:48 INFO - PROCESS | 12277 | |4;audio-oscillator;92;92;161;91;92;93;152;93;91;137 02:30:48 INFO - PROCESS | 12277 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;118;117 02:30:48 INFO - PROCESS | 12277 | |6;imaging-darkroom;147;146;146;146;146;146;148;147;146;151 02:30:48 INFO - PROCESS | 12277 | |7;imaging-desaturate;95;95;96;96;95;95;95;96;95;95 02:30:48 INFO - PROCESS | 12277 | |8;json-parse-financial;53;59;55;56;58;61;55;76;54;57 02:30:48 INFO - PROCESS | 12277 | |9;json-stringify-tinderbox;59;59;59;58;59;59;59;59;59;59 02:30:48 INFO - PROCESS | 12277 | |10;stanford-crypto-aes;80;72;72;74;73;74;82;73;74;75 02:30:48 INFO - PROCESS | 12277 | |11;stanford-crypto-ccm;123;114;122;113;114;114;119;113;128;125 02:30:48 INFO - PROCESS | 12277 | |12;stanford-crypto-pbkdf2;161;159;166;161;162;160;158;159;159;162 02:30:48 INFO - PROCESS | 12277 | |13;stanford-crypto-sha256-iterative;66;67;69;67;67;66;66;70;75;69 02:30:48 INFO - PROCESS | 12277 | __end_tp_report 02:30:48 INFO - PROCESS | 12277 | __start_cc_report 02:30:48 INFO - PROCESS | 12277 | _x_x_mozilla_cycle_collect,829 02:30:48 INFO - PROCESS | 12277 | __end_cc_report 02:30:48 INFO - PROCESS | 12277 | __startTimestamp1465291848120__endTimestamp 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | ------- Summary: start ------- 02:30:48 INFO - PROCESS | 12277 | Number of tests: 14 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.20 (2.9%) stddev-sans-first:3.37 02:30:48 INFO - PROCESS | 12277 | Values: 108.0 110.0 107.0 109.0 111.0 112.0 101.0 110.0 111.0 111.0 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:153.00 stddev:19.46 (12.7%) stddev-sans-first:20.60 02:30:48 INFO - PROCESS | 12277 | Values: 152.0 127.0 159.0 181.0 129.0 153.0 153.0 133.0 173.0 126.0 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.64 (1.0%) stddev-sans-first:1.72 02:30:48 INFO - PROCESS | 12277 | Values: 162.0 165.0 161.0 165.0 164.0 162.0 161.0 161.0 164.0 162.0 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:39.81 (52.4%) stddev-sans-first:41.62 02:30:48 INFO - PROCESS | 12277 | Values: 76.0 76.0 79.0 166.0 76.0 76.0 76.0 76.0 175.0 75.0 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:92.00 stddev:28.60 (31.1%) stddev-sans-first:29.64 02:30:48 INFO - PROCESS | 12277 | Values: 92.0 92.0 161.0 91.0 92.0 93.0 152.0 93.0 91.0 137.0 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:30:48 INFO - PROCESS | 12277 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:146.50 stddev:1.60 (1.1%) stddev-sans-first:1.69 02:30:48 INFO - PROCESS | 12277 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 148.0 147.0 146.0 151.0 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:30:48 INFO - PROCESS | 12277 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:57.50 stddev:6.64 (11.5%) stddev-sans-first:6.75 02:30:48 INFO - PROCESS | 12277 | Values: 53.0 59.0 55.0 56.0 58.0 61.0 55.0 76.0 54.0 57.0 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 02:30:48 INFO - PROCESS | 12277 | Values: 59.0 59.0 59.0 58.0 59.0 59.0 59.0 59.0 59.0 59.0 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.00 stddev:3.38 (4.6%) stddev-sans-first:3.04 02:30:48 INFO - PROCESS | 12277 | Values: 80.0 72.0 72.0 74.0 73.0 74.0 82.0 73.0 74.0 75.0 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:120.50 stddev:5.64 (4.7%) stddev-sans-first:5.74 02:30:48 INFO - PROCESS | 12277 | Values: 123.0 114.0 122.0 113.0 114.0 114.0 119.0 113.0 128.0 125.0 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:161.00 stddev:2.31 (1.4%) stddev-sans-first:2.45 02:30:48 INFO - PROCESS | 12277 | Values: 161.0 159.0 166.0 161.0 162.0 160.0 158.0 159.0 159.0 162.0 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - PROCESS | 12277 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:2.78 (4.1%) stddev-sans-first:2.83 02:30:48 INFO - PROCESS | 12277 | Values: 66.0 67.0 69.0 67.0 67.0 66.0 66.0 70.0 75.0 69.0 02:30:48 INFO - PROCESS | 12277 | -------- Summary: end -------- 02:30:48 INFO - PROCESS | 12277 | 02:30:48 INFO - TEST-INFO | 12277: exit 0 02:30:49 INFO - TEST-OK | kraken | took 60570ms 02:30:49 INFO - SUITE-END | took 1169s 02:30:49 INFO - Completed test suite (00:19:29) 02:30:49 INFO - javascript benchmark 02:30:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3324.069260607031, 3335.6997870191685, 3338.365710515002, 3365.983170084149, 3374.544436501073, 5709.200711900332, 5711.086226203808, 5712.828615141542, 5723.656580605167, 5741.138829175626, 5677.9716101419535, 5727.971360143193, 5733.655980641164, 5734.541236701064, 5746.0806270996645, 5162.251473536335, 5172.12073947428, 5209.088409528336, 5252.0, 5258.526732594066, 5162.354705661793, 5219.478052194788, 5346.946530534703, 5348.759305831247, 5350.598705097113, 5184.818531351403, 5224.686518808865, 5241.9213711794355, 5243.895122097556, 5309.097453432925, 5121.052605268019, 5122.897542049175, 5137.255098010804, 5148.382194136709, 5168.457311982263, 4865.0, 5038.319826823368, 5045.697258164522, 5110.8466745997675, 5122.436531981479, 5504.779808807642, 5505.724713764296, 5524.723763811833, 5545.916811247795, 5570.470805273492, 6028.638281703112, 6043.939560604382, 6063.636181829104, 6076.696165191723, 6077.270727512727, 5828.708564571754, 6050.27396712393, 6103.389661033861, 6109.725062372204, 6121.846953826145, 5588.692621905793, 5590.468905453975, 5591.524720398771, 5595.692236926968, 5622.49397554218, 6105.267367915879, 6110.297315808739, 6112.541559383064, 6119.204503414528, 6119.663418512025, 5821.068629019422, 5862.560307976919, 5992.820215393545, 6032.366601506867, 6083.7870674526175, 5973.940260597426, 5979.760809567656, 5986.790462333797, 5991.071383935497, 5997.640141591519, 5877.500412464989, 5893.057110862327, 5931.822045338647, 5962.940370596325, 5965.940340596625, 5907.734151963172, 6005.399460054047, 6074.3925607438905, 6077.270727512639, 6105.572609917352, 4580.88547786308, 4600.746958917225, 4605.263157894788, 4626.259798432235, 4633.397658304399, 4063.146739184804, 4119.464469618991, 4119.876403707894, 4141.399497072907, 4161.750294982311, 5652.378238393773, 5812.389699081536, 5829.358770535323, 5878.059510478303, 5915.349311575723, 6162.661053642003, 6186.133941248228, 6199.3490683477585, 6208.161898143783, 6221.035739460301, 5651.773929042874, 5932.614380065282, 5947.821565353046, 5953.136795164677, 6007.789727359522, 4944.060628480577, 4976.154053810861, 5015.398152221684, 5016.573591244785, 5041.59667226621, 6345.777897773556, 6372.522060845455, 6397.26431460388, 6408.455281301141, 6425.839354016187, 6043.0, 6134.987697083657, 6150.969245153656, 6156.26124865019, 6163.537734669828, 6395.136656551492, 6397.392247736458, 6463.095166676575, 6464.191976003, 6466.482681385572, 6013.849653758691, 6046.0, 6082.178905847654, 6084.452399284086, 6089.69551522431, 5911.438413350725, 6034.577579569564, 6119.173911521888, 6165.290991536031, 6199.969000154971, 5767.826965191051, 5816.82549523515, 5821.039528477754, 5834.883302333845, 5879.529637629065, 5822.505087067647, 5824.796132135355, 5826.82519524415, 5834.737436815439, 5853.560982926383, 5764.59647824665, 5802.47777700009, 5865.442782935615, 5927.40725927421, 5991.580589358703, 6052.818415447544, 6065.787697430569, 6069.241344831896, 6099.725512351866, 6102.542309326907, 5876.3536011039605, 5912.556558258234, 5924.703764811656, 5935.970320148372, 5949.077892926603], "value": 5599.192488088886, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.8183308673573, 671.4695390641393, 687.2852233676975, 729.8722723523385, 746.6826598695553, 40366.0, 41236.38145427817, 41421.0, 41434.0, 41445.79277103618, 44039.55960440395, 44368.0, 44370.112597748026, 44532.3320150198, 44561.108777824425, 8880.822383552326, 9025.729228123168, 9027.954860225722, 9080.137386948229, 9088.182063614273, 8828.0, 8938.061503542132, 8950.731478055668, 8950.820983580325, 8951.776205594848, 9207.309451791109, 9217.861732074025, 9248.445093294424, 9270.768230794216, 9277.211437027827, 9105.043970383114, 9142.177204051668, 9147.039560846115, 9148.908510914873, 9194.632214711404, 9137.543122843897, 9211.40125891815, 9212.769680757967, 9221.723348299562, 9251.0, 44129.11741765179, 44575.77712111451, 44728.3290750639, 44852.0, 44856.775716121534, 3861.6910647148443, 3862.9613703862883, 3933.8623148189677, 4077.5718549552166, 4224.4508213931995, 32829.507557386656, 33153.50269745956, 33427.49858752121, 33584.0, 33721.0, 4502.459704835408, 4618.35343051973, 4664.13713463007, 4700.929486057712, 4725.31482934976, 319883.0, 320337.0, 320490.0, 320959.0, 322978.0, 62922.37077629257, 63022.16400261999, 63486.682566586875, 63521.0, 63638.0, 72515.63742181256, 73421.0, 73740.63129684317, 73927.0, 74117.0, 17164.828351716573, 17272.0, 17308.91345543264, 17316.65366692659, 17328.82671173272, 12224.1443098984, 12260.570880019335, 12285.815712764315, 12291.07816913735, 12322.075844311712, 21106.155753769985, 21217.469563260733, 21339.57320853574, 21371.252006179708, 21436.892815535823, 7947.165547617533, 7969.481983671043, 8050.59747012647, 8108.135128920381, 8172.141925097898, 1135.7444574970566, 1155.572438197872, 1215.3558613934629, 1228.1832581333313, 1283.018490854497, 33616.327673446394, 33661.65612472629, 33666.49500257498, 33811.4928276076, 33872.0, 1205.2166092040245, 1212.1514939542355, 1257.5535684831752, 1297.5004623220127, 1333.919964802115, 17523.0, 17892.0, 18008.279668813102, 18144.909275453803, 18154.54613634643, 519095.0, 528231.0, 543709.0, 553597.0, 571513.0, 58346.0, 59231.703841480514, 59367.0, 59380.0, 59401.0, 1540.8151021877447, 1545.0412460138932, 1556.8053993250844, 1566.2090644224822, 1581.9446319378767, 32354.676453235166, 33252.50121248135, 33684.66315336913, 34090.0, 34662.65337346695, 55439.44560554504, 55965.16052259138, 56258.71870640621, 56428.7178564121, 56492.45783939815, 472960.0, 474866.0, 475054.0, 475270.0, 479858.0, 30855.845720771253, 31233.531497027107, 31694.683053169174, 31824.52263216007, 31869.521957170196, 50397.24404134014, 50515.74742126413, 51090.744546277034, 51348.0, 51671.224931626806, 42693.57306426896, 42824.57175428206, 43597.782011089745, 43797.34303985379, 44244.55755442404, 42169.57830421779, 42657.78671106625, 43060.56939430691, 43565.56434435615, 43813.78093109514, 43922.560774393125, 43932.34101488544, 44654.77672611746, 44807.10385792331, 45064.0, 36557.817210913774, 36695.08262293464, 36837.26325473529, 37331.626683732815, 37675.2464950694, 29435.705642943296, 29803.85098074496, 29863.552046718884, 29959.400811984073, 30127.397452051275], "value": 21357.487649731094, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.8834537983985, 411.2084237842153, 411.5246889842233, 415.99376009359867, 418.8304582263872, 18514.907425462872, 18668.06659667018, 19078.523036924085, 19318.806811931878, 19320.516987075312, 20006.799932000675, 20236.29172978946, 20370.59258814823, 21103.050362733677, 21119.472013199676, 5641.576881733876, 5642.802501912434, 5891.793787217448, 5915.260592425947, 5920.378360272174, 5761.9135712964335, 5848.532117430616, 5849.766009359641, 5878.470937615613, 5888.911666324987, 5643.6049476536655, 5818.359980402152, 5847.649141051551, 5854.824355269348, 5864.032434648278, 5750.712464376807, 5765.365809760923, 5780.797672081478, 5780.971095144519, 5782.335031471372, 5141.331626888481, 5175.844724658266, 5187.19598462239, 5206.713630750307, 5219.269302297681, 23379.532409351887, 23742.762572374228, 24097.277081687404, 24148.63777043346, 24245.757542424526, 2513.6983561972497, 2691.044679138897, 2905.5496398058335, 2939.1623387334507, 3289.7203737682325, 9784.11942925133, 10320.225983051301, 10436.79126417475, 14629.341679624442, 15584.298706558233, 1966.3707613563665, 2042.1218875883364, 2118.8940552972444, 2134.6050980568643, 2145.281330754199, 63094.0, 70582.99999999949, 71338.0, 82703.58648206781, 84868.57565712131, 10382.0, 10442.425666588411, 11142.944285278521, 11211.439428028565, 11260.0, 15548.22258887051, 15816.683666326839, 15818.60453488649, 15825.287862046236, 15842.683146337009, 8253.669853205925, 8486.575671216415, 8488.448250863674, 8586.484810911365, 8615.827683446421, 8094.838103237902, 8460.576971151419, 8512.957435212784, 8516.659333626585, 8563.657453701906, 4563.201439748031, 4739.573438390561, 4774.665773395829, 4803.135435621622, 4901.632377571696, 1967.8524110691756, 2013.7281467001767, 2032.4106009257446, 2045.509077821312, 2052.8049835265624, 1063.9361638301727, 1069.534752382716, 1115.6987613344352, 1146.4382452598334, 1162.6279590530949, 19087.2365105397, 19239.422817315502, 19334.226630934885, 19724.30964916221, 19792.01039947997, 1080.9459527023616, 1088.894771806617, 1097.8517900083546, 1117.754094099297, 1141.1156353825852, 10807.83788243177, 11109.112350342839, 11153.94423027896, 11208.47626037927, 11227.66317010491, 529964.0, 534577.0, 539803.0, 542870.0, 545461.0, 93608.0, 97184.0, 97970.0, 98069.0, 105071.4746426263, 1110.1507346879644, 1138.203257719583, 1141.3380239461092, 1147.9655610331704, 1152.7175841918615, 17433.128343583023, 18056.729149063038, 18086.0, 18153.0, 18347.541311466786, 40105.0, 41024.58975410327, 41147.7942610285, 41216.79391603143, 42248.57751422447, 61832.69083654553, 62174.0, 62279.06581401373, 62836.37163628305, 63255.683721581096, 8019.599020048858, 8307.958460207661, 8308.376871734765, 8361.540115293717, 8561.400701951054, 9165.633374665205, 9725.756856078655, 10087.00516437087, 12632.242065475733, 14172.43310267619, 12559.120861539604, 12666.430010649727, 12875.678108047, 12935.0, 13103.803442948554, 11999.820002699791, 12171.878281217429, 12352.444140013542, 12509.687257818627, 12881.549145779853, 12565.434555444845, 12797.744045119232, 12842.67893302675, 12943.0, 13177.143485673401, 8856.512891791013, 9054.139856713602, 9073.863892041756, 9228.907710923073, 9277.16505514507, 12712.74574508523, 12760.617181484571, 12811.487540498276, 12888.162269452456, 13101.737965240833], "value": 9610.065316843034, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1598.8561029507343, 1608.5656872644386, 1814.628001259742, 1905.6188762247536, 1919.1267973072245, 7595.0, 8224.588770561462, 8375.455595386296, 8384.413091083627, 8531.744047678563, 8484.533350665712, 8589.09814469481, 8662.610182541785, 8665.17680820321, 8670.479771213715, 2407.2176542623674, 2410.3251089694913, 2434.610462326028, 2436.0864675746593, 2441.8168637352182, 2367.490989437271, 2383.285014495644, 2423.6001059825107, 2443.8778061096964, 2458.1887976967646, 2431.720352159498, 2437.317551085699, 2451.2768733223743, 2468.148488771371, 2472.110040385469, 2415.903363865443, 2416.891239894209, 2429.125514814665, 2447.1068060158004, 2451.669024681663, 2344.284993077111, 2357.10430036585, 2359.10354065454, 2365.621500559902, 2376.097083108425, 8588.69939552119, 8625.568721563897, 8635.0, 8665.306775457948, 8685.609147588373, 5263.078961181816, 5356.758945847446, 5370.43610420904, 5380.219868119101, 5387.0, 3528.700060494861, 3529.594096678889, 3529.6293889141784, 3606.7114630829733, 3691.575468821093, 1114.4260705736551, 1126.6901602059418, 1146.7362506623524, 1172.2790483852455, 1178.1281851429965, 12090.939545302304, 12140.696482587917, 12144.3320617366, 12157.392130393446, 12171.878281217163, 4565.885852853705, 4612.74629895359, 4614.238650622677, 4622.607078398307, 4647.976760116246, 10411.479426028669, 10416.947915260374, 10431.895681043245, 10433.16534677224, 10466.21503387249, 5342.679439233659, 5348.893022139536, 5406.999705054577, 5411.02601531728, 5420.322459692538, 4775.808967641256, 4876.829310974099, 4881.219004959189, 4923.359963204761, 4938.333325001151, 3753.343164946178, 3822.50307460034, 3823.9426408603895, 3868.5551161616213, 3888.6111388860886, 1138.7665528566624, 1142.0349804415255, 1157.346099453806, 1166.5042356998242, 1193.5345215366015, 1061.9946900265604, 1069.1126365116934, 1069.4973362519604, 1075.6611667324767, 1084.9783004340027, 6083.543734219951, 6129.754809807647, 6165.568410211242, 6183.659898705614, 6223.875522489616, 470.6117453101205, 473.637667184604, 476.6972972162632, 482.67660667352254, 485.4805358266621, 4054.2702313583836, 4055.7769322687536, 4125.133721918371, 4127.484064491939, 4128.979355103205, 10090.49547522621, 10266.384016958857, 10311.1235544978, 10393.0, 10411.0, 10225.130863876653, 10241.641542546124, 10271.7432064199, 10280.07479326864, 10332.380057196593, 7599.354054905284, 7768.300852923264, 7831.725889593837, 8100.756977290691, 8137.79655508617, 6001.0, 6003.939960600513, 6049.153118563493, 6066.910205747361, 6164.599301045418, 9430.151286384258, 9560.713178604654, 9700.514974251118, 9706.320557560903, 9714.951425242829, 9505.42967421957, 9576.712698618774, 9735.269854761063, 9745.561449734922, 9936.0, 7143.964280178566, 7193.892091618734, 7247.456440767069, 7612.695492180251, 7821.217878212134, 7852.764417067498, 7923.049234091715, 7925.841483170419, 7955.403344749051, 7978.0825205102155, 7042.295770422917, 7262.3826974707745, 7294.562326260441, 7348.412127029718, 7365.447591430771, 7083.114610673666, 7107.573545587281, 7154.892676609751, 7175.067241258603, 7217.4586905983315, 6512.479001679949, 6538.1500404947055, 6538.574992625464, 6554.508411869034, 6579.96710016466, 5111.182210846247, 5187.481251874782, 5199.142141546754, 5241.31862857826, 5245.396779370269, 5175.197844334134, 5240.34495688039, 5256.579473642023, 5260.500252476008, 5299.364076310713], "value": 4538.389129087265, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.436195115621, 333.7080054951917, 335.72302850148634, 336.20822961924665, 340.1106107528813, 6556.770513032045, 6560.803175904719, 6684.699188536515, 6703.76536821212, 6743.123393958791, 6546.279909209983, 6666.100076489673, 6667.666616669159, 6692.933070669292, 6704.56420332678, 4844.539768721975, 4866.0, 4869.293952376921, 4869.610431165516, 4872.9756351218375, 4843.079814835188, 4862.586680132193, 4862.829800956967, 4869.561739443449, 4876.585490233334, 4817.253325734499, 4822.276658501218, 4823.493533179018, 4827.420709514846, 4830.879228019293, 4703.835365762182, 4824.782884770194, 4831.106245344605, 4840.75796210188, 4845.63657725672, 4172.91654166918, 4187.790610469464, 4190.245755763961, 4204.873853784391, 4205.705600607958, 6297.370262973666, 6299.244090709099, 6323.114763933053, 6368.649724265164, 6377.234731832164, 5620.325560932673, 5666.57500687446, 5667.0, 5676.687782171979, 5692.37383887772, 6882.208546017222, 6900.7929762107215, 6906.205786334585, 6906.689198986058, 6921.826954326182, 4478.3730277760815, 4643.628509719214, 4663.720176789404, 4666.066786642651, 4672.556107169813, 7224.4942854000765, 7267.418606511466, 7333.303336183108, 7338.816529586749, 7345.412367010626, 4715.528447155326, 4715.882102947454, 4720.527947205321, 4722.197226471508, 4733.692309999908, 4761.166795810719, 4795.520447955177, 4799.112164249625, 4800.303955926371, 4801.4718380978065, 5588.580856435784, 5598.44015598445, 5655.066913959151, 5657.066584013592, 5657.632253903483, 6845.5550389224545, 6963.1296087989, 7007.194172670106, 7008.369246767714, 7009.579425234502, 1672.105423598369, 1684.5030715938829, 1697.1514242878561, 1703.4463799265288, 1706.931722731077, 1071.4428497181423, 1076.1337123615408, 1083.6911480228098, 1086.9293495922739, 1094.950727217277, 6664.266930637626, 6789.762358317435, 7020.052292940388, 7020.9648951755935, 7027.191872934575, 7383.593902335316, 7394.223606521346, 7398.186199518049, 7401.444891633149, 7401.629918504053, 6858.6570671466225, 6908.930910690829, 6908.9309106909295, 6920.619365934922, 6931.826704332331, 3873.6126387361037, 3881.7865017423746, 3925.3130702127014, 3949.0917089069676, 3950.48643676326, 7649.120351159577, 7666.808329791688, 7669.923300767033, 7671.079470463468, 7685.0, 7426.257374262638, 7455.515391499535, 7500.212477689873, 7502.887456688154, 7506.474546781782, 7666.195049519832, 7682.654280557388, 7689.307962283421, 7694.923050769421, 7705.460617756703, 7091.787246382617, 7296.598687072262, 7308.744193953186, 7310.451716121419, 7320.718874196888, 7066.505344625827, 7108.0, 7143.178534468395, 7149.14210294768, 7150.5352152109945, 7625.351845093229, 7626.733064342721, 7631.732889348847, 7636.961815190888, 7645.61771911391, 4598.4711758146905, 4647.488776234679, 4647.86056418308, 4649.163150632919, 4662.347271381941, 7147.428205743424, 7256.600886951268, 7278.818029549304, 7284.235155308616, 7288.344049035612, 7016.0, 7032.5077244592385, 7034.085568876013, 7038.683259253244, 7049.7885063448175, 6993.720251189896, 7006.229314775473, 7014.579125252501, 7024.227334993045, 7032.12098487689, 6889.242183359726, 6898.655067246718, 6907.6891539881835, 6908.3437073477935, 6918.308169183041, 6921.7231310747, 7061.1173603299585, 7083.858322833617, 7115.964420177866, 7124.857502850017, 6715.227748808754, 6927.861442771217, 6933.2026816916705, 6943.916824952595, 6946.9780645419405], "value": 5205.697681736241, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.3434792601405, 900.1493588558811, 905.194377004466, 909.354358405532, 915.8397280475915, 14784.926075369622, 14917.179555124478, 14995.625109372257, 15093.547193584183, 15124.168170750605, 14007.509737159202, 14070.437182512687, 14091.78862317066, 14093.71812563748, 14095.295235238224, 741.5995362504241, 889.8576227803553, 914.2548822709471, 921.1295325917011, 921.5023887100991, 905.0361365146131, 905.1265528764741, 909.231699214163, 910.1853840812469, 910.7358865928873, 958.3100167879115, 963.3593660215948, 963.86987756653, 963.9759006024835, 964.5177411294353, 949.02724707175, 949.4635530925005, 953.5422996961463, 954.1651055326589, 955.7323949294208, 703.1070540413646, 704.5138854190643, 704.8907419350008, 705.044664479633, 707.1196360531171, 14750.852491475056, 14879.47921822731, 14955.0, 14956.102633842005, 14974.925125374304, 14200.431982720678, 14282.57152285433, 14345.13929164243, 14360.353784079742, 14599.0, 12137.878621213851, 12197.634070977885, 12259.509619615204, 12350.197237179555, 12465.626031219077, 4055.6755459563165, 4076.9100894834614, 4085.407615895708, 4089.795510224477, 4161.4382058422025, 55297.44702552963, 55316.0, 55607.0, 55702.721486392715, 55960.72019639916, 11292.0, 11349.432528373549, 11424.42877856104, 11541.653750387502, 11763.823542646867, 20365.0, 20567.38297851067, 20654.690179647318, 20742.792572074388, 20757.792422075887, 8600.913990860012, 8704.60829262672, 8846.0, 8883.866741998876, 8983.101689830964, 4718.221493453541, 4800.255960326155, 4816.109019831342, 4986.202207646759, 5039.823606173766, 3647.3799454092336, 3662.0661731258892, 3684.1158122050515, 3696.5748938872375, 3698.4637227602384, 665.9200895892524, 668.5253470036231, 679.6465837764433, 702.4520873718508, 711.7580022792275, 827.3381294964005, 829.8008477965366, 831.5717405536154, 845.809692819123, 852.2329903087148, 9507.286953478517, 9870.851937220947, 9982.251331150193, 10037.297389182833, 10218.897811021943, 727.989080163798, 736.5580651608992, 750.2909750285927, 801.5911884938723, 841.1588411588411, 4504.144212599595, 4512.255477846119, 4555.749433781108, 4601.12578610063, 4661.883452913704, 69671.65164174249, 70161.0, 71650.64174679198, 72070.0, 72590.27409725836, 58696.0, 59216.703916481005, 60229.698851506335, 60725.39274607286, 60885.69557152186, 52149.217761733606, 52343.21485177725, 52473.7376313116, 52888.735556321975, 53000.73499632477, 8791.07693692153, 8948.821023579361, 8990.86513702282, 9068.546572671208, 9281.0, 39382.01544961399, 39878.0, 40427.1914561713, 40899.795501023495, 41332.173356533305, 48893.51106489032, 50937.49062509476, 51415.0, 51510.74244628753, 51977.740111300714, 11209.43952802373, 11344.773104538028, 11550.364729939934, 11598.362090085126, 11859.0, 12936.09447338715, 13010.674733131747, 13026.348682565644, 13187.868121318665, 13216.603501894959, 11511.942440287745, 11629.53481860716, 11909.166358354832, 12180.147389682637, 12622.55821046259, 12258.448369823202, 12370.81443778362, 12493.625191244277, 12877.8068328977, 12968.610941671765, 11712.531498739954, 12059.397030148282, 12216.938915305367, 12551.623451296477, 12588.559400420942, 9968.850467242852, 10021.448820314952, 10122.544485498318, 10175.135113515435, 10248.436336001592, 9748.658796942073, 9914.752131196778, 9937.503124843874, 9948.403095814274, 10047.447390393598], "value": 7130.1984759550405, "unit": "score"}], "name": "dromaeo_css", "value": 7605.9614153998755, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 107.0, 109.0, 111.0, 112.0, 101.0, 110.0, 111.0, 111.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 159.0, 181.0, 129.0, 153.0, 153.0, 133.0, 173.0, 126.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 161.0, 165.0, 164.0, 162.0, 161.0, 161.0, 164.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 79.0, 166.0, 76.0, 76.0, 76.0, 76.0, 175.0, 75.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 161.0, 91.0, 92.0, 93.0, 152.0, 93.0, 91.0, 137.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 148.0, 147.0, 146.0, 151.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 59.0, 55.0, 56.0, 58.0, 61.0, 55.0, 76.0, 54.0, 57.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 72.0, 72.0, 74.0, 73.0, 74.0, 82.0, 73.0, 74.0, 75.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 114.0, 122.0, 113.0, 114.0, 114.0, 119.0, 113.0, 128.0, 125.0], "value": 118.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 166.0, 161.0, 162.0, 160.0, 158.0, 159.0, 159.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 67.0, 67.0, 66.0, 66.0, 70.0, 75.0, 69.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1523.8000000000002, "alertThreshold": 2.0}]} 02:30:49 INFO - Return code: 0 02:30:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:30:49 ERROR - # TBPL SUCCESS # 02:30:49 INFO - Running post-action listener: _resource_record_post_action 02:30:49 INFO - Running post-run listener: _resource_record_post_run 02:30:50 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 45056; Write bytes: 389902336; Read time: 56; Write time: 266048 02:30:50 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 110714880; Read time: 0; Write time: 77320 02:30:50 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 45056; Write bytes: 221564928; Read time: 56; Write time: 119076 02:30:50 INFO - Running post-run listener: _upload_blobber_files 02:30:50 INFO - Blob upload gear active. 02:30:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:30:50 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 02:30:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:30:50 INFO - (blobuploader) - INFO - Open directory for files ... 02:30:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:30:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:30:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:51 INFO - (blobuploader) - INFO - Done attempting. 02:30:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:30:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:30:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:52 INFO - (blobuploader) - INFO - Done attempting. 02:30:52 INFO - (blobuploader) - INFO - Iteration through files over. 02:30:52 INFO - Return code: 0 02:30:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:30:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:30:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/acf9c58fcefb7b6e6f6ccb5397ba2a0228ce2b58f4432536f5e2663012c87dd4d21b1f6958723d98e7ebd62183e285bf5c18c514109165440d9cf83e6adcd2da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1ced7da304dc9a887acfa47e7c28fcde61e35b636043ca1ec217273cd6da455346d10a86c8ac0b1955798ddc8d3b8d12dc628748c57d73c29b5df7b5d444c171"} 02:30:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:30:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:30:52 INFO - Contents: 02:30:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/acf9c58fcefb7b6e6f6ccb5397ba2a0228ce2b58f4432536f5e2663012c87dd4d21b1f6958723d98e7ebd62183e285bf5c18c514109165440d9cf83e6adcd2da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1ced7da304dc9a887acfa47e7c28fcde61e35b636043ca1ec217273cd6da455346d10a86c8ac0b1955798ddc8d3b8d12dc628748c57d73c29b5df7b5d444c171"} 02:30:52 INFO - Running post-run listener: copy_logs_to_upload_dir 02:30:52 INFO - Copying logs to upload dir... 02:30:52 INFO - mkdir: /builds/slave/test/build/upload/logs 02:30:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.470435 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-07 02:30:52.610549) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:30:52.617970) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/acf9c58fcefb7b6e6f6ccb5397ba2a0228ce2b58f4432536f5e2663012c87dd4d21b1f6958723d98e7ebd62183e285bf5c18c514109165440d9cf83e6adcd2da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1ced7da304dc9a887acfa47e7c28fcde61e35b636043ca1ec217273cd6da455346d10a86c8ac0b1955798ddc8d3b8d12dc628748c57d73c29b5df7b5d444c171"} build_url:https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/acf9c58fcefb7b6e6f6ccb5397ba2a0228ce2b58f4432536f5e2663012c87dd4d21b1f6958723d98e7ebd62183e285bf5c18c514109165440d9cf83e6adcd2da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1ced7da304dc9a887acfa47e7c28fcde61e35b636043ca1ec217273cd6da455346d10a86c8ac0b1955798ddc8d3b8d12dc628748c57d73c29b5df7b5d444c171"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:30:52.646550) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:30:52.646889) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1465290625.158477-2018252097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:30:52.725792) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:30:52.726144) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:30:52.726430) ========= ========= Total master_lag: 0.18 =========