builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1460772494.2 results: success (0) buildid: 20160415163038 builduid: 02a5e9aa09ed40dd81e70d58dce59a55 revision: f5a97eb5c89a2b5133ff8bba915acba6344fa7cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 19:08:14.196996) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 19:08:14.197481) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 19:08:14.197768) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 19:08:14.214189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:08:14.214473) ========= 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=6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 19:08:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-04-15 19:08:14 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159007 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:08:14.387130) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:08:14.387481) ========= 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=6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020144 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:08:14.437262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:08:14.437661) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f5a97eb5c89a2b5133ff8bba915acba6344fa7cc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f5a97eb5c89a2b5133ff8bba915acba6344fa7cc --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=6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 19:08:14,710 truncating revision to first 12 chars 2016-04-15 19:08:14,710 Setting DEBUG logging. 2016-04-15 19:08:14,710 attempt 1/10 2016-04-15 19:08:14,710 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f5a97eb5c89a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 19:08:14,961 unpacking tar archive at: mozilla-central-f5a97eb5c89a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525938 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:08:14.976889) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 19:08:14.977217) ========= script_repo_revision: f5a97eb5c89a2b5133ff8bba915acba6344fa7cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 19:08:14.977611) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 19:08:14.977882) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 19:08:14.986373) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-15 19:08:14.986725) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:08:15 INFO - MultiFileLogger online at 20160415 19:08:15 in /builds/slave/test 19:08:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:08:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:08:15 INFO - {'append_to_log': False, 19:08:15 INFO - 'base_work_dir': '/builds/slave/test', 19:08:15 INFO - 'blob_upload_branch': 'Firefox', 19:08:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:08:15 INFO - 'branch': 'Firefox', 19:08:15 INFO - 'buildbot_json_path': 'buildprops.json', 19:08:15 INFO - 'config_files': ('talos/linux_config.py',), 19:08:15 INFO - 'default_actions': ('clobber', 19:08:15 INFO - 'read-buildbot-config', 19:08:15 INFO - 'download-and-extract', 19:08:15 INFO - 'populate-webroot', 19:08:15 INFO - 'create-virtualenv', 19:08:15 INFO - 'install', 19:08:15 INFO - 'run-tests'), 19:08:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:08:15 INFO - 'download_minidump_stackwalk': True, 19:08:15 INFO - 'download_symbols': 'ondemand', 19:08:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:08:15 INFO - 'tooltool.py': '/tools/tooltool.py', 19:08:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:08:15 INFO - '/tools/misc-python/virtualenv.py')}, 19:08:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:08:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:08:15 INFO - 'installer_path': 'installer.exe', 19:08:15 INFO - 'log_level': 'info', 19:08:15 INFO - 'log_name': 'talos', 19:08:15 INFO - 'log_to_console': True, 19:08:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:08:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:08:15 INFO - 'opt_config_files': (), 19:08:15 INFO - 'pip_index': False, 19:08:15 INFO - 'sps_profile': False, 19:08:15 INFO - 'sps_profile_interval': 0, 19:08:15 INFO - 'suite': 'dromaeojs-e10s', 19:08:15 INFO - 'system_bits': '32', 19:08:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:08:15 INFO - 'title': 'talos-linux64-ix-050', 19:08:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:08:15 INFO - 'use_talos_json': True, 19:08:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:08:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:08:15 INFO - 'work_dir': 'build'} 19:08:15 INFO - ##### 19:08:15 INFO - ##### Running clobber step. 19:08:15 INFO - ##### 19:08:15 INFO - Running pre-action listener: _resource_record_pre_action 19:08:15 INFO - Running main action method: clobber 19:08:15 INFO - rmtree: /builds/slave/test/build 19:08:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:08:16 INFO - Running post-action listener: _resource_record_post_action 19:08:16 INFO - ##### 19:08:16 INFO - ##### Running read-buildbot-config step. 19:08:16 INFO - ##### 19:08:16 INFO - Running pre-action listener: _resource_record_pre_action 19:08:16 INFO - Running main action method: read_buildbot_config 19:08:16 INFO - Using buildbot properties: 19:08:16 INFO - { 19:08:16 INFO - "project": "", 19:08:16 INFO - "product": "firefox", 19:08:16 INFO - "script_repo_revision": "production", 19:08:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:08:16 INFO - "repository": "", 19:08:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:08:16 INFO - "buildid": "20160415163038", 19:08:16 INFO - "pgo_build": "True", 19:08:16 INFO - "basedir": "/builds/slave/test", 19:08:16 INFO - "buildnumber": 699, 19:08:16 INFO - "slavename": "talos-linux64-ix-050", 19:08:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:08:16 INFO - "platform": "ubuntu64_hw", 19:08:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:08:16 INFO - "branch": "mozilla-central", 19:08:16 INFO - "repo_path": "mozilla-central", 19:08:16 INFO - "revision": "f5a97eb5c89a2b5133ff8bba915acba6344fa7cc", 19:08:16 INFO - "stage_platform": "linux64-pgo", 19:08:16 INFO - "builduid": "02a5e9aa09ed40dd81e70d58dce59a55", 19:08:16 INFO - "slavebuilddir": "test" 19:08:16 INFO - } 19:08:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 19:08:16 INFO - Running post-action listener: _resource_record_post_action 19:08:16 INFO - ##### 19:08:16 INFO - ##### Running download-and-extract step. 19:08:16 INFO - ##### 19:08:16 INFO - Running pre-action listener: _resource_record_pre_action 19:08:16 INFO - Running main action method: download_and_extract 19:08:16 INFO - mkdir: /builds/slave/test/build/tests 19:08:16 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')]} 19:08:16 INFO - https://queue.taskcluster.net/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:08:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:08:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:08:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:08:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:08:18 INFO - Downloaded 1361 bytes. 19:08:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:08:18 INFO - Using the following test package requirements: 19:08:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:08:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:08:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:18 INFO - u'jsshell-linux-x86_64.zip'], 19:08:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:08:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:08:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:08:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:08:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:08:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:08: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')]} 19:08:18 INFO - https://queue.taskcluster.net/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:08:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:08:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:08:20 INFO - Downloaded 23775078 bytes. 19:08:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:08:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:08:21 INFO - Return code: 0 19:08:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:08:21 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')]} 19:08:21 INFO - https://queue.taskcluster.net/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:08:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:08:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:08:31 INFO - Downloaded 23775078 bytes. 19:08:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:08:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:08:32 INFO - Return code: 0 19:08: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')]} 19:08:32 INFO - https://queue.taskcluster.net/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:08:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:08:33 INFO - Downloaded 10841076 bytes. 19:08:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:08:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:08:34 INFO - Return code: 0 19:08: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')]} 19:08:34 INFO - https://queue.taskcluster.net/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:08:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:08:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:08:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:08:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:08:35 INFO - Downloaded 58228955 bytes. 19:08:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:08:35 INFO - mkdir: /builds/slave/test/properties 19:08:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:08:35 INFO - Writing to file /builds/slave/test/properties/build_url 19:08:35 INFO - Contents: 19:08:35 INFO - build_url:https://queue.taskcluster.net/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:08:36 INFO - Running post-action listener: _resource_record_post_action 19:08:36 INFO - Running post-action listener: set_extra_try_arguments 19:08:36 INFO - ##### 19:08:36 INFO - ##### Running populate-webroot step. 19:08:36 INFO - ##### 19:08:36 INFO - Running pre-action listener: _resource_record_pre_action 19:08:36 INFO - Running main action method: populate_webroot 19:08:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:08:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:08:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:08:36 INFO - '--tppagecycles', 19:08:36 INFO - '7'], 19:08:36 INFO - 'tests': ['tsvgm']}}, 19:08:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:08:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:08:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:08:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:08:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:08:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:08:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:36 INFO - 'talos_options': ['--disable-e10s'], 19:08:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:36 INFO - 'talos_options': ['--disable-e10s'], 19:08:36 INFO - 'tests': ['damp', 'tps']}, 19:08:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:36 INFO - 'tests': ['damp', 'tps']}, 19:08:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:08:36 INFO - 'tests': ['dromaeo_dom']}, 19:08:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:08:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:08:36 INFO - 'tests': ['a11yr', 19:08:36 INFO - 'ts_paint', 19:08:36 INFO - 'tpaint', 19:08:36 INFO - 'sessionrestore', 19:08:36 INFO - 'sessionrestore_no_auto_restore', 19:08:36 INFO - 'tabpaint']}, 19:08:36 INFO - 'other-e10s': {'tests': ['a11yr', 19:08:36 INFO - 'ts_paint', 19:08:36 INFO - 'tpaint', 19:08:36 INFO - 'sessionrestore', 19:08:36 INFO - 'sessionrestore_no_auto_restore', 19:08:36 INFO - 'tabpaint']}, 19:08:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:08:36 INFO - 'ts_paint', 19:08:36 INFO - 'tpaint', 19:08:36 INFO - 'sessionrestore', 19:08:36 INFO - 'sessionrestore_no_auto_restore', 19:08:36 INFO - 'tabpaint']}, 19:08:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:08:36 INFO - 'ts_paint', 19:08:36 INFO - 'tpaint', 19:08:36 INFO - 'sessionrestore', 19:08:36 INFO - 'sessionrestore_no_auto_restore', 19:08:36 INFO - 'tabpaint']}, 19:08:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:08:36 INFO - 'tests': ['a11yr', 19:08:36 INFO - 'ts_paint', 19:08:36 INFO - 'tpaint', 19:08:36 INFO - 'sessionrestore', 19:08:36 INFO - 'sessionrestore_no_auto_restore', 19:08:36 INFO - 'tabpaint']}, 19:08:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:08:36 INFO - 'tests': ['a11yr', 19:08:36 INFO - 'ts_paint', 19:08:36 INFO - 'tpaint', 19:08:36 INFO - 'sessionrestore', 19:08:36 INFO - 'sessionrestore_no_auto_restore', 19:08:36 INFO - 'tabpaint']}, 19:08:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:08:36 INFO - 'tests': ['tsvgx', 19:08:36 INFO - 'tsvgr_opacity', 19:08:36 INFO - 'tart', 19:08:36 INFO - 'tscrollx', 19:08:36 INFO - 'cart']}, 19:08:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:08:36 INFO - 'tsvgr_opacity', 19:08:36 INFO - 'tart', 19:08:36 INFO - 'tscrollx', 19:08:36 INFO - 'cart']}, 19:08:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:36 INFO - 'talos_options': ['--disable-e10s'], 19:08:36 INFO - 'tests': ['tp5o']}, 19:08:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:36 INFO - 'tests': ['tp5o']}, 19:08:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:36 INFO - 'talos_options': ['--disable-e10s', 19:08:36 INFO - '--xperf_path', 19:08:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:36 INFO - 'tests': ['tp5n']}, 19:08:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:36 INFO - 'talos_options': ['--xperf_path', 19:08:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:36 INFO - 'tests': ['tp5n']}}, 19:08:36 INFO - 'talos.zip': {'path': '', 19:08:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:08:36 INFO - Running post-action listener: _resource_record_post_action 19:08:36 INFO - ##### 19:08:36 INFO - ##### Running create-virtualenv step. 19:08:36 INFO - ##### 19:08:36 INFO - Running pre-action listener: _resource_record_pre_action 19:08:36 INFO - Running main action method: create_virtualenv 19:08:36 INFO - Creating virtualenv /builds/slave/test/build/venv 19:08:36 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 19:08:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:08:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:08:36 INFO - Using real prefix '/usr' 19:08:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:08:37 INFO - Installing distribute.............................................................................................................................................................................................done. 19:08:39 INFO - Installing pip.................done. 19:08:39 INFO - Return code: 0 19:08:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:39 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 0x7f7df91a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, '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 0x137e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', '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 19:08:39 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 19:08:39 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 19:08:39 INFO - Using env: {'DISPLAY': ':0', 19:08:39 INFO - 'HOME': '/home/cltbld', 19:08:39 INFO - 'LANG': 'en_US.UTF-8', 19:08:39 INFO - 'LANGUAGE': 'en_US:en', 19:08:39 INFO - 'LOGNAME': 'cltbld', 19:08:39 INFO - 'MAIL': '/var/mail/cltbld', 19:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:39 INFO - 'MOZ_NO_REMOTE': '1', 19:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:39 INFO - 'NO_EM_RESTART': '1', 19:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:39 INFO - 'PWD': '/builds/slave/test', 19:08:39 INFO - 'SHELL': '/bin/bash', 19:08:39 INFO - 'SHLVL': '1', 19:08:39 INFO - 'TERM': 'linux', 19:08:39 INFO - 'TMOUT': '86400', 19:08:39 INFO - 'USER': 'cltbld', 19:08:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', 19:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:39 INFO - '_': '/tools/buildbot/bin/python'} 19:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:39 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 19:08:39 INFO - Cleaning up... 19:08:39 INFO - Return code: 0 19:08:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:39 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 0x7f7df91a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, '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 0x137e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', '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 19:08:39 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 19:08:39 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 19:08:39 INFO - Using env: {'DISPLAY': ':0', 19:08:39 INFO - 'HOME': '/home/cltbld', 19:08:39 INFO - 'LANG': 'en_US.UTF-8', 19:08:39 INFO - 'LANGUAGE': 'en_US:en', 19:08:39 INFO - 'LOGNAME': 'cltbld', 19:08:39 INFO - 'MAIL': '/var/mail/cltbld', 19:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:39 INFO - 'MOZ_NO_REMOTE': '1', 19:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:39 INFO - 'NO_EM_RESTART': '1', 19:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:39 INFO - 'PWD': '/builds/slave/test', 19:08:39 INFO - 'SHELL': '/bin/bash', 19:08:39 INFO - 'SHLVL': '1', 19:08:39 INFO - 'TERM': 'linux', 19:08:39 INFO - 'TMOUT': '86400', 19:08:39 INFO - 'USER': 'cltbld', 19:08:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', 19:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:39 INFO - '_': '/tools/buildbot/bin/python'} 19:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:39 INFO - Downloading/unpacking psutil>=0.7.1 19:08:39 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 19:08:39 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 19:08:39 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 19:08:39 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 19:08:39 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 19:08:39 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 19:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:08:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:41 INFO - Installing collected packages: psutil 19:08:41 INFO - Running setup.py install for psutil 19:08:41 INFO - building 'psutil._psutil_linux' extension 19:08:41 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 19:08:41 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 19:08:41 INFO - building 'psutil._psutil_posix' extension 19:08:41 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 19:08:41 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 19:08:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:42 INFO - Successfully installed psutil 19:08:42 INFO - Cleaning up... 19:08:42 INFO - Return code: 0 19:08:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:42 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 0x7f7df91a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, '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 0x137e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', '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 19:08:42 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 19:08:42 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 19:08:42 INFO - Using env: {'DISPLAY': ':0', 19:08:42 INFO - 'HOME': '/home/cltbld', 19:08:42 INFO - 'LANG': 'en_US.UTF-8', 19:08:42 INFO - 'LANGUAGE': 'en_US:en', 19:08:42 INFO - 'LOGNAME': 'cltbld', 19:08:42 INFO - 'MAIL': '/var/mail/cltbld', 19:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:42 INFO - 'MOZ_NO_REMOTE': '1', 19:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:42 INFO - 'NO_EM_RESTART': '1', 19:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:42 INFO - 'PWD': '/builds/slave/test', 19:08:42 INFO - 'SHELL': '/bin/bash', 19:08:42 INFO - 'SHLVL': '1', 19:08:42 INFO - 'TERM': 'linux', 19:08:42 INFO - 'TMOUT': '86400', 19:08:42 INFO - 'USER': 'cltbld', 19:08:42 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', 19:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:42 INFO - '_': '/tools/buildbot/bin/python'} 19:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:08:42 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 19:08:42 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 19:08:42 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 19:08:42 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 19:08:42 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 19:08:42 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 19:08:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:08:44 INFO - Installing collected packages: mozsystemmonitor 19:08:44 INFO - Running setup.py install for mozsystemmonitor 19:08:44 INFO - Successfully installed mozsystemmonitor 19:08:44 INFO - Cleaning up... 19:08:44 INFO - Return code: 0 19:08:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:44 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 0x7f7df91a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, '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 0x137e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', '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 19:08:44 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 19:08:44 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 19:08:44 INFO - Using env: {'DISPLAY': ':0', 19:08:44 INFO - 'HOME': '/home/cltbld', 19:08:44 INFO - 'LANG': 'en_US.UTF-8', 19:08:44 INFO - 'LANGUAGE': 'en_US:en', 19:08:44 INFO - 'LOGNAME': 'cltbld', 19:08:44 INFO - 'MAIL': '/var/mail/cltbld', 19:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:44 INFO - 'MOZ_NO_REMOTE': '1', 19:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:44 INFO - 'NO_EM_RESTART': '1', 19:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:44 INFO - 'PWD': '/builds/slave/test', 19:08:44 INFO - 'SHELL': '/bin/bash', 19:08:44 INFO - 'SHLVL': '1', 19:08:44 INFO - 'TERM': 'linux', 19:08:44 INFO - 'TMOUT': '86400', 19:08:44 INFO - 'USER': 'cltbld', 19:08:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', 19:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:44 INFO - '_': '/tools/buildbot/bin/python'} 19:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:44 INFO - Downloading/unpacking blobuploader==1.2.4 19:08:44 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 19:08:44 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 19:08:44 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 19:08:44 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 19:08:44 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 19:08:44 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 19:08:46 INFO - Downloading blobuploader-1.2.4.tar.gz 19:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:08:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:08:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:47 INFO - Downloading docopt-0.6.1.tar.gz 19:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:08:47 INFO - Installing collected packages: blobuploader, requests, docopt 19:08:47 INFO - Running setup.py install for blobuploader 19:08:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:08:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:08:47 INFO - Running setup.py install for requests 19:08:47 INFO - Running setup.py install for docopt 19:08:47 INFO - Successfully installed blobuploader requests docopt 19:08:47 INFO - Cleaning up... 19:08:47 INFO - Return code: 0 19:08:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:47 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')]} 19:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:47 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')]} 19:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:47 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 0x7f7df91a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, '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 0x137e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', '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 19:08:47 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 19:08:47 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 19:08:47 INFO - Using env: {'DISPLAY': ':0', 19:08:47 INFO - 'HOME': '/home/cltbld', 19:08:47 INFO - 'LANG': 'en_US.UTF-8', 19:08:47 INFO - 'LANGUAGE': 'en_US:en', 19:08:47 INFO - 'LOGNAME': 'cltbld', 19:08:47 INFO - 'MAIL': '/var/mail/cltbld', 19:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:47 INFO - 'MOZ_NO_REMOTE': '1', 19:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:47 INFO - 'NO_EM_RESTART': '1', 19:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:47 INFO - 'PWD': '/builds/slave/test', 19:08:47 INFO - 'SHELL': '/bin/bash', 19:08:47 INFO - 'SHLVL': '1', 19:08:47 INFO - 'TERM': 'linux', 19:08:47 INFO - 'TMOUT': '86400', 19:08:47 INFO - 'USER': 'cltbld', 19:08:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', 19:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:47 INFO - '_': '/tools/buildbot/bin/python'} 19:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:48 INFO - Running setup.py (path:/tmp/pip-CIkEtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:48 INFO - Running setup.py (path:/tmp/pip-GAo9aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:48 INFO - Running setup.py (path:/tmp/pip-RBPWP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:48 INFO - Running setup.py (path:/tmp/pip-7b_IYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:48 INFO - Running setup.py (path:/tmp/pip-qaQfHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:48 INFO - Running setup.py (path:/tmp/pip-tvR9YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:48 INFO - Running setup.py (path:/tmp/pip-cyRpzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:48 INFO - Running setup.py (path:/tmp/pip-8azJ0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:48 INFO - Running setup.py (path:/tmp/pip-dKPxIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:48 INFO - Running setup.py (path:/tmp/pip-7N5L8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:48 INFO - Running setup.py (path:/tmp/pip-CTRwI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:48 INFO - Running setup.py (path:/tmp/pip-6LS_cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:48 INFO - Running setup.py (path:/tmp/pip-GFfDNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:48 INFO - Running setup.py (path:/tmp/pip-FhF1QH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:49 INFO - Running setup.py (path:/tmp/pip-ULrZEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:49 INFO - Running setup.py (path:/tmp/pip-srByet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:49 INFO - Running setup.py (path:/tmp/pip-8hbEFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:08:49 INFO - Running setup.py install for manifestparser 19:08:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:08:49 INFO - Running setup.py install for mozcrash 19:08:49 INFO - Running setup.py install for mozdebug 19:08:49 INFO - Running setup.py install for mozdevice 19:08:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:08:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:08:49 INFO - Running setup.py install for mozfile 19:08:49 INFO - Running setup.py install for mozhttpd 19:08:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:08:49 INFO - Running setup.py install for mozinfo 19:08:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:08:49 INFO - Running setup.py install for mozInstall 19:08:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:08:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:08:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:08:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:08:50 INFO - Running setup.py install for mozleak 19:08:50 INFO - Running setup.py install for mozlog 19:08:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:08:50 INFO - Running setup.py install for moznetwork 19:08:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:08:50 INFO - Running setup.py install for mozprocess 19:08:50 INFO - Running setup.py install for mozprofile 19:08:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:08:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:08:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:08:50 INFO - Running setup.py install for mozrunner 19:08:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:08:50 INFO - Running setup.py install for mozscreenshot 19:08:50 INFO - Running setup.py install for moztest 19:08:50 INFO - Running setup.py install for mozversion 19:08:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:08:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:08:51 INFO - Cleaning up... 19:08:51 INFO - Return code: 0 19:08:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:51 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 0x7f7df91a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, '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 0x137e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', '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 19:08:51 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 19:08:51 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 19:08:51 INFO - Using env: {'DISPLAY': ':0', 19:08:51 INFO - 'HOME': '/home/cltbld', 19:08:51 INFO - 'LANG': 'en_US.UTF-8', 19:08:51 INFO - 'LANGUAGE': 'en_US:en', 19:08:51 INFO - 'LOGNAME': 'cltbld', 19:08:51 INFO - 'MAIL': '/var/mail/cltbld', 19:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:51 INFO - 'MOZ_NO_REMOTE': '1', 19:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:51 INFO - 'NO_EM_RESTART': '1', 19:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:51 INFO - 'PWD': '/builds/slave/test', 19:08:51 INFO - 'SHELL': '/bin/bash', 19:08:51 INFO - 'SHLVL': '1', 19:08:51 INFO - 'TERM': 'linux', 19:08:51 INFO - 'TMOUT': '86400', 19:08:51 INFO - 'USER': 'cltbld', 19:08:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', 19:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:51 INFO - '_': '/tools/buildbot/bin/python'} 19:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:51 INFO - Running setup.py (path:/tmp/pip-gTVJpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:51 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)) 19:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:51 INFO - Running setup.py (path:/tmp/pip-Cs1NU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:51 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)) 19:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:51 INFO - Running setup.py (path:/tmp/pip-ljmiBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:51 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)) 19:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:51 INFO - Running setup.py (path:/tmp/pip-hovTks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:51 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)) 19:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:51 INFO - Running setup.py (path:/tmp/pip-kYaphN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:51 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)) 19:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:51 INFO - Running setup.py (path:/tmp/pip-fGJKkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:51 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)) 19:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:51 INFO - Running setup.py (path:/tmp/pip-pihPPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:51 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)) 19:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:51 INFO - Running setup.py (path:/tmp/pip-l9POMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:51 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)) 19:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:51 INFO - Running setup.py (path:/tmp/pip-MAnHSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:51 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)) 19:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:51 INFO - Running setup.py (path:/tmp/pip-b40WSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:51 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)) 19:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:51 INFO - Running setup.py (path:/tmp/pip-gjDXj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:52 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)) 19:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:52 INFO - Running setup.py (path:/tmp/pip-fbCL3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:52 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)) 19:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:52 INFO - Running setup.py (path:/tmp/pip-yboqQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:52 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)) 19:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:52 INFO - Running setup.py (path:/tmp/pip-_I9j9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:52 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)) 19:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:52 INFO - Running setup.py (path:/tmp/pip-oC3ftH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:52 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)) 19:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:52 INFO - Running setup.py (path:/tmp/pip-aH2Fzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:52 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)) 19:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:52 INFO - Running setup.py (path:/tmp/pip-02UrkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:52 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)) 19:08:52 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)) 19:08:52 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)) 19:08:52 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)) 19:08:52 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)) 19:08:52 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)) 19:08:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:08:52 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 19:08:52 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 19:08:52 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 19:08:52 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 19:08:52 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 19:08:52 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 19:08:54 INFO - Downloading blessings-1.6.tar.gz 19:08:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:08:54 INFO - Installing collected packages: blessings 19:08:54 INFO - Running setup.py install for blessings 19:08:54 INFO - Successfully installed blessings 19:08:54 INFO - Cleaning up... 19:08:54 INFO - Return code: 0 19:08:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:08:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:54 INFO - Reading from file tmpfile_stdout 19:08:54 INFO - Current package versions: 19:08:54 INFO - argparse == 1.2.1 19:08:54 INFO - blessings == 1.6 19:08:54 INFO - blobuploader == 1.2.4 19:08:54 INFO - docopt == 0.6.1 19:08:54 INFO - manifestparser == 1.1 19:08:54 INFO - mozInstall == 1.12 19:08:54 INFO - mozcrash == 0.17 19:08:54 INFO - mozdebug == 0.1 19:08:54 INFO - mozdevice == 0.48 19:08:54 INFO - mozfile == 1.2 19:08:54 INFO - mozhttpd == 0.7 19:08:54 INFO - mozinfo == 0.9 19:08:54 INFO - mozleak == 0.1 19:08:54 INFO - mozlog == 3.1 19:08:54 INFO - moznetwork == 0.27 19:08:54 INFO - mozprocess == 0.22 19:08:54 INFO - mozprofile == 0.28 19:08:54 INFO - mozrunner == 6.11 19:08:54 INFO - mozscreenshot == 0.1 19:08:54 INFO - mozsystemmonitor == 0.0 19:08:54 INFO - moztest == 0.7 19:08:54 INFO - mozversion == 1.4 19:08:54 INFO - psutil == 3.1.1 19:08:54 INFO - requests == 1.2.3 19:08:54 INFO - wsgiref == 0.1.2 19:08:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:54 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 0x7f7df91a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, '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 0x137e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', '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 19:08:54 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 19:08:54 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 19:08:54 INFO - Using env: {'DISPLAY': ':0', 19:08:54 INFO - 'HOME': '/home/cltbld', 19:08:54 INFO - 'LANG': 'en_US.UTF-8', 19:08:54 INFO - 'LANGUAGE': 'en_US:en', 19:08:54 INFO - 'LOGNAME': 'cltbld', 19:08:54 INFO - 'MAIL': '/var/mail/cltbld', 19:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:54 INFO - 'MOZ_NO_REMOTE': '1', 19:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:54 INFO - 'NO_EM_RESTART': '1', 19:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:54 INFO - 'PWD': '/builds/slave/test', 19:08:54 INFO - 'SHELL': '/bin/bash', 19:08:54 INFO - 'SHLVL': '1', 19:08:54 INFO - 'TERM': 'linux', 19:08:54 INFO - 'TMOUT': '86400', 19:08:54 INFO - 'USER': 'cltbld', 19:08:54 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', 19:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:54 INFO - '_': '/tools/buildbot/bin/python'} 19:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:55 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)) 19:08:55 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)) 19:08:55 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)) 19:08:55 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)) 19:08:55 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)) 19:08:55 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)) 19:08:55 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)) 19:08:55 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)) 19:08:55 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)) 19:08:55 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)) 19:08:55 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)) 19:08:55 INFO - Cleaning up... 19:08:55 INFO - Return code: 0 19:08:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:55 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 0x7f7df91a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, '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 0x137e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', '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 19:08:55 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 19:08:55 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 19:08:55 INFO - Using env: {'DISPLAY': ':0', 19:08:55 INFO - 'HOME': '/home/cltbld', 19:08:55 INFO - 'LANG': 'en_US.UTF-8', 19:08:55 INFO - 'LANGUAGE': 'en_US:en', 19:08:55 INFO - 'LOGNAME': 'cltbld', 19:08:55 INFO - 'MAIL': '/var/mail/cltbld', 19:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:55 INFO - 'MOZ_NO_REMOTE': '1', 19:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:55 INFO - 'NO_EM_RESTART': '1', 19:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:55 INFO - 'PWD': '/builds/slave/test', 19:08:55 INFO - 'SHELL': '/bin/bash', 19:08:55 INFO - 'SHLVL': '1', 19:08:55 INFO - 'TERM': 'linux', 19:08:55 INFO - 'TMOUT': '86400', 19:08:55 INFO - 'USER': 'cltbld', 19:08:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', 19:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:55 INFO - '_': '/tools/buildbot/bin/python'} 19:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:55 INFO - Downloading/unpacking jsonschema 19:08:55 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 19:08:55 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 19:08:55 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 19:08:55 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 19:08:55 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 19:08:55 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 19:08:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:08:57 INFO - Downloading/unpacking functools32 (from jsonschema) 19:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:57 INFO - Downloading functools32-3.2.3-2.tar.gz 19:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:08:57 INFO - warning: no files found matching '*.txt' 19:08:57 INFO - no previously-included directories found matching 'build' 19:08:57 INFO - no previously-included directories found matching 'dist' 19:08:57 INFO - no previously-included directories found matching '.git*' 19:08:57 INFO - Installing collected packages: jsonschema, functools32 19:08:57 INFO - Running setup.py install for functools32 19:08:57 INFO - warning: no files found matching '*.txt' 19:08:57 INFO - no previously-included directories found matching 'build' 19:08:57 INFO - no previously-included directories found matching 'dist' 19:08:57 INFO - no previously-included directories found matching '.git*' 19:08:57 INFO - Successfully installed jsonschema functools32 19:08:57 INFO - Cleaning up... 19:08:57 INFO - Return code: 0 19:08:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7df91a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, '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 0x137e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', '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 19:08:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:08:57 INFO - Using env: {'DISPLAY': ':0', 19:08:57 INFO - 'HOME': '/home/cltbld', 19:08:57 INFO - 'LANG': 'en_US.UTF-8', 19:08:57 INFO - 'LANGUAGE': 'en_US:en', 19:08:57 INFO - 'LOGNAME': 'cltbld', 19:08:57 INFO - 'MAIL': '/var/mail/cltbld', 19:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:57 INFO - 'MOZ_NO_REMOTE': '1', 19:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:57 INFO - 'NO_EM_RESTART': '1', 19:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:57 INFO - 'PWD': '/builds/slave/test', 19:08:57 INFO - 'SHELL': '/bin/bash', 19:08:57 INFO - 'SHLVL': '1', 19:08:57 INFO - 'TERM': 'linux', 19:08:57 INFO - 'TMOUT': '86400', 19:08:57 INFO - 'USER': 'cltbld', 19:08:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', 19:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:57 INFO - '_': '/tools/buildbot/bin/python'} 19:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:57 INFO - Downloading/unpacking flake8 19:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:08:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:08:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:09:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:09:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:09:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:09:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:09:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:09:00 INFO - no previously-included directories found matching 'docs/_build' 19:09:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:09:00 INFO - Running setup.py install for pep8 19:09:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:09:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:09:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:09:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:09:00 INFO - no previously-included directories found matching 'docs/_build' 19:09:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:09:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:09:00 INFO - Cleaning up... 19:09:00 INFO - Return code: 0 19:09:00 INFO - Running post-action listener: _resource_record_post_action 19:09:00 INFO - Running post-action listener: _start_resource_monitoring 19:09:00 INFO - Starting resource monitoring. 19:09:00 INFO - ##### 19:09:00 INFO - ##### Running install step. 19:09:00 INFO - ##### 19:09:00 INFO - Running pre-action listener: _resource_record_pre_action 19:09:00 INFO - Running main action method: install 19:09:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:09:00 INFO - Reading from file tmpfile_stdout 19:09:00 INFO - Detecting whether we're running mozinstall >=1.0... 19:09:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:09:01 INFO - Reading from file tmpfile_stdout 19:09:01 INFO - Output received: 19:09:01 INFO - Usage: mozinstall [options] installer 19:09:01 INFO - Options: 19:09:01 INFO - -h, --help show this help message and exit 19:09:01 INFO - -d DEST, --destination=DEST 19:09:01 INFO - Directory to install application into. [default: 19:09:01 INFO - "/builds/slave/test"] 19:09:01 INFO - --app=APP Application being installed. [default: firefox] 19:09:01 INFO - mkdir: /builds/slave/test/build/application 19:09:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:09:17 INFO - Reading from file tmpfile_stdout 19:09:17 INFO - Output received: 19:09:17 INFO - /builds/slave/test/build/application/firefox/firefox 19:09:17 INFO - Running post-action listener: _resource_record_post_action 19:09:17 INFO - ##### 19:09:17 INFO - ##### Running run-tests step. 19:09:17 INFO - ##### 19:09:17 INFO - Running pre-action listener: _resource_record_pre_action 19:09:17 INFO - Running main action method: run_tests 19:09:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:09:17 INFO - Python 2.7.3 19:09:17 INFO - Return code: 0 19:09:17 INFO - grabbing minidump binary from tooltool 19:09:17 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')]} 19:09:17 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 0x137d410>, '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 0x137e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:09:17 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 19:09:17 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 19:09:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:09:17 INFO - Return code: 0 19:09:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:09:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:09:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:09:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:09:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:09:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:09:18 INFO - Return code: 0 19:09:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 19:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 19:09:18 INFO - Using env: {'DISPLAY': ':0', 19:09:18 INFO - 'HOME': '/home/cltbld', 19:09:18 INFO - 'LANG': 'en_US.UTF-8', 19:09:18 INFO - 'LANGUAGE': 'en_US:en', 19:09:18 INFO - 'LOGNAME': 'cltbld', 19:09:18 INFO - 'MAIL': '/var/mail/cltbld', 19:09:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:09:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:18 INFO - 'MOZ_NO_REMOTE': '1', 19:09:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:18 INFO - 'NO_EM_RESTART': '1', 19:09:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:18 INFO - 'PWD': '/builds/slave/test', 19:09:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:09:18 INFO - 'SHELL': '/bin/bash', 19:09:18 INFO - 'SHLVL': '1', 19:09:18 INFO - 'TERM': 'linux', 19:09:18 INFO - 'TMOUT': '86400', 19:09:18 INFO - 'USER': 'cltbld', 19:09:18 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149', 19:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:18 INFO - '_': '/tools/buildbot/bin/python'} 19:09:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 19:09:18 INFO - mozversion application_buildid: 20160415163038 19:09:18 INFO - mozversion application_changeset: f5a97eb5c89a2b5133ff8bba915acba6344fa7cc 19:09:18 INFO - mozversion application_display_name: Nightly 19:09:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:09:18 INFO - mozversion application_name: Firefox 19:09:18 INFO - mozversion application_remotingname: firefox 19:09:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:09:18 INFO - mozversion application_vendor: Mozilla 19:09:18 INFO - mozversion application_version: 48.0a1 19:09:18 INFO - mozversion platform_buildid: 20160415163038 19:09:18 INFO - mozversion platform_changeset: f5a97eb5c89a2b5133ff8bba915acba6344fa7cc 19:09:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:09:18 INFO - mozversion platform_version: 48.0a1 19:09:18 INFO - using testdate: 1460772558 19:09:18 INFO - actual date: 1460772558 19:09:18 INFO - starting webserver on 'localhost:39024' 19:09:18 INFO - SUITE-START | Running 2 tests 19:09:18 INFO - TEST-START | dromaeo_css 19:09:18 INFO - operating with platform_type : linux_ 19:09:18 INFO - Initialising browser for dromaeo_css test... 19:09:18 INFO - TEST-INFO | started process 10025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGi9BmC/profile http://localhost:39024/getInfo.html) 19:09:22 INFO - PROCESS | 10025 | 19:09:22 INFO - PROCESS | 10025 | (process:10092): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:09:22 INFO - PROCESS | 10025 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 19:09:23 INFO - PROCESS | 10025 | __metrics Screen width/height:1600/1200 19:09:23 INFO - PROCESS | 10025 | colorDepth:24 19:09:23 INFO - PROCESS | 10025 | Browser inner width/height: 1024/697 19:09:23 INFO - PROCESS | 10025 | __metrics 19:09:24 ERROR - PROCESS | 10025 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:09:25 INFO - TEST-INFO | 10025: exit 0 19:09:25 INFO - Browser initialized. 19:09:25 INFO - Running cycle 1/1 for dromaeo_css test... 19:09:25 INFO - TEST-INFO | started process 10143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGi9BmC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:26 INFO - PROCESS | 10143 | 19:09:26 INFO - PROCESS | 10143 | (process:10203): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:09:36 INFO - PROCESS | 10143 | RSS: Main: 164012032 19:09:36 INFO - PROCESS | 10143 | 19:10:26 INFO - PROCESS | 10143 | 1460772626506 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] 19:12:34 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:39024/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39024/tests/dromaeo/cssquery-ext.html) 19:12:35 INFO - PROCESS | 10143 | RSS: Main: 168439808 19:12:35 INFO - PROCESS | 10143 | 19:15:37 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:39024/tests/dromaeo/cssquery-ext.html (next: http://localhost:39024/tests/dromaeo/cssquery-jquery.html) 19:15:37 INFO - PROCESS | 10143 | RSS: Main: 165453824 19:15:37 INFO - PROCESS | 10143 | 19:18:39 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:39024/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39024/tests/dromaeo/cssquery-mootools.html) 19:18:40 INFO - PROCESS | 10143 | RSS: Main: 166555648 19:18:40 INFO - PROCESS | 10143 | 19:21:41 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:39024/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39024/tests/dromaeo/cssquery-prototype.html) 19:21:42 INFO - PROCESS | 10143 | RSS: Main: 164491264 19:21:42 INFO - PROCESS | 10143 | 19:24:44 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:39024/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39024/tests/dromaeo/cssquery-yui.html) 19:24:45 INFO - PROCESS | 10143 | RSS: Main: 166174720 19:24:45 INFO - PROCESS | 10143 | 19:27:47 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:39024/tests/dromaeo/cssquery-yui.html (next: http://localhost:39024/tests/dromaeo/cssquery-dojo.html) 19:27:48 INFO - PROCESS | 10143 | RSS: Main: 167587840 19:27:48 INFO - PROCESS | 10143 | 19:27:48 INFO - PROCESS | 10143 | __start_tp_report 19:27:48 INFO - PROCESS | 10143 | _x_x_mozilla_page_load 19:27:48 INFO - PROCESS | 10143 | _x_x_mozilla_page_load_details 19:27:48 INFO - PROCESS | 10143 | |i|pagename|runs| 19:27:48 INFO - PROCESS | 10143 | |0;dojo.html;3098.070578826352;3163.6994485523874;3184.124365799403;3187.744980401567;3203.711665950064;5480.917786233204;5525.419830917751;5529.585281103913;5531.9723401383035;5533.750981205845;5442.83671489855;5476.91784623231;5491.478309560585;5503.697296648693;5583.3858275589655;4917.21324588066;4952.455229924705;4953.455119936804;5063.113955057868;5111.51440613143;5055.6713813602;5073.162928116856;5082.593392528589;5115.718635475047;5136.974315128419;4795.040991801636;4854.077725232212;4882.853514394574;4928.827491037797;5046.596272298226;4923.58149557288;4926.482719314492;4926.876828079291;4937.925931111036;4962.330085438456;4866.051120031595;4898.608111351084;4906.411230652309;4916.1888288432365;4957.702537847741;5282.630215884889;5290.92063619046;5324.1215199492035;5371.704556249405;5386.245925570423;5759.539236861041;5776.277965254343;5783.768649254025;5793.217915581385;5795.362510123883;5750.942490575125;5763.193152958589;5782.653040817564;5801.0428279333855;5812.82561523155;5398.568114550826;5432.511074003359;5435.565154787608;5458.4541545845495;5469.042917489423;5861.88276234473;5935;5938.851528711817;5941.197938278364;5957.970210149008;5680.14797780328;5698.1737648041635;5702.7433765480655;5713.6857472838565;5746.9425305747245;5721.485066344049;5740.770369185269;5749.195112684228;5794.130880367894;5818.6217895836635;5817.7382017809305;5847.064469684915;5856.12158176277;5868.559858010666;5915.08316210988;5646.2377579027125;5773.538116950634;5793.594448388657;5799.449052340021;5830.212921255661;4379.430674012422;4414.183376075436;4422.491413487426;4456.108778244364;4460.085682435093;3939.1333906540517;3944.230874979409;3947.5460322062754;3956.9604303956594;3990.5809889961715;5489.286392768914;5572.526335261548;5605.887882242332;5647.576431767634;5689.260396148474;5820.3888591698105;5844.47399734026;5845.503132233723;5851.239338886003;5886.352501224862;5455.399906010336;5489.451054894478;5493.258410114663;5496.945030549723;5545.445455454423;4869.513048695173;4891.6575839691595;4919.704817710949;4986.152354099811;5040.294358789773;6039.48664363534;6041.667708275999;6071.9696401518595;6077.17958075663;6091.14723938649;5836.708164591669;5847.415258474203;5850.356460789395;5870.236869206976;5876;5969.8806023878415;6034.306054803754;6039.909401358896;6061.212042434456;6112.755489780359;5701.287339082614;5708.372079071381;5713.942860571341;5714.3999880012;5763.769449221984;5765.308163020464;5772.04761214395;5816.592838501264;5819.330776960704;5820.563457740771;5601.04782187021;5678;5690.857728556819;5810.6513609183585;5832.708364581838;5671.489565939085;5687.488126068508;5687.630304030225;5695.601307908407;5704.3154821421695;5568.972155139199;5570.58220633446;5597.6641401516035;5619.80330688424;5633.2395126657375;5635.520980716685;5735.799247026334;5764.962306784819;5839.620424672383;5873.03094989322;5518.80684176068;5536.640118392453;5564.10974244119;5566.4990150886615;5581 19:27:48 INFO - PROCESS | 10143 | |1;ext.html;599.7930713903704;659.7855696898507;665.7902760630402;669.6116252573507;682.9590224586528;34540;36311;36342.454863177074;36536.269274614526;36595.26809463816;37241.62758372422;37399.25201495968;37516.43725344115;37786.81106594463;37903.24193516128;8203.138670439608;8350.33197344214;8399.110200204936;8410.36922230832;8416.032156302012;8290.253877151055;8477.109903460141;8528.872066919;8567.100454452286;8575.313974882025;8554.230119289263;8578.270846978014;8591.183837535424;8596.527191004492;8600.655973761042;8411.537365444898;8536.78658033548;8593.14068593142;8602.698905538307;8609.913900860975;8478.491290522588;8562.443441176303;8565.95717021411;8599.82800343996;8609.182127697859;33963.32073358519;36802;37241.62758372409;37291;37292;3367.579052618423;3378.3243351329834;3524.8766293179874;3570.1788588624763;3616.8553257869653;26298.73701262982;26925.192244232705;28346.574801377996;28577.428451431064;28593.14220573386;3868.903277418087;3881.3789793633164;3899.2786334528205;3940.310445671996;3979;230567;230602;231622;232438;232519;33485.16287092842;34032.14919627029;34109.48835767466;34902.65097348994;35945.28109437797;34336.141596460286;34423.65576344255;34454.13864653404;34459;34527.96416107521;14586.635334116732;14705.044172128777;14740.262986850614;14754.557363279118;14756.262186890612;12751.48994040228;12761.29812860283;12802.231866088065;12807;12807.103502754717;8478.025027121837;8531.317494600416;8581.528015959057;8600.526971016528;8624.913750862412;3343.849526771301;3394.694477496988;3415.2315728960784;3416.6754158354915;3421.828908554612;1058.8941105889348;1067.7010437077631;1091.252665060623;1170.151640060949;1194.1521519721096;31137.844310778753;31538.36923261522;31617;32041.679583204335;32096.679033209835;1160.2400427719856;1175.2478413815165;1181.8358916467273;1212.8180772884139;1216.318861437598;16547.338106475607;16716.916415418087;16731.665366692843;16765.413210537816;17066.775463089692;423298;432981.67018329416;434432;435168;435647.82176088914;56268.43731562714;57101;57314;57324;57377.71311143501;1361.3057340756088;1384.4946594492937;1423.238567366454;1434.4047220403625;1439.8632129947848;30048.248793779458;30354.937577184694;30575.388492230475;30617.693823062375;30777.846110769304;49208.2618760726;49452.50547494479;49856.50143498664;49989.50031499061;50194;385256;389440;389983;390347;391279;27451.862740686167;27639;27670.861645691642;27693.86153069222;27868.581971270043;47067;47191.292130618756;47348.76325618487;47376;48485;39617.40573891452;40383.39424908687;40484;40846;41143.7942810284;37846.62153378541;38600.227995439374;39266.80366598149;39941;39984;40836.1832763349;41041.79479102585;41072.589274108075;42361.57638423699;42574.935626609586;32433;34844.65155348414;35021.124471888405;35038.12404689903;35364;27342.31644208831;27942.58086128669;28020.57969130424;28033.85983070153;28099.71900280971 19:27:48 INFO - PROCESS | 10143 | |2;jquery.html;389.41198789827354;393.290111349015;394.8558776046742;398.64122289939036;404.31468660620243;13697;16708.49874503764;16860.32558697652;17468.21393037313;17471.03909284989;17960.371387001458;18257.08714564273;18483.81516184841;19468.610627787435;19526.316578919705;5634.6337488063145;5671.092625179972;5691.573132015115;5752.079667253241;5763.164341170528;5698.401667824881;5745.109508026242;5751.194832723422;5760.711964401784;5770.480656740892;5104.974475127619;5418.9458105419035;5422.213779002042;5424.430434804348;5640.802571909963;5150.922736158961;5237.659552129118;5271.051210782077;5304.787808487656;5506.779728810843;5302.204669299597;5318.787248510055;5331.280277162572;5339.866503337409;5352.652077614982;12129.93935030328;12840.293783841886;12881;12945.676358091028;12953.676158096028;2130.840186985982;2165.069020321261;2190.397640648818;2211.5687440949023;2344.4598656029348;9031;9338.486383248919;9362.859557106649;9477.90522094777;9510.38182518134;1730.774999250102;1831.4871835885974;1875.2124107874724;1876.4464482977555;1939.2727727102338;75941.62029189874;78875.60562197209;80008.19991800065;80251;80964;9988.900110998942;10409.115225205791;10875.293105948247;10996.780064398667;11055.613053543088;12504.562340318045;12769.297688627028;15383.846161538466;15484.845151548341;15499.767503487457;5809.419058094241;5934.228550288522;6731.697073631698;7910;7938.56337901421;7690.269424404784;7726.497777644435;7815.53106813593;7875.488093273919;7880.64537095832;4219.346001369792;4283.186194623012;4530.9980401398925;4544.091181763661;4640.141573808856;1920.2798950393603;1940.621578792122;1945.727598136262;1975.9308424205083;1981.3758666020447;976.3312131190157;1038.6312858934969;1100.5398311908984;1127.115214556569;1155.8150695888617;17906.641867162845;18378.63242735138;18727.812721872608;18797;19209;1004.4826914139225;1033.679559336608;1048.7902419516126;1057.6879820452984;1067.3329169269207;10577.9471102644;10663.626773062906;10956.233063685624;10969.122470202365;11017.614383496699;475231.3669021568;488395;494192;503038;506411;54094.16428450454;65673.01490477647;84776;89338;93735.53132234295;1056.4981633724074;1091.4815462655176;1096.9012788849043;1100.818364969771;1104.8397982292522;16791;17165.57086072858;17330.480085597454;17684;17819.376321828673;35571.82214088913;37049.44425833561;39601.40597890977;40104;40758.1848363037;48884;48960.75519622379;49230.50769492259;49518.50481495139;49545.50454495409;7875.173106823701;8149.429539932148;8261.463004904663;8366.163383661586;8529.14708529142;8975.640974361213;9440.339176257596;10850.620228291971;12038.638840834788;13070.54253101137;11474.139439541901;12043.277403355827;12068.215565988183;12190;12227.449764760786;11370.658880233606;11623.709407264885;11685.948264656221;11739.060875129799;11844.407779611158;12000.519979200733;12139.271643701406;12460.43928023223;12475.189112707645;12700.936495317465;8110.635021423932;8139.1453897339925;8182.427230093836;8290.419670622998;8392.496450213006;10794.946025269823;11539.192256542297;11620.244684095507;11759.353235572125;11802.704932376759 19:27:48 INFO - PROCESS | 10143 | |3;mootools.html;1389.1456754096228;1484.6807936293699;1565.2173913043478;1827.6892928202203;1877.3429299745083;7789.376849852012;8047.195280471965;8323.87514187287;8519.233269005796;8525.062243153256;8053.315468185211;8087.312578430826;8092.919070809305;8101.149379315176;8148.837023259532;2225.710657614508;2248.9437764055865;2253.0874995626796;2258.0516183203094;2261.185973049701;2238.507528343762;2246.269962262263;2260.0507786729613;2278.1229226747737;2279.9658005129854;2220.467087898901;2253.2001139595454;2272.216085450517;2273.386185729852;2287.2452090810075;2155.892205389732;2159.6652518859523;2171.1966572368246;2172.858764180339;2178.237616834111;2123.490362313049;2125.861818981761;2135.487483004068;2138.134055707441;2142.775008624103;8151.755447336589;8278.503289802571;8303;8313.210245026712;8343.08226095129;5063.822766203202;5213.687178769286;5235.947640523584;5265.736713164365;5266.394364648077;3090.3819236152635;3140.623125224965;3226.56441380413;3231.353729254135;3254.23525471514;972.7616733900239;982.7199248214224;987.3680844259679;1004.3421558878946;1022.6062965758163;11476.139289553234;11657.883421165849;11685.941570292094;11687.123465740104;11735.94132029343;4377.693561450668;4421.292593185075;4564.406627138451;4569.794359253775;4580.564846339593;9912.207023438108;9945.353552019096;9954.800903982024;9967.700968970943;9980.950095249478;5217.817376391884;5228.111221092423;5237.083510385667;5237.764300606482;5241.790328386898;4326.805293761789;4738.763061846894;4800.279958006327;4851.393575803025;4881.316615673809;3858.2476417098396;3868.168343806095;3925.646691797752;3931.233409485123;3977.204559088194;1216.4647555075737;1229.164168365502;1237.6596435979998;1248.4132457744845;1252.3612957391795;915.9313051521162;959.2565761534867;1006.3961623026272;1030.7577719235974;1035.9015893490107;5928.258967629046;5948.553858460633;6019.097135429721;6022;6175.475084617858;433.559936664286;435.1449401925232;438.18278909833566;1028.753099256173;1090.4057288777476;4034.092329225901;4042.130941847517;4053.3717273822604;4072.2466343725914;4087.1008378156757;9851.45816980073;10651.147908167328;10804.1896857736;10848.67453976382;10862.619808306672;10560.260781745204;10712.73218169552;10724.356538607708;10725.195610329256;10804.243702940876;7928.563928983961;8088.514689118554;8111.026676798822;8114.8782768258525;8210.548419836967;5807.622504537191;5895.587308888336;5953.553483488669;5965.433283838029;6058.545609079425;9510.26903525441;9776.1690256329;9820.214382849212;9938.204943604638;9979.60081596728;9677.564509596945;9744.902550974399;9979.10188083076;10104.393736375841;10119.949400252952;6649.368310010541;7047.964760176166;7199.6760145794615;7246.094238220223;7288.016117824238;8272.420930535045;8276.08963014056;8281.668733250843;8285.212904774036;8344.123866994121;7214.242504536948;7466.290702383265;7493.775186744407;7537.886931696139;7559.697612095454;7251.927480725125;7295.963520182578;7406.666699998621;7421.92382104581;7436.293552112541;7094.964525177341;7123.679434425359;7157.463190260647;7167.749128780676;7213;5173.741312934413;5224.921626175535;5239.397469291081;5318.308619879391;5417.918731218956;5151.768170432414;5250.396204436539;5304.443033481583;5334.439883812144;5390.568754499709 19:27:48 INFO - PROCESS | 10143 | |4;prototype.html;315.79631137916044;322.5371591765816;326.85618327935714;328.2221135907899;328.5580893697978;5992.850178745528;6030.879382412355;6031.698415079245;6130.049842274443;6143.569950103494;5951.6726580038085;5999;6024.849378765533;6031.215941927554;6070.5447091468095;4333.739975601458;4398.8020539075815;4533.342665313544;4550.613197878168;4565.406497155365;4544.590986811187;4566.13243483737;4567.314902764579;4576.679632425731;4580.931286030712;4533.297338912474;4555.271156614942;4558.544145585448;4567.0409214065085;4579.564941330568;4218.135282267128;4441.178381999324;4443.466783985942;4455.598996090335;4459.598636122764;3796.2027974125467;3806.1626442182674;3812.942805857914;3823.2926908522013;3829.942550861739;5731.598788084836;5781.682007489587;5808.2449281593545;5819.206780745266;5832.133717210494;4970.801167953277;5069.44236134025;5082.186850104003;5093.770780314858;5134.792039423047;6156.815295541141;6167.735614199079;6180.289266734293;6195.845103872394;6218.751249949996;4183.602557757008;4185.455890734215;4196.769177695225;4205.9789701051295;4214.536400995888;6064.939350606525;6366.204224471941;6453.580517266362;6569.37590928861;6577.539572229945;4255;4264.168487144977;4271.380649805761;4285.442892423965;4296.140771845643;4300.376445415397;4333.090051089306;4369.279068953587;4378.496472905593;4380.364847097153;5104.3874735031295;5110.233464980209;5118.38579370478;5119.795208191705;5125.077486052472;6276.46650034743;6300;6305.959516679696;6312.305646378894;6332.461740752087;1488.3674438363653;1498.4980031689506;1529.678767458846;1530.5331873778605;1534.815822101355;927.4574373991156;986.3687240166299;991.1179050644931;999.7300728803183;1005.4570531912685;6021.879562408727;6037.215162028908;6039.1545183674325;6073.271207455045;6112.388761123852;6354.8411289717205;6384.744610215539;6406.743730250738;6439.774607888701;6460.967695161494;5836.649801011868;6119.785807496716;6152.753889844356;6164.938350616526;6190.876182476325;3472.461768425898;3483.3729928613093;3486.6861982421706;3499.16020155166;3510.789352638799;6549.443297319781;6870.31296870309;6878.140232470942;6903.413209877217;6923.134608173978;6726.159230096238;6727.159105111861;6735;6757.459403247728;6757.911463564571;6710.966445167841;6725.2602213756445;6861.794146175523;6882.311768823178;6895.586264824126;6566.9343306568235;6574.145361103026;6578.440832529289;6592.901106483502;6611.33886611335;6090.604110732788;6462.547621666438;6473.320301368477;6496.415322620986;6498.187726534184;6860.108185935796;6883;6912.44700423975;6913.170419549686;6914.170299564084;4236.364545318103;4291.334843099325;4299.742015479082;4302.118065796567;4307.956920430755;6371.267304259884;6494.512911531749;6580.769673061612;6588.670566471753;6599.307072757291;6335.65153916539;6344.048392740941;6348.619082855043;6361.300256971637;6378.808635740936;5959.821205363846;6295.685215739286;6298.559100862895;6322.557420980671;6376.139221205078;6116.5412594056515;6273.710095815086;6281.560290779602;6298.496120310272;6302.401271879165;6335.4931605472375;6429.935700642934;6430.7749228776765;6439.839004024937;6439.871202575829;6006.969965150146;6230.190075290183;6241.937580624136;6249.34381889895;6251.124842521959 19:27:48 INFO - PROCESS | 10143 | |5;yui.html;779.4310153587879;779.9025121859769;822.0833770346065;823.9670413183472;847.3179090831882;13935.37290821913;14018;14020.929895350535;14192.574222773308;14511.201883896381;13438.32808359583;13579.864201357983;13581.660458488543;13589.116707414036;13613.523526676569;691.6887400669693;811.5779794506852;822.0833770346051;835.7659855240512;836.3852568362249;824.6206744897354;831.3266254334009;833.5665453963935;835.1022650650575;836.1053672570353;880.0715245416084;883.9425437346584;886.1138861138861;887.2813021452612;888.4269646078276;880.5377176982136;881.8853549038616;881.9426737262057;884.1467983396021;884.1600479544394;639.25526761323;640.5196102922808;641.643887642363;643.2217017408941;645.4900628503476;13258.138221015699;13327.600171994856;13393.799093013613;13412.46350145993;13419.530316438877;13728.244946527937;14000.439982400692;14002.159870407706;14140.15159090458;14172.574822755334;11229.66311010671;11345.149113816497;11394.943025284903;11396.088312934946;11554.364509951949;3899.980500097481;3919.7256192066566;3954.9604503955165;3965.5637879833193;3965.8215380307665;55572.72213638906;55766;56091;56234.71882640561;56452.153217701765;10863.67408977732;10914.56341746337;10921.15818688249;11062.944685276521;11067.335959842274;19679.803201967796;19690.31083912056;19804.306849260207;19807.702884456743;19844.20623175057;8530.74407767768;8640;8646.740597782076;8685.782855428539;8760.8685869712;4642.117997580449;4666.883327916761;4687.156311863829;4713.410823647044;4862.635302352338;3226.467632840602;3288.835558222127;3291.2923721400016;3310.2386451116377;3333.5499707539657;577.2380457795754;584.6375247346588;588.4174667079646;593.2258402784407;593.4214141212284;791.1534657916089;798.3254150243035;805.6535689653505;808.6078252047752;830.1739768929954;9200.861987070199;9211.723648290563;9276.675316363895;9346.813063738688;9528;724.6992498113224;751.9812004699817;753.7211231844253;755.161770434817;765.7932358263238;4307;4443.888902777392;4502.122086193161;4511.278195488771;4593.908121837545;56857.71571142118;57335;59016.40983590195;59398.70300648469;59665.70167149136;52411.47588524142;52980.205296920576;52983.470165297855;53348.73325633347;55068.17397739037;46417.535824642;46663.76668116638;47929.76035119802;48167.75916120467;48429;8465.703700370457;8667;8724.476531408136;8792.824143516966;8845.336599754915;30530.389392212477;31074.22314442157;31916.361672766878;31917;32163.195920102185;40553.59446405498;41737;42404.5759542413;42443.15113697771;43060.78469607632;11247.493862776359;11427.885721142682;11500.82748758786;11978.401079945794;12034.879651203375;13755.10591811529;14033.146417445483;14368.13791172533;14390.496332628307;14447.78328325055;13041.739165216832;13071.542496012595;13551;13915.51295704686;14386.640333991734;12745.872541274468;13342.06605537603;13437.126586771828;13986.580402587939;14191.219482928538;13063.216207027608;13333.733325333633;13375.264360460269;13653.658658533615;13860.306984650928;11092.279001865176;11160.218784684994;11307.095432365555;11632.767344653228;11762.294262344287;11273.71815704614;11282.661520154408;11291.548338066385;11539.4807233673;11822.11334149925 19:27:48 INFO - PROCESS | 10143 | __end_tp_report 19:27:48 INFO - PROCESS | 10143 | __start_cc_report 19:27:48 INFO - PROCESS | 10143 | _x_x_mozilla_cycle_collect,349 19:27:48 INFO - PROCESS | 10143 | __end_cc_report 19:27:48 INFO - PROCESS | 10143 | __startTimestamp1460773668165__endTimestamp 19:27:48 INFO - PROCESS | 10143 | 19:27:48 INFO - PROCESS | 10143 | ------- Summary: start ------- 19:27:48 INFO - PROCESS | 10143 | Number of tests: 6 19:27:48 INFO - PROCESS | 10143 | 19:27:48 INFO - PROCESS | 10143 | [#0] dojo.html Cycles:165 Average:5408.36 Median:5619.80 stddev:614.54 (10.9%) stddev-sans-first:589.09 19:27:48 INFO - PROCESS | 10143 | Values: 3098.1 3163.7 3184.1 3187.7 3203.7 5480.9 5525.4 5529.6 5532.0 5533.8 5442.8 5476.9 5491.5 5503.7 5583.4 4917.2 4952.5 4953.5 5063.1 5111.5 5055.7 5073.2 5082.6 5115.7 5137.0 4795.0 4854.1 4882.9 4928.8 5046.6 4923.6 4926.5 4926.9 4937.9 4962.3 4866.1 4898.6 4906.4 4916.2 4957.7 5282.6 5290.9 5324.1 5371.7 5386.2 5759.5 5776.3 5783.8 5793.2 5795.4 5750.9 5763.2 5782.7 5801.0 5812.8 5398.6 5432.5 5435.6 5458.5 5469.0 5861.9 5935.0 5938.9 5941.2 5958.0 5680.1 5698.2 5702.7 5713.7 5746.9 5721.5 5740.8 5749.2 5794.1 5818.6 5817.7 5847.1 5856.1 5868.6 5915.1 5646.2 5773.5 5793.6 5799.4 5830.2 4379.4 4414.2 4422.5 4456.1 4460.1 3939.1 3944.2 3947.5 3957.0 3990.6 5489.3 5572.5 5605.9 5647.6 5689.3 5820.4 5844.5 5845.5 5851.2 5886.4 5455.4 5489.5 5493.3 5496.9 5545.4 4869.5 4891.7 4919.7 4986.2 5040.3 6039.5 6041.7 6072.0 6077.2 6091.1 5836.7 5847.4 5850.4 5870.2 5876.0 5969.9 6034.3 6039.9 6061.2 6112.8 5701.3 5708.4 5713.9 5714.4 5763.8 5765.3 5772.0 5816.6 5819.3 5820.6 5601.0 5678.0 5690.9 5810.7 5832.7 5671.5 5687.5 5687.6 5695.6 5704.3 5569.0 5570.6 5597.7 5619.8 5633.2 5635.5 5735.8 5765.0 5839.6 5873.0 5518.8 5536.6 5564.1 5566.5 5581.0 19:27:48 INFO - PROCESS | 10143 | 19:27:48 INFO - PROCESS | 10143 | [#1] ext.html Cycles:180 Average:49951.54 Median:36698.63 stddev:95736.39 (260.9%) stddev-sans-first:95933.25 19:27:48 INFO - PROCESS | 10143 | Values: 599.8 659.8 665.8 669.6 683.0 34540.0 36311.0 36342.5 36536.3 36595.3 37241.6 37399.3 37516.4 37786.8 37903.2 8203.1 8350.3 8399.1 8410.4 8416.0 8290.3 8477.1 8528.9 8567.1 8575.3 8554.2 8578.3 8591.2 8596.5 8600.7 8411.5 8536.8 8593.1 8602.7 8609.9 8478.5 8562.4 8566.0 8599.8 8609.2 33963.3 36802.0 37241.6 37291.0 37292.0 3367.6 3378.3 3524.9 3570.2 3616.9 26298.7 26925.2 28346.6 28577.4 28593.1 3868.9 3881.4 3899.3 3940.3 3979.0 230567.0 230602.0 231622.0 232438.0 232519.0 33485.2 34032.1 34109.5 34902.7 35945.3 34336.1 34423.7 34454.1 34459.0 34528.0 14586.6 14705.0 14740.3 14754.6 14756.3 12751.5 12761.3 12802.2 12807.0 12807.1 8478.0 8531.3 8581.5 8600.5 8624.9 3343.8 3394.7 3415.2 3416.7 3421.8 1058.9 1067.7 1091.3 1170.2 1194.2 31137.8 31538.4 31617.0 32041.7 32096.7 1160.2 1175.2 1181.8 1212.8 1216.3 16547.3 16716.9 16731.7 16765.4 17066.8 423298.0 432981.7 434432.0 435168.0 435647.8 56268.4 57101.0 57314.0 57324.0 57377.7 1361.3 1384.5 1423.2 1434.4 1439.9 30048.2 30354.9 30575.4 30617.7 30777.8 49208.3 49452.5 49856.5 49989.5 50194.0 385256.0 389440.0 389983.0 390347.0 391279.0 27451.9 27639.0 27670.9 27693.9 27868.6 47067.0 47191.3 47348.8 47376.0 48485.0 39617.4 40383.4 40484.0 40846.0 41143.8 37846.6 38600.2 39266.8 39941.0 39984.0 40836.2 41041.8 41072.6 42361.6 42574.9 32433.0 34844.7 35021.1 35038.1 35364.0 27342.3 27942.6 28020.6 28033.9 28099.7 19:27:48 INFO - PROCESS | 10143 | 19:27:48 INFO - PROCESS | 10143 | [#2] jquery.html Cycles:180 Average:27726.18 Median:18958.14 stddev:81098.70 (427.8%) stddev-sans-first:81300.22 19:27:48 INFO - PROCESS | 10143 | Values: 389.4 393.3 394.9 398.6 404.3 13697.0 16708.5 16860.3 17468.2 17471.0 17960.4 18257.1 18483.8 19468.6 19526.3 5634.6 5671.1 5691.6 5752.1 5763.2 5698.4 5745.1 5751.2 5760.7 5770.5 5105.0 5418.9 5422.2 5424.4 5640.8 5150.9 5237.7 5271.1 5304.8 5506.8 5302.2 5318.8 5331.3 5339.9 5352.7 12129.9 12840.3 12881.0 12945.7 12953.7 2130.8 2165.1 2190.4 2211.6 2344.5 9031.0 9338.5 9362.9 9477.9 9510.4 1730.8 1831.5 1875.2 1876.4 1939.3 75941.6 78875.6 80008.2 80251.0 80964.0 9988.9 10409.1 10875.3 10996.8 11055.6 12504.6 12769.3 15383.8 15484.8 15499.8 5809.4 5934.2 6731.7 7910.0 7938.6 7690.3 7726.5 7815.5 7875.5 7880.6 4219.3 4283.2 4531.0 4544.1 4640.1 1920.3 1940.6 1945.7 1975.9 1981.4 976.3 1038.6 1100.5 1127.1 1155.8 17906.6 18378.6 18727.8 18797.0 19209.0 1004.5 1033.7 1048.8 1057.7 1067.3 10577.9 10663.6 10956.2 10969.1 11017.6 475231.4 488395.0 494192.0 503038.0 506411.0 54094.2 65673.0 84776.0 89338.0 93735.5 1056.5 1091.5 1096.9 1100.8 1104.8 16791.0 17165.6 17330.5 17684.0 17819.4 35571.8 37049.4 39601.4 40104.0 40758.2 48884.0 48960.8 49230.5 49518.5 49545.5 7875.2 8149.4 8261.5 8366.2 8529.1 8975.6 9440.3 10850.6 12038.6 13070.5 11474.1 12043.3 12068.2 12190.0 12227.4 11370.7 11623.7 11685.9 11739.1 11844.4 12000.5 12139.3 12460.4 12475.2 12700.9 8110.6 8139.1 8182.4 8290.4 8392.5 10794.9 11539.2 11620.2 11759.4 11802.7 19:27:48 INFO - PROCESS | 10143 | 19:27:48 INFO - PROCESS | 10143 | [#3] mootools.html Cycles:180 Average:5628.82 Median:5221.37 stddev:3176.18 (60.8%) stddev-sans-first:3169.11 19:27:48 INFO - PROCESS | 10143 | Values: 1389.1 1484.7 1565.2 1827.7 1877.3 7789.4 8047.2 8323.9 8519.2 8525.1 8053.3 8087.3 8092.9 8101.1 8148.8 2225.7 2248.9 2253.1 2258.1 2261.2 2238.5 2246.3 2260.1 2278.1 2280.0 2220.5 2253.2 2272.2 2273.4 2287.2 2155.9 2159.7 2171.2 2172.9 2178.2 2123.5 2125.9 2135.5 2138.1 2142.8 8151.8 8278.5 8303.0 8313.2 8343.1 5063.8 5213.7 5235.9 5265.7 5266.4 3090.4 3140.6 3226.6 3231.4 3254.2 972.8 982.7 987.4 1004.3 1022.6 11476.1 11657.9 11685.9 11687.1 11735.9 4377.7 4421.3 4564.4 4569.8 4580.6 9912.2 9945.4 9954.8 9967.7 9981.0 5217.8 5228.1 5237.1 5237.8 5241.8 4326.8 4738.8 4800.3 4851.4 4881.3 3858.2 3868.2 3925.6 3931.2 3977.2 1216.5 1229.2 1237.7 1248.4 1252.4 915.9 959.3 1006.4 1030.8 1035.9 5928.3 5948.6 6019.1 6022.0 6175.5 433.6 435.1 438.2 1028.8 1090.4 4034.1 4042.1 4053.4 4072.2 4087.1 9851.5 10651.1 10804.2 10848.7 10862.6 10560.3 10712.7 10724.4 10725.2 10804.2 7928.6 8088.5 8111.0 8114.9 8210.5 5807.6 5895.6 5953.6 5965.4 6058.5 9510.3 9776.2 9820.2 9938.2 9979.6 9677.6 9744.9 9979.1 10104.4 10119.9 6649.4 7048.0 7199.7 7246.1 7288.0 8272.4 8276.1 8281.7 8285.2 8344.1 7214.2 7466.3 7493.8 7537.9 7559.7 7251.9 7296.0 7406.7 7421.9 7436.3 7095.0 7123.7 7157.5 7167.7 7213.0 5173.7 5224.9 5239.4 5318.3 5417.9 5151.8 5250.4 5304.4 5334.4 5390.6 19:27:48 INFO - PROCESS | 10143 | 19:27:48 INFO - PROCESS | 10143 | [#4] prototype.html Cycles:180 Average:5250.67 Median:6071.91 stddev:1633.50 (26.9%) stddev-sans-first:1595.53 19:27:48 INFO - PROCESS | 10143 | Values: 315.8 322.5 326.9 328.2 328.6 5992.9 6030.9 6031.7 6130.0 6143.6 5951.7 5999.0 6024.8 6031.2 6070.5 4333.7 4398.8 4533.3 4550.6 4565.4 4544.6 4566.1 4567.3 4576.7 4580.9 4533.3 4555.3 4558.5 4567.0 4579.6 4218.1 4441.2 4443.5 4455.6 4459.6 3796.2 3806.2 3812.9 3823.3 3829.9 5731.6 5781.7 5808.2 5819.2 5832.1 4970.8 5069.4 5082.2 5093.8 5134.8 6156.8 6167.7 6180.3 6195.8 6218.8 4183.6 4185.5 4196.8 4206.0 4214.5 6064.9 6366.2 6453.6 6569.4 6577.5 4255.0 4264.2 4271.4 4285.4 4296.1 4300.4 4333.1 4369.3 4378.5 4380.4 5104.4 5110.2 5118.4 5119.8 5125.1 6276.5 6300.0 6306.0 6312.3 6332.5 1488.4 1498.5 1529.7 1530.5 1534.8 927.5 986.4 991.1 999.7 1005.5 6021.9 6037.2 6039.2 6073.3 6112.4 6354.8 6384.7 6406.7 6439.8 6461.0 5836.6 6119.8 6152.8 6164.9 6190.9 3472.5 3483.4 3486.7 3499.2 3510.8 6549.4 6870.3 6878.1 6903.4 6923.1 6726.2 6727.2 6735.0 6757.5 6757.9 6711.0 6725.3 6861.8 6882.3 6895.6 6566.9 6574.1 6578.4 6592.9 6611.3 6090.6 6462.5 6473.3 6496.4 6498.2 6860.1 6883.0 6912.4 6913.2 6914.2 4236.4 4291.3 4299.7 4302.1 4308.0 6371.3 6494.5 6580.8 6588.7 6599.3 6335.7 6344.0 6348.6 6361.3 6378.8 5959.8 6295.7 6298.6 6322.6 6376.1 6116.5 6273.7 6281.6 6298.5 6302.4 6335.5 6429.9 6430.8 6439.8 6439.9 6007.0 6230.2 6241.9 6249.3 6251.1 19:27:48 INFO - PROCESS | 10143 | 19:27:48 INFO - PROCESS | 10143 | [#5] yui.html Cycles:180 Average:14595.55 Median:4375.44 stddev:16388.39 (374.6%) stddev-sans-first:16401.52 19:27:48 INFO - PROCESS | 10143 | Values: 779.4 779.9 822.1 824.0 847.3 13935.4 14018.0 14020.9 14192.6 14511.2 13438.3 13579.9 13581.7 13589.1 13613.5 691.7 811.6 822.1 835.8 836.4 824.6 831.3 833.6 835.1 836.1 880.1 883.9 886.1 887.3 888.4 880.5 881.9 881.9 884.1 884.2 639.3 640.5 641.6 643.2 645.5 13258.1 13327.6 13393.8 13412.5 13419.5 13728.2 14000.4 14002.2 14140.2 14172.6 11229.7 11345.1 11394.9 11396.1 11554.4 3900.0 3919.7 3955.0 3965.6 3965.8 55572.7 55766.0 56091.0 56234.7 56452.2 10863.7 10914.6 10921.2 11062.9 11067.3 19679.8 19690.3 19804.3 19807.7 19844.2 8530.7 8640.0 8646.7 8685.8 8760.9 4642.1 4666.9 4687.2 4713.4 4862.6 3226.5 3288.8 3291.3 3310.2 3333.5 577.2 584.6 588.4 593.2 593.4 791.2 798.3 805.7 808.6 830.2 9200.9 9211.7 9276.7 9346.8 9528.0 724.7 752.0 753.7 755.2 765.8 4307.0 4443.9 4502.1 4511.3 4593.9 56857.7 57335.0 59016.4 59398.7 59665.7 52411.5 52980.2 52983.5 53348.7 55068.2 46417.5 46663.8 47929.8 48167.8 48429.0 8465.7 8667.0 8724.5 8792.8 8845.3 30530.4 31074.2 31916.4 31917.0 32163.2 40553.6 41737.0 42404.6 42443.2 43060.8 11247.5 11427.9 11500.8 11978.4 12034.9 13755.1 14033.1 14368.1 14390.5 14447.8 13041.7 13071.5 13551.0 13915.5 14386.6 12745.9 13342.1 13437.1 13986.6 14191.2 13063.2 13333.7 13375.3 13653.7 13860.3 11092.3 11160.2 11307.1 11632.8 11762.3 11273.7 11282.7 11291.5 11539.5 11822.1 19:27:48 INFO - PROCESS | 10143 | -------- Summary: end -------- 19:27:48 INFO - PROCESS | 10143 | 19:27:48 INFO - TEST-INFO | 10143: exit 0 19:27:48 INFO - TEST-OK | dromaeo_css | took 1109949ms 19:27:48 INFO - TEST-START | kraken 19:27:48 INFO - operating with platform_type : linux_ 19:27:48 INFO - Initialising browser for kraken test... 19:27:48 INFO - TEST-INFO | started process 10374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGSFzvt/profile http://localhost:39024/getInfo.html) 19:27:52 INFO - PROCESS | 10374 | 19:27:52 INFO - PROCESS | 10374 | (process:10442): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:27:52 INFO - PROCESS | 10374 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 19:27:53 INFO - PROCESS | 10374 | __metrics Screen width/height:1600/1200 19:27:53 INFO - PROCESS | 10374 | colorDepth:24 19:27:53 INFO - PROCESS | 10374 | Browser inner width/height: 1024/697 19:27:53 INFO - PROCESS | 10374 | __metrics 19:27:54 ERROR - PROCESS | 10374 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:27:54 INFO - TEST-INFO | 10374: exit 0 19:27:54 INFO - Browser initialized. 19:27:54 INFO - Running cycle 1/1 for kraken test... 19:27:54 INFO - TEST-INFO | started process 10493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGSFzvt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:56 INFO - PROCESS | 10493 | 19:27:56 INFO - PROCESS | 10493 | (process:10554): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:28:06 INFO - PROCESS | 10493 | RSS: Main: 163635200 19:28:06 INFO - PROCESS | 10493 | 19:28:09 INFO - PROCESS | 10493 | Cycle 1(1): loaded http://localhost:39024/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39024/tests/kraken/driver.html?testName=audio-beat-detection) 19:28:10 INFO - PROCESS | 10493 | RSS: Main: 168329216 19:28:10 INFO - PROCESS | 10493 | 19:28:12 INFO - PROCESS | 10493 | Cycle 1(1): loaded http://localhost:39024/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39024/tests/kraken/driver.html?testName=audio-dft) 19:28:13 INFO - PROCESS | 10493 | RSS: Main: 171503616 19:28:13 INFO - PROCESS | 10493 | 19:28:16 INFO - PROCESS | 10493 | Cycle 1(1): loaded http://localhost:39024/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39024/tests/kraken/driver.html?testName=audio-fft) 19:28:16 INFO - PROCESS | 10493 | RSS: Main: 162529280 19:28:16 INFO - PROCESS | 10493 | 19:28:19 INFO - PROCESS | 10493 | Cycle 1(1): loaded http://localhost:39024/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39024/tests/kraken/driver.html?testName=audio-oscillator) 19:28:19 INFO - PROCESS | 10493 | RSS: Main: 163065856 19:28:19 INFO - PROCESS | 10493 | 19:28:22 INFO - PROCESS | 10493 | Cycle 1(1): loaded http://localhost:39024/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39024/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:28:22 INFO - PROCESS | 10493 | RSS: Main: 163540992 19:28:22 INFO - PROCESS | 10493 | 19:28:25 INFO - PROCESS | 10493 | Cycle 1(1): loaded http://localhost:39024/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39024/tests/kraken/driver.html?testName=imaging-darkroom) 19:28:26 INFO - PROCESS | 10493 | RSS: Main: 163762176 19:28:26 INFO - PROCESS | 10493 | 19:28:29 INFO - PROCESS | 10493 | Cycle 1(1): loaded http://localhost:39024/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39024/tests/kraken/driver.html?testName=imaging-desaturate) 19:28:30 INFO - PROCESS | 10493 | RSS: Main: 166744064 19:28:30 INFO - PROCESS | 10493 | 19:28:33 INFO - PROCESS | 10493 | Cycle 1(1): loaded http://localhost:39024/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39024/tests/kraken/driver.html?testName=json-parse-financial) 19:28:33 INFO - PROCESS | 10493 | RSS: Main: 166244352 19:28:33 INFO - PROCESS | 10493 | 19:28:35 INFO - PROCESS | 10493 | Cycle 1(1): loaded http://localhost:39024/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39024/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:28:35 INFO - PROCESS | 10493 | RSS: Main: 166162432 19:28:35 INFO - PROCESS | 10493 | 19:28:37 INFO - PROCESS | 10493 | Cycle 1(1): loaded http://localhost:39024/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39024/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:28:38 INFO - PROCESS | 10493 | RSS: Main: 166133760 19:28:38 INFO - PROCESS | 10493 | 19:28:40 INFO - PROCESS | 10493 | Cycle 1(1): loaded http://localhost:39024/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39024/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:28:41 INFO - PROCESS | 10493 | RSS: Main: 166662144 19:28:41 INFO - PROCESS | 10493 | 19:28:43 INFO - PROCESS | 10493 | Cycle 1(1): loaded http://localhost:39024/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:28:44 INFO - PROCESS | 10493 | RSS: Main: 167223296 19:28:44 INFO - PROCESS | 10493 | 19:28:47 INFO - PROCESS | 10493 | Cycle 1(1): loaded http://localhost:39024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:28:47 INFO - PROCESS | 10493 | RSS: Main: 166424576 19:28:47 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | Cycle 1(1): loaded http://localhost:39024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39024/tests/kraken/driver.html?testName=ai-astar) 19:28:49 INFO - PROCESS | 10493 | RSS: Main: 168198144 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | __start_tp_report 19:28:49 INFO - PROCESS | 10493 | _x_x_mozilla_page_load 19:28:49 INFO - PROCESS | 10493 | _x_x_mozilla_page_load_details 19:28:49 INFO - PROCESS | 10493 | |i|pagename|runs| 19:28:49 INFO - PROCESS | 10493 | |0;ai-astar;112;107;114;114;113;122;113;112;111;111 19:28:49 INFO - PROCESS | 10493 | |1;audio-beat-detection;160;128;154;183;131;157;159;141;185;132 19:28:49 INFO - PROCESS | 10493 | |2;audio-dft;162;163;162;161;161;163;173;165;166;163 19:28:49 INFO - PROCESS | 10493 | |3;audio-fft;76;77;76;165;77;77;73;74;166;76 19:28:49 INFO - PROCESS | 10493 | |4;audio-oscillator;91;93;146;93;92;91;137;93;93;155 19:28:49 INFO - PROCESS | 10493 | |5;imaging-gaussian-blur;117;118;118;117;117;119;118;117;117;117 19:28:49 INFO - PROCESS | 10493 | |6;imaging-darkroom;147;147;147;145;146;147;148;146;148;145 19:28:49 INFO - PROCESS | 10493 | |7;imaging-desaturate;96;95;95;95;95;95;95;96;95;95 19:28:49 INFO - PROCESS | 10493 | |8;json-parse-financial;62;59;57;59;58;62;58;74;62;58 19:28:49 INFO - PROCESS | 10493 | |9;json-stringify-tinderbox;61;61;60;61;61;60;61;65;61;60 19:28:49 INFO - PROCESS | 10493 | |10;stanford-crypto-aes;77;78;79;78;78;79;79;79;81;86 19:28:49 INFO - PROCESS | 10493 | |11;stanford-crypto-ccm;136;123;133;132;129;125;127;134;158;129 19:28:49 INFO - PROCESS | 10493 | |12;stanford-crypto-pbkdf2;169;166;166;168;176;165;169;166;176;169 19:28:49 INFO - PROCESS | 10493 | |13;stanford-crypto-sha256-iterative;69;67;69;70;72;68;68;70;67;70 19:28:49 INFO - PROCESS | 10493 | __end_tp_report 19:28:49 INFO - PROCESS | 10493 | __start_cc_report 19:28:49 INFO - PROCESS | 10493 | _x_x_mozilla_cycle_collect,856 19:28:49 INFO - PROCESS | 10493 | __end_cc_report 19:28:49 INFO - PROCESS | 10493 | __startTimestamp1460773729714__endTimestamp 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | ------- Summary: start ------- 19:28:49 INFO - PROCESS | 10493 | Number of tests: 14 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:3.78 (3.3%) stddev-sans-first:4.00 19:28:49 INFO - PROCESS | 10493 | Values: 112.0 107.0 114.0 114.0 113.0 122.0 113.0 112.0 111.0 111.0 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:158.00 stddev:20.33 (12.9%) stddev-sans-first:21.41 19:28:49 INFO - PROCESS | 10493 | Values: 160.0 128.0 154.0 183.0 131.0 157.0 159.0 141.0 185.0 132.0 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:3.57 (2.2%) stddev-sans-first:3.72 19:28:49 INFO - PROCESS | 10493 | Values: 162.0 163.0 162.0 161.0 161.0 163.0 173.0 165.0 166.0 163.0 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.00 stddev:37.87 (49.8%) stddev-sans-first:39.62 19:28:49 INFO - PROCESS | 10493 | Values: 76.0 77.0 76.0 165.0 77.0 77.0 73.0 74.0 166.0 76.0 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:92.50 stddev:26.30 (28.4%) stddev-sans-first:27.13 19:28:49 INFO - PROCESS | 10493 | Values: 91.0 93.0 146.0 93.0 92.0 91.0 137.0 93.0 93.0 155.0 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 19:28:49 INFO - PROCESS | 10493 | Values: 117.0 118.0 118.0 117.0 117.0 119.0 118.0 117.0 117.0 117.0 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 19:28:49 INFO - PROCESS | 10493 | Values: 147.0 147.0 147.0 145.0 146.0 147.0 148.0 146.0 148.0 145.0 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 19:28:49 INFO - PROCESS | 10493 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:60.50 stddev:4.98 (8.2%) stddev-sans-first:5.26 19:28:49 INFO - PROCESS | 10493 | Values: 62.0 59.0 57.0 59.0 58.0 62.0 58.0 74.0 62.0 58.0 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:1.45 (2.4%) stddev-sans-first:1.54 19:28:49 INFO - PROCESS | 10493 | Values: 61.0 61.0 60.0 61.0 61.0 60.0 61.0 65.0 61.0 60.0 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.55 (3.2%) stddev-sans-first:2.55 19:28:49 INFO - PROCESS | 10493 | Values: 77.0 78.0 79.0 78.0 78.0 79.0 79.0 79.0 81.0 86.0 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:132.50 stddev:9.81 (7.4%) stddev-sans-first:10.33 19:28:49 INFO - PROCESS | 10493 | Values: 136.0 123.0 133.0 132.0 129.0 125.0 127.0 134.0 158.0 129.0 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.00 stddev:3.97 (2.4%) stddev-sans-first:4.21 19:28:49 INFO - PROCESS | 10493 | Values: 169.0 166.0 166.0 168.0 176.0 165.0 169.0 166.0 176.0 169.0 19:28:49 INFO - PROCESS | 10493 | 19:28:49 INFO - PROCESS | 10493 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.56 (2.2%) stddev-sans-first:1.66 19:28:49 INFO - PROCESS | 10493 | Values: 69.0 67.0 69.0 70.0 72.0 68.0 68.0 70.0 67.0 70.0 19:28:49 INFO - PROCESS | 10493 | -------- Summary: end -------- 19:28:49 INFO - PROCESS | 10493 | 19:28:50 INFO - TEST-INFO | 10493: exit 0 19:28:50 INFO - TEST-OK | kraken | took 61797ms 19:28:50 INFO - SUITE-END | took 1171s 19:28:50 INFO - Completed test suite (00:19:31) 19:28:50 INFO - javascript benchmark 19:28:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3098.070578826352, 3163.6994485523874, 3184.124365799403, 3187.744980401567, 3203.711665950064, 5480.917786233204, 5525.419830917751, 5529.585281103913, 5531.9723401383035, 5533.750981205845, 5442.83671489855, 5476.91784623231, 5491.478309560585, 5503.697296648693, 5583.3858275589655, 4917.21324588066, 4952.455229924705, 4953.455119936804, 5063.113955057868, 5111.51440613143, 5055.6713813602, 5073.162928116856, 5082.593392528589, 5115.718635475047, 5136.974315128419, 4795.040991801636, 4854.077725232212, 4882.853514394574, 4928.827491037797, 5046.596272298226, 4923.58149557288, 4926.482719314492, 4926.876828079291, 4937.925931111036, 4962.330085438456, 4866.051120031595, 4898.608111351084, 4906.411230652309, 4916.1888288432365, 4957.702537847741, 5282.630215884889, 5290.92063619046, 5324.1215199492035, 5371.704556249405, 5386.245925570423, 5759.539236861041, 5776.277965254343, 5783.768649254025, 5793.217915581385, 5795.362510123883, 5750.942490575125, 5763.193152958589, 5782.653040817564, 5801.0428279333855, 5812.82561523155, 5398.568114550826, 5432.511074003359, 5435.565154787608, 5458.4541545845495, 5469.042917489423, 5861.88276234473, 5935.0, 5938.851528711817, 5941.197938278364, 5957.970210149008, 5680.14797780328, 5698.1737648041635, 5702.7433765480655, 5713.6857472838565, 5746.9425305747245, 5721.485066344049, 5740.770369185269, 5749.195112684228, 5794.130880367894, 5818.6217895836635, 5817.7382017809305, 5847.064469684915, 5856.12158176277, 5868.559858010666, 5915.08316210988, 5646.2377579027125, 5773.538116950634, 5793.594448388657, 5799.449052340021, 5830.212921255661, 4379.430674012422, 4414.183376075436, 4422.491413487426, 4456.108778244364, 4460.085682435093, 3939.1333906540517, 3944.230874979409, 3947.5460322062754, 3956.9604303956594, 3990.5809889961715, 5489.286392768914, 5572.526335261548, 5605.887882242332, 5647.576431767634, 5689.260396148474, 5820.3888591698105, 5844.47399734026, 5845.503132233723, 5851.239338886003, 5886.352501224862, 5455.399906010336, 5489.451054894478, 5493.258410114663, 5496.945030549723, 5545.445455454423, 4869.513048695173, 4891.6575839691595, 4919.704817710949, 4986.152354099811, 5040.294358789773, 6039.48664363534, 6041.667708275999, 6071.9696401518595, 6077.17958075663, 6091.14723938649, 5836.708164591669, 5847.415258474203, 5850.356460789395, 5870.236869206976, 5876.0, 5969.8806023878415, 6034.306054803754, 6039.909401358896, 6061.212042434456, 6112.755489780359, 5701.287339082614, 5708.372079071381, 5713.942860571341, 5714.3999880012, 5763.769449221984, 5765.308163020464, 5772.04761214395, 5816.592838501264, 5819.330776960704, 5820.563457740771, 5601.04782187021, 5678.0, 5690.857728556819, 5810.6513609183585, 5832.708364581838, 5671.489565939085, 5687.488126068508, 5687.630304030225, 5695.601307908407, 5704.3154821421695, 5568.972155139199, 5570.58220633446, 5597.6641401516035, 5619.80330688424, 5633.2395126657375, 5635.520980716685, 5735.799247026334, 5764.962306784819, 5839.620424672383, 5873.03094989322, 5518.80684176068, 5536.640118392453, 5564.10974244119, 5566.4990150886615, 5581.0], "value": 5366.810544273255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.7930713903704, 659.7855696898507, 665.7902760630402, 669.6116252573507, 682.9590224586528, 34540.0, 36311.0, 36342.454863177074, 36536.269274614526, 36595.26809463816, 37241.62758372422, 37399.25201495968, 37516.43725344115, 37786.81106594463, 37903.24193516128, 8203.138670439608, 8350.33197344214, 8399.110200204936, 8410.36922230832, 8416.032156302012, 8290.253877151055, 8477.109903460141, 8528.872066919, 8567.100454452286, 8575.313974882025, 8554.230119289263, 8578.270846978014, 8591.183837535424, 8596.527191004492, 8600.655973761042, 8411.537365444898, 8536.78658033548, 8593.14068593142, 8602.698905538307, 8609.913900860975, 8478.491290522588, 8562.443441176303, 8565.95717021411, 8599.82800343996, 8609.182127697859, 33963.32073358519, 36802.0, 37241.62758372409, 37291.0, 37292.0, 3367.579052618423, 3378.3243351329834, 3524.8766293179874, 3570.1788588624763, 3616.8553257869653, 26298.73701262982, 26925.192244232705, 28346.574801377996, 28577.428451431064, 28593.14220573386, 3868.903277418087, 3881.3789793633164, 3899.2786334528205, 3940.310445671996, 3979.0, 230567.0, 230602.0, 231622.0, 232438.0, 232519.0, 33485.16287092842, 34032.14919627029, 34109.48835767466, 34902.65097348994, 35945.28109437797, 34336.141596460286, 34423.65576344255, 34454.13864653404, 34459.0, 34527.96416107521, 14586.635334116732, 14705.044172128777, 14740.262986850614, 14754.557363279118, 14756.262186890612, 12751.48994040228, 12761.29812860283, 12802.231866088065, 12807.0, 12807.103502754717, 8478.025027121837, 8531.317494600416, 8581.528015959057, 8600.526971016528, 8624.913750862412, 3343.849526771301, 3394.694477496988, 3415.2315728960784, 3416.6754158354915, 3421.828908554612, 1058.8941105889348, 1067.7010437077631, 1091.252665060623, 1170.151640060949, 1194.1521519721096, 31137.844310778753, 31538.36923261522, 31617.0, 32041.679583204335, 32096.679033209835, 1160.2400427719856, 1175.2478413815165, 1181.8358916467273, 1212.8180772884139, 1216.318861437598, 16547.338106475607, 16716.916415418087, 16731.665366692843, 16765.413210537816, 17066.775463089692, 423298.0, 432981.67018329416, 434432.0, 435168.0, 435647.82176088914, 56268.43731562714, 57101.0, 57314.0, 57324.0, 57377.71311143501, 1361.3057340756088, 1384.4946594492937, 1423.238567366454, 1434.4047220403625, 1439.8632129947848, 30048.248793779458, 30354.937577184694, 30575.388492230475, 30617.693823062375, 30777.846110769304, 49208.2618760726, 49452.50547494479, 49856.50143498664, 49989.50031499061, 50194.0, 385256.0, 389440.0, 389983.0, 390347.0, 391279.0, 27451.862740686167, 27639.0, 27670.861645691642, 27693.86153069222, 27868.581971270043, 47067.0, 47191.292130618756, 47348.76325618487, 47376.0, 48485.0, 39617.40573891452, 40383.39424908687, 40484.0, 40846.0, 41143.7942810284, 37846.62153378541, 38600.227995439374, 39266.80366598149, 39941.0, 39984.0, 40836.1832763349, 41041.79479102585, 41072.589274108075, 42361.57638423699, 42574.935626609586, 32433.0, 34844.65155348414, 35021.124471888405, 35038.12404689903, 35364.0, 27342.31644208831, 27942.58086128669, 28020.57969130424, 28033.85983070153, 28099.71900280971], "value": 17782.716919911578, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.41198789827354, 393.290111349015, 394.8558776046742, 398.64122289939036, 404.31468660620243, 13697.0, 16708.49874503764, 16860.32558697652, 17468.21393037313, 17471.03909284989, 17960.371387001458, 18257.08714564273, 18483.81516184841, 19468.610627787435, 19526.316578919705, 5634.6337488063145, 5671.092625179972, 5691.573132015115, 5752.079667253241, 5763.164341170528, 5698.401667824881, 5745.109508026242, 5751.194832723422, 5760.711964401784, 5770.480656740892, 5104.974475127619, 5418.9458105419035, 5422.213779002042, 5424.430434804348, 5640.802571909963, 5150.922736158961, 5237.659552129118, 5271.051210782077, 5304.787808487656, 5506.779728810843, 5302.204669299597, 5318.787248510055, 5331.280277162572, 5339.866503337409, 5352.652077614982, 12129.93935030328, 12840.293783841886, 12881.0, 12945.676358091028, 12953.676158096028, 2130.840186985982, 2165.069020321261, 2190.397640648818, 2211.5687440949023, 2344.4598656029348, 9031.0, 9338.486383248919, 9362.859557106649, 9477.90522094777, 9510.38182518134, 1730.774999250102, 1831.4871835885974, 1875.2124107874724, 1876.4464482977555, 1939.2727727102338, 75941.62029189874, 78875.60562197209, 80008.19991800065, 80251.0, 80964.0, 9988.900110998942, 10409.115225205791, 10875.293105948247, 10996.780064398667, 11055.613053543088, 12504.562340318045, 12769.297688627028, 15383.846161538466, 15484.845151548341, 15499.767503487457, 5809.419058094241, 5934.228550288522, 6731.697073631698, 7910.0, 7938.56337901421, 7690.269424404784, 7726.497777644435, 7815.53106813593, 7875.488093273919, 7880.64537095832, 4219.346001369792, 4283.186194623012, 4530.9980401398925, 4544.091181763661, 4640.141573808856, 1920.2798950393603, 1940.621578792122, 1945.727598136262, 1975.9308424205083, 1981.3758666020447, 976.3312131190157, 1038.6312858934969, 1100.5398311908984, 1127.115214556569, 1155.8150695888617, 17906.641867162845, 18378.63242735138, 18727.812721872608, 18797.0, 19209.0, 1004.4826914139225, 1033.679559336608, 1048.7902419516126, 1057.6879820452984, 1067.3329169269207, 10577.9471102644, 10663.626773062906, 10956.233063685624, 10969.122470202365, 11017.614383496699, 475231.3669021568, 488395.0, 494192.0, 503038.0, 506411.0, 54094.16428450454, 65673.01490477647, 84776.0, 89338.0, 93735.53132234295, 1056.4981633724074, 1091.4815462655176, 1096.9012788849043, 1100.818364969771, 1104.8397982292522, 16791.0, 17165.57086072858, 17330.480085597454, 17684.0, 17819.376321828673, 35571.82214088913, 37049.44425833561, 39601.40597890977, 40104.0, 40758.1848363037, 48884.0, 48960.75519622379, 49230.50769492259, 49518.50481495139, 49545.50454495409, 7875.173106823701, 8149.429539932148, 8261.463004904663, 8366.163383661586, 8529.14708529142, 8975.640974361213, 9440.339176257596, 10850.620228291971, 12038.638840834788, 13070.54253101137, 11474.139439541901, 12043.277403355827, 12068.215565988183, 12190.0, 12227.449764760786, 11370.658880233606, 11623.709407264885, 11685.948264656221, 11739.060875129799, 11844.407779611158, 12000.519979200733, 12139.271643701406, 12460.43928023223, 12475.189112707645, 12700.936495317465, 8110.635021423932, 8139.1453897339925, 8182.427230093836, 8290.419670622998, 8392.496450213006, 10794.946025269823, 11539.192256542297, 11620.244684095507, 11759.353235572125, 11802.704932376759], "value": 8734.540145918385, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.1456754096228, 1484.6807936293699, 1565.2173913043478, 1827.6892928202203, 1877.3429299745083, 7789.376849852012, 8047.195280471965, 8323.87514187287, 8519.233269005796, 8525.062243153256, 8053.315468185211, 8087.312578430826, 8092.919070809305, 8101.149379315176, 8148.837023259532, 2225.710657614508, 2248.9437764055865, 2253.0874995626796, 2258.0516183203094, 2261.185973049701, 2238.507528343762, 2246.269962262263, 2260.0507786729613, 2278.1229226747737, 2279.9658005129854, 2220.467087898901, 2253.2001139595454, 2272.216085450517, 2273.386185729852, 2287.2452090810075, 2155.892205389732, 2159.6652518859523, 2171.1966572368246, 2172.858764180339, 2178.237616834111, 2123.490362313049, 2125.861818981761, 2135.487483004068, 2138.134055707441, 2142.775008624103, 8151.755447336589, 8278.503289802571, 8303.0, 8313.210245026712, 8343.08226095129, 5063.822766203202, 5213.687178769286, 5235.947640523584, 5265.736713164365, 5266.394364648077, 3090.3819236152635, 3140.623125224965, 3226.56441380413, 3231.353729254135, 3254.23525471514, 972.7616733900239, 982.7199248214224, 987.3680844259679, 1004.3421558878946, 1022.6062965758163, 11476.139289553234, 11657.883421165849, 11685.941570292094, 11687.123465740104, 11735.94132029343, 4377.693561450668, 4421.292593185075, 4564.406627138451, 4569.794359253775, 4580.564846339593, 9912.207023438108, 9945.353552019096, 9954.800903982024, 9967.700968970943, 9980.950095249478, 5217.817376391884, 5228.111221092423, 5237.083510385667, 5237.764300606482, 5241.790328386898, 4326.805293761789, 4738.763061846894, 4800.279958006327, 4851.393575803025, 4881.316615673809, 3858.2476417098396, 3868.168343806095, 3925.646691797752, 3931.233409485123, 3977.204559088194, 1216.4647555075737, 1229.164168365502, 1237.6596435979998, 1248.4132457744845, 1252.3612957391795, 915.9313051521162, 959.2565761534867, 1006.3961623026272, 1030.7577719235974, 1035.9015893490107, 5928.258967629046, 5948.553858460633, 6019.097135429721, 6022.0, 6175.475084617858, 433.559936664286, 435.1449401925232, 438.18278909833566, 1028.753099256173, 1090.4057288777476, 4034.092329225901, 4042.130941847517, 4053.3717273822604, 4072.2466343725914, 4087.1008378156757, 9851.45816980073, 10651.147908167328, 10804.1896857736, 10848.67453976382, 10862.619808306672, 10560.260781745204, 10712.73218169552, 10724.356538607708, 10725.195610329256, 10804.243702940876, 7928.563928983961, 8088.514689118554, 8111.026676798822, 8114.8782768258525, 8210.548419836967, 5807.622504537191, 5895.587308888336, 5953.553483488669, 5965.433283838029, 6058.545609079425, 9510.26903525441, 9776.1690256329, 9820.214382849212, 9938.204943604638, 9979.60081596728, 9677.564509596945, 9744.902550974399, 9979.10188083076, 10104.393736375841, 10119.949400252952, 6649.368310010541, 7047.964760176166, 7199.6760145794615, 7246.094238220223, 7288.016117824238, 8272.420930535045, 8276.08963014056, 8281.668733250843, 8285.212904774036, 8344.123866994121, 7214.242504536948, 7466.290702383265, 7493.775186744407, 7537.886931696139, 7559.697612095454, 7251.927480725125, 7295.963520182578, 7406.666699998621, 7421.92382104581, 7436.293552112541, 7094.964525177341, 7123.679434425359, 7157.463190260647, 7167.749128780676, 7213.0, 5173.741312934413, 5224.921626175535, 5239.397469291081, 5318.308619879391, 5417.918731218956, 5151.768170432414, 5250.396204436539, 5304.443033481583, 5334.439883812144, 5390.568754499709], "value": 4479.981006954819, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.79631137916044, 322.5371591765816, 326.85618327935714, 328.2221135907899, 328.5580893697978, 5992.850178745528, 6030.879382412355, 6031.698415079245, 6130.049842274443, 6143.569950103494, 5951.6726580038085, 5999.0, 6024.849378765533, 6031.215941927554, 6070.5447091468095, 4333.739975601458, 4398.8020539075815, 4533.342665313544, 4550.613197878168, 4565.406497155365, 4544.590986811187, 4566.13243483737, 4567.314902764579, 4576.679632425731, 4580.931286030712, 4533.297338912474, 4555.271156614942, 4558.544145585448, 4567.0409214065085, 4579.564941330568, 4218.135282267128, 4441.178381999324, 4443.466783985942, 4455.598996090335, 4459.598636122764, 3796.2027974125467, 3806.1626442182674, 3812.942805857914, 3823.2926908522013, 3829.942550861739, 5731.598788084836, 5781.682007489587, 5808.2449281593545, 5819.206780745266, 5832.133717210494, 4970.801167953277, 5069.44236134025, 5082.186850104003, 5093.770780314858, 5134.792039423047, 6156.815295541141, 6167.735614199079, 6180.289266734293, 6195.845103872394, 6218.751249949996, 4183.602557757008, 4185.455890734215, 4196.769177695225, 4205.9789701051295, 4214.536400995888, 6064.939350606525, 6366.204224471941, 6453.580517266362, 6569.37590928861, 6577.539572229945, 4255.0, 4264.168487144977, 4271.380649805761, 4285.442892423965, 4296.140771845643, 4300.376445415397, 4333.090051089306, 4369.279068953587, 4378.496472905593, 4380.364847097153, 5104.3874735031295, 5110.233464980209, 5118.38579370478, 5119.795208191705, 5125.077486052472, 6276.46650034743, 6300.0, 6305.959516679696, 6312.305646378894, 6332.461740752087, 1488.3674438363653, 1498.4980031689506, 1529.678767458846, 1530.5331873778605, 1534.815822101355, 927.4574373991156, 986.3687240166299, 991.1179050644931, 999.7300728803183, 1005.4570531912685, 6021.879562408727, 6037.215162028908, 6039.1545183674325, 6073.271207455045, 6112.388761123852, 6354.8411289717205, 6384.744610215539, 6406.743730250738, 6439.774607888701, 6460.967695161494, 5836.649801011868, 6119.785807496716, 6152.753889844356, 6164.938350616526, 6190.876182476325, 3472.461768425898, 3483.3729928613093, 3486.6861982421706, 3499.16020155166, 3510.789352638799, 6549.443297319781, 6870.31296870309, 6878.140232470942, 6903.413209877217, 6923.134608173978, 6726.159230096238, 6727.159105111861, 6735.0, 6757.459403247728, 6757.911463564571, 6710.966445167841, 6725.2602213756445, 6861.794146175523, 6882.311768823178, 6895.586264824126, 6566.9343306568235, 6574.145361103026, 6578.440832529289, 6592.901106483502, 6611.33886611335, 6090.604110732788, 6462.547621666438, 6473.320301368477, 6496.415322620986, 6498.187726534184, 6860.108185935796, 6883.0, 6912.44700423975, 6913.170419549686, 6914.170299564084, 4236.364545318103, 4291.334843099325, 4299.742015479082, 4302.118065796567, 4307.956920430755, 6371.267304259884, 6494.512911531749, 6580.769673061612, 6588.670566471753, 6599.307072757291, 6335.65153916539, 6344.048392740941, 6348.619082855043, 6361.300256971637, 6378.808635740936, 5959.821205363846, 6295.685215739286, 6298.559100862895, 6322.557420980671, 6376.139221205078, 6116.5412594056515, 6273.710095815086, 6281.560290779602, 6298.496120310272, 6302.401271879165, 6335.4931605472375, 6429.935700642934, 6430.7749228776765, 6439.839004024937, 6439.871202575829, 6006.969965150146, 6230.190075290183, 6241.937580624136, 6249.34381889895, 6251.124842521959], "value": 4709.553586633924, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.4310153587879, 779.9025121859769, 822.0833770346065, 823.9670413183472, 847.3179090831882, 13935.37290821913, 14018.0, 14020.929895350535, 14192.574222773308, 14511.201883896381, 13438.32808359583, 13579.864201357983, 13581.660458488543, 13589.116707414036, 13613.523526676569, 691.6887400669693, 811.5779794506852, 822.0833770346051, 835.7659855240512, 836.3852568362249, 824.6206744897354, 831.3266254334009, 833.5665453963935, 835.1022650650575, 836.1053672570353, 880.0715245416084, 883.9425437346584, 886.1138861138861, 887.2813021452612, 888.4269646078276, 880.5377176982136, 881.8853549038616, 881.9426737262057, 884.1467983396021, 884.1600479544394, 639.25526761323, 640.5196102922808, 641.643887642363, 643.2217017408941, 645.4900628503476, 13258.138221015699, 13327.600171994856, 13393.799093013613, 13412.46350145993, 13419.530316438877, 13728.244946527937, 14000.439982400692, 14002.159870407706, 14140.15159090458, 14172.574822755334, 11229.66311010671, 11345.149113816497, 11394.943025284903, 11396.088312934946, 11554.364509951949, 3899.980500097481, 3919.7256192066566, 3954.9604503955165, 3965.5637879833193, 3965.8215380307665, 55572.72213638906, 55766.0, 56091.0, 56234.71882640561, 56452.153217701765, 10863.67408977732, 10914.56341746337, 10921.15818688249, 11062.944685276521, 11067.335959842274, 19679.803201967796, 19690.31083912056, 19804.306849260207, 19807.702884456743, 19844.20623175057, 8530.74407767768, 8640.0, 8646.740597782076, 8685.782855428539, 8760.8685869712, 4642.117997580449, 4666.883327916761, 4687.156311863829, 4713.410823647044, 4862.635302352338, 3226.467632840602, 3288.835558222127, 3291.2923721400016, 3310.2386451116377, 3333.5499707539657, 577.2380457795754, 584.6375247346588, 588.4174667079646, 593.2258402784407, 593.4214141212284, 791.1534657916089, 798.3254150243035, 805.6535689653505, 808.6078252047752, 830.1739768929954, 9200.861987070199, 9211.723648290563, 9276.675316363895, 9346.813063738688, 9528.0, 724.6992498113224, 751.9812004699817, 753.7211231844253, 755.161770434817, 765.7932358263238, 4307.0, 4443.888902777392, 4502.122086193161, 4511.278195488771, 4593.908121837545, 56857.71571142118, 57335.0, 59016.40983590195, 59398.70300648469, 59665.70167149136, 52411.47588524142, 52980.205296920576, 52983.470165297855, 53348.73325633347, 55068.17397739037, 46417.535824642, 46663.76668116638, 47929.76035119802, 48167.75916120467, 48429.0, 8465.703700370457, 8667.0, 8724.476531408136, 8792.824143516966, 8845.336599754915, 30530.389392212477, 31074.22314442157, 31916.361672766878, 31917.0, 32163.195920102185, 40553.59446405498, 41737.0, 42404.5759542413, 42443.15113697771, 43060.78469607632, 11247.493862776359, 11427.885721142682, 11500.82748758786, 11978.401079945794, 12034.879651203375, 13755.10591811529, 14033.146417445483, 14368.13791172533, 14390.496332628307, 14447.78328325055, 13041.739165216832, 13071.542496012595, 13551.0, 13915.51295704686, 14386.640333991734, 12745.872541274468, 13342.06605537603, 13437.126586771828, 13986.580402587939, 14191.219482928538, 13063.216207027608, 13333.733325333633, 13375.264360460269, 13653.658658533615, 13860.306984650928, 11092.279001865176, 11160.218784684994, 11307.095432365555, 11632.767344653228, 11762.294262344287, 11273.71815704614, 11282.661520154408, 11291.548338066385, 11539.4807233673, 11822.11334149925], "value": 6806.437807597613, "unit": "score"}], "name": "dromaeo_css", "value": 7020.38901760052, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 114.0, 114.0, 113.0, 122.0, 113.0, 112.0, 111.0, 111.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 154.0, 183.0, 131.0, 157.0, 159.0, 141.0, 185.0, 132.0], "value": 153.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 161.0, 163.0, 173.0, 165.0, 166.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 165.0, 77.0, 77.0, 73.0, 74.0, 166.0, 76.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 146.0, 93.0, 92.0, 91.0, 137.0, 93.0, 93.0, 155.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 119.0, 118.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 145.0, 146.0, 147.0, 148.0, 146.0, 148.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 57.0, 59.0, 58.0, 62.0, 58.0, 74.0, 62.0, 58.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0, 65.0, 61.0, 60.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 79.0, 78.0, 78.0, 79.0, 79.0, 79.0, 81.0, 86.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 123.0, 133.0, 132.0, 129.0, 125.0, 127.0, 134.0, 158.0, 129.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 166.0, 168.0, 176.0, 165.0, 169.0, 166.0, 176.0, 169.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 70.0, 72.0, 68.0, 68.0, 70.0, 67.0, 70.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1563.2, "alertThreshold": 2.0}]} 19:28:50 INFO - Return code: 0 19:28:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:28:51 ERROR - # TBPL SUCCESS # 19:28:51 INFO - Running post-action listener: _resource_record_post_action 19:28:51 INFO - Running post-run listener: _resource_record_post_run 19:28:52 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535126016; Read time: 8; Write time: 406280 19:28:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244211712; Read time: 0; Write time: 240472 19:28:52 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290914304; Read time: 8; Write time: 165808 19:28:52 INFO - Running post-run listener: _upload_blobber_files 19:28:52 INFO - Blob upload gear active. 19:28:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:28:52 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 19:28:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:28:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:28:52 INFO - (blobuploader) - INFO - Open directory for files ... 19:28:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:28:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:28:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:53 INFO - (blobuploader) - INFO - Done attempting. 19:28:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:28:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:28:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:54 INFO - (blobuploader) - INFO - Done attempting. 19:28:54 INFO - (blobuploader) - INFO - Iteration through files over. 19:28:54 INFO - Return code: 0 19:28:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:28:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:28:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83a6c073e2c1625ccf28e600efeb13fd229270e2e9d6153577d12461c066c6a0421533c6a4fa7e49f717c83f370c9c475853dc0794766d1732a88a86ed2777de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50b50fee8c65eede3a260566c155b58c7fca3ceb810cc0a90f40d4e821605a75188f4639916031dc8bad1e98b269f90a445b215fb213c2dc4a85eeec146b4a59"} 19:28:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:28:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:28:54 INFO - Contents: 19:28:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83a6c073e2c1625ccf28e600efeb13fd229270e2e9d6153577d12461c066c6a0421533c6a4fa7e49f717c83f370c9c475853dc0794766d1732a88a86ed2777de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50b50fee8c65eede3a260566c155b58c7fca3ceb810cc0a90f40d4e821605a75188f4639916031dc8bad1e98b269f90a445b215fb213c2dc4a85eeec146b4a59"} 19:28:54 INFO - Running post-run listener: copy_logs_to_upload_dir 19:28:54 INFO - Copying logs to upload dir... 19:28:54 INFO - mkdir: /builds/slave/test/build/upload/logs 19:28:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.441812 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-15 19:28:54.446451) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 19:28:54.450612) ========= 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=6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83a6c073e2c1625ccf28e600efeb13fd229270e2e9d6153577d12461c066c6a0421533c6a4fa7e49f717c83f370c9c475853dc0794766d1732a88a86ed2777de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50b50fee8c65eede3a260566c155b58c7fca3ceb810cc0a90f40d4e821605a75188f4639916031dc8bad1e98b269f90a445b215fb213c2dc4a85eeec146b4a59"} build_url:https://queue.taskcluster.net/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/eoeOV8deR_Cy2GbSv04ksg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83a6c073e2c1625ccf28e600efeb13fd229270e2e9d6153577d12461c066c6a0421533c6a4fa7e49f717c83f370c9c475853dc0794766d1732a88a86ed2777de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50b50fee8c65eede3a260566c155b58c7fca3ceb810cc0a90f40d4e821605a75188f4639916031dc8bad1e98b269f90a445b215fb213c2dc4a85eeec146b4a59"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 19:28:54.477802) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:28:54.478392) ========= 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=6dbc10da6d83fee962c624be000001a8-1460767546.381892-706606149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:28:54.561472) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 19:28:54.561797) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 19:28:54.562119) ========= ========= Total master_lag: 0.17 =========