builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1461863621.23 results: success (0) buildid: 20160428073800 builduid: 07ee357c245743149f1bde46aa7e4885 revision: 4292da9df16b220f30921100282264a34cd2ff03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 10:13:41.227916) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 10:13:41.229019) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 10:13:41.229721) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 10:13:41.249718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:13:41.250285) ========= 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=232498196343f89f466a4a9a000001c8-1461862186.56488-773782793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 10:13:41-- 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% 102M=0s 2016-04-28 10:13:41 (102 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086598 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:13:41.354115) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:13:41.354564) ========= 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=232498196343f89f466a4a9a000001c8-1461862186.56488-773782793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018454 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:13:41.407448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 10:13:41.408292) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4292da9df16b220f30921100282264a34cd2ff03 --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 4292da9df16b220f30921100282264a34cd2ff03 --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=232498196343f89f466a4a9a000001c8-1461862186.56488-773782793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 10:13:41,506 truncating revision to first 12 chars 2016-04-28 10:13:41,506 Setting DEBUG logging. 2016-04-28 10:13:41,506 attempt 1/10 2016-04-28 10:13:41,506 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4292da9df16b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 10:13:42,354 unpacking tar archive at: mozilla-central-4292da9df16b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.141292 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 10:13:42.563383) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 10:13:42.563806) ========= script_repo_revision: 4292da9df16b220f30921100282264a34cd2ff03 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 10:13:42.564275) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 10:13:42.564613) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 10:13:42.572954) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-28 10:13:42.573288) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=232498196343f89f466a4a9a000001c8-1461862186.56488-773782793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:13:42 INFO - MultiFileLogger online at 20160428 10:13:42 in /builds/slave/test 10:13:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:13:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:13:42 INFO - {'append_to_log': False, 10:13:42 INFO - 'base_work_dir': '/builds/slave/test', 10:13:42 INFO - 'blob_upload_branch': 'Firefox', 10:13:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:13:42 INFO - 'branch': 'Firefox', 10:13:42 INFO - 'buildbot_json_path': 'buildprops.json', 10:13:42 INFO - 'config_files': ('talos/linux_config.py',), 10:13:42 INFO - 'default_actions': ('clobber', 10:13:42 INFO - 'read-buildbot-config', 10:13:42 INFO - 'download-and-extract', 10:13:42 INFO - 'populate-webroot', 10:13:42 INFO - 'create-virtualenv', 10:13:42 INFO - 'install', 10:13:42 INFO - 'run-tests'), 10:13:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:13:42 INFO - 'download_minidump_stackwalk': True, 10:13:42 INFO - 'download_symbols': 'ondemand', 10:13:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:13:42 INFO - 'tooltool.py': '/tools/tooltool.py', 10:13:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:13:42 INFO - '/tools/misc-python/virtualenv.py')}, 10:13:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:13:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:13:42 INFO - 'installer_path': 'installer.exe', 10:13:42 INFO - 'log_level': 'info', 10:13:42 INFO - 'log_name': 'talos', 10:13:42 INFO - 'log_to_console': True, 10:13:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:13:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:13:42 INFO - 'opt_config_files': (), 10:13:42 INFO - 'pip_index': False, 10:13:42 INFO - 'sps_profile': False, 10:13:42 INFO - 'sps_profile_interval': 0, 10:13:42 INFO - 'suite': 'dromaeojs', 10:13:42 INFO - 'system_bits': '32', 10:13:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:13:42 INFO - 'title': 'talos-linux64-ix-025', 10:13:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:13:42 INFO - 'use_talos_json': True, 10:13:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:13:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:13:42 INFO - 'work_dir': 'build'} 10:13:42 INFO - ##### 10:13:42 INFO - ##### Running clobber step. 10:13:42 INFO - ##### 10:13:42 INFO - Running pre-action listener: _resource_record_pre_action 10:13:42 INFO - Running main action method: clobber 10:13:42 INFO - rmtree: /builds/slave/test/build 10:13:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:13:43 INFO - Running post-action listener: _resource_record_post_action 10:13:43 INFO - ##### 10:13:43 INFO - ##### Running read-buildbot-config step. 10:13:43 INFO - ##### 10:13:43 INFO - Running pre-action listener: _resource_record_pre_action 10:13:43 INFO - Running main action method: read_buildbot_config 10:13:43 INFO - Using buildbot properties: 10:13:43 INFO - { 10:13:43 INFO - "project": "", 10:13:43 INFO - "product": "firefox", 10:13:43 INFO - "script_repo_revision": "production", 10:13:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:13:43 INFO - "repository": "", 10:13:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:13:43 INFO - "buildid": "20160428073800", 10:13:43 INFO - "pgo_build": "True", 10:13:43 INFO - "basedir": "/builds/slave/test", 10:13:43 INFO - "buildnumber": 273, 10:13:43 INFO - "slavename": "talos-linux64-ix-025", 10:13:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:13:43 INFO - "platform": "ubuntu64_hw", 10:13:43 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:13:43 INFO - "branch": "mozilla-central", 10:13:43 INFO - "repo_path": "mozilla-central", 10:13:43 INFO - "revision": "4292da9df16b220f30921100282264a34cd2ff03", 10:13:43 INFO - "stage_platform": "linux64-pgo", 10:13:43 INFO - "builduid": "07ee357c245743149f1bde46aa7e4885", 10:13:43 INFO - "slavebuilddir": "test" 10:13:43 INFO - } 10:13:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:13:43 INFO - Running post-action listener: _resource_record_post_action 10:13:43 INFO - ##### 10:13:43 INFO - ##### Running download-and-extract step. 10:13:43 INFO - ##### 10:13:43 INFO - Running pre-action listener: _resource_record_pre_action 10:13:43 INFO - Running main action method: download_and_extract 10:13:43 INFO - mkdir: /builds/slave/test/build/tests 10:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:43 INFO - https://queue.taskcluster.net/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:13:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:13:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:13:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:13:43 INFO - Downloaded 1361 bytes. 10:13:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:13:43 INFO - Using the following test package requirements: 10:13:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:13:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:13:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:13:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:43 INFO - u'jsshell-linux-x86_64.zip'], 10:13:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:13:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:13:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:13:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:13:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:13:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:13:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:43 INFO - https://queue.taskcluster.net/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:13:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:13:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:13:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:13:45 INFO - Downloaded 23873265 bytes. 10:13:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:13:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:13:47 INFO - Return code: 0 10:13:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:13: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')]} 10:13:47 INFO - https://queue.taskcluster.net/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:13:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:13:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:13:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:13:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:13:48 INFO - Downloaded 23873265 bytes. 10:13:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:13:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:13:49 INFO - Return code: 0 10:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:49 INFO - https://queue.taskcluster.net/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:13:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:13:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:13:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:13:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:13:50 INFO - Downloaded 10840145 bytes. 10:13:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:13:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:13:50 INFO - Return code: 0 10:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:50 INFO - https://queue.taskcluster.net/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:13:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:13:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:13:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:13:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:13:52 INFO - Downloaded 58403569 bytes. 10:13:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:13:52 INFO - mkdir: /builds/slave/test/properties 10:13:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:13:52 INFO - Writing to file /builds/slave/test/properties/build_url 10:13:52 INFO - Contents: 10:13:52 INFO - build_url:https://queue.taskcluster.net/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:13:53 INFO - Running post-action listener: _resource_record_post_action 10:13:53 INFO - Running post-action listener: set_extra_try_arguments 10:13:53 INFO - ##### 10:13:53 INFO - ##### Running populate-webroot step. 10:13:53 INFO - ##### 10:13:53 INFO - Running pre-action listener: _resource_record_pre_action 10:13:53 INFO - Running main action method: populate_webroot 10:13:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:13:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:13:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:13:53 INFO - '--tppagecycles', 10:13:53 INFO - '7'], 10:13:53 INFO - 'tests': ['tsvgm']}}, 10:13:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:13:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:13:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:13:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:13:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:53 INFO - 'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:53 INFO - 'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['damp', 'tps']}, 10:13:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:53 INFO - 'tests': ['damp', 'tps']}, 10:13:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['dromaeo_dom']}, 10:13:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:13:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['a11yr', 10:13:53 INFO - 'ts_paint', 10:13:53 INFO - 'tpaint', 10:13:53 INFO - 'sessionrestore', 10:13:53 INFO - 'sessionrestore_no_auto_restore', 10:13:53 INFO - 'tabpaint']}, 10:13:53 INFO - 'other-e10s': {'tests': ['a11yr', 10:13:53 INFO - 'ts_paint', 10:13:53 INFO - 'tpaint', 10:13:53 INFO - 'sessionrestore', 10:13:53 INFO - 'sessionrestore_no_auto_restore', 10:13:53 INFO - 'tabpaint']}, 10:13:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:13:53 INFO - 'ts_paint', 10:13:53 INFO - 'tpaint', 10:13:53 INFO - 'sessionrestore', 10:13:53 INFO - 'sessionrestore_no_auto_restore', 10:13:53 INFO - 'tabpaint']}, 10:13:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:13:53 INFO - 'ts_paint', 10:13:53 INFO - 'tpaint', 10:13:53 INFO - 'sessionrestore', 10:13:53 INFO - 'sessionrestore_no_auto_restore', 10:13:53 INFO - 'tabpaint']}, 10:13:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['a11yr', 10:13:53 INFO - 'ts_paint', 10:13:53 INFO - 'tpaint', 10:13:53 INFO - 'sessionrestore', 10:13:53 INFO - 'sessionrestore_no_auto_restore', 10:13:53 INFO - 'tabpaint']}, 10:13:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['a11yr', 10:13:53 INFO - 'ts_paint', 10:13:53 INFO - 'tpaint', 10:13:53 INFO - 'sessionrestore', 10:13:53 INFO - 'sessionrestore_no_auto_restore', 10:13:53 INFO - 'tabpaint']}, 10:13:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['tsvgx', 10:13:53 INFO - 'tsvgr_opacity', 10:13:53 INFO - 'tart', 10:13:53 INFO - 'tscrollx', 10:13:53 INFO - 'cart']}, 10:13:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:13:53 INFO - 'tsvgr_opacity', 10:13:53 INFO - 'tart', 10:13:53 INFO - 'tscrollx', 10:13:53 INFO - 'cart']}, 10:13:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:53 INFO - 'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['tp5o']}, 10:13:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:53 INFO - 'tests': ['tp5o']}, 10:13:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:53 INFO - 'talos_options': ['--disable-e10s', 10:13:53 INFO - '--xperf_path', 10:13:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:53 INFO - 'tests': ['tp5n']}, 10:13:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:53 INFO - 'talos_options': ['--xperf_path', 10:13:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:53 INFO - 'tests': ['tp5n']}}, 10:13:53 INFO - 'talos.zip': {'path': '', 10:13:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:13:53 INFO - Running post-action listener: _resource_record_post_action 10:13:53 INFO - ##### 10:13:53 INFO - ##### Running create-virtualenv step. 10:13:53 INFO - ##### 10:13:53 INFO - Running pre-action listener: _resource_record_pre_action 10:13:53 INFO - Running main action method: create_virtualenv 10:13:53 INFO - Creating virtualenv /builds/slave/test/build/venv 10:13:53 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 10:13:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:13:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:13:53 INFO - Using real prefix '/usr' 10:13:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:13:53 INFO - Installing distribute.............................................................................................................................................................................................done. 10:13:55 INFO - Installing pip.................done. 10:13:55 INFO - Return code: 0 10:13:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8f94b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', '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 10:13: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', 'pip>=1.5'] in /builds/slave/test/build 10:13: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 pip>=1.5 10:13:55 INFO - Using env: {'DISPLAY': ':0', 10:13:55 INFO - 'HOME': '/home/cltbld', 10:13:55 INFO - 'LANG': 'en_US.UTF-8', 10:13:55 INFO - 'LANGUAGE': 'en_US:en', 10:13:55 INFO - 'LOGNAME': 'cltbld', 10:13:55 INFO - 'MAIL': '/var/mail/cltbld', 10:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:55 INFO - 'MOZ_NO_REMOTE': '1', 10:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:55 INFO - 'NO_EM_RESTART': '1', 10:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:55 INFO - 'PWD': '/builds/slave/test', 10:13:55 INFO - 'SHELL': '/bin/bash', 10:13:55 INFO - 'SHLVL': '1', 10:13:55 INFO - 'TERM': 'linux', 10:13:55 INFO - 'TMOUT': '86400', 10:13:55 INFO - 'USER': 'cltbld', 10:13:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', 10:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:55 INFO - '_': '/tools/buildbot/bin/python'} 10:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:55 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 10:13:55 INFO - Cleaning up... 10:13:55 INFO - Return code: 0 10:13:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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', '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 0x7ff8f94b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', '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 10:13: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', 'psutil>=0.7.1'] in /builds/slave/test/build 10:13: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 psutil>=0.7.1 10:13:55 INFO - Using env: {'DISPLAY': ':0', 10:13:55 INFO - 'HOME': '/home/cltbld', 10:13:55 INFO - 'LANG': 'en_US.UTF-8', 10:13:55 INFO - 'LANGUAGE': 'en_US:en', 10:13:55 INFO - 'LOGNAME': 'cltbld', 10:13:55 INFO - 'MAIL': '/var/mail/cltbld', 10:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:55 INFO - 'MOZ_NO_REMOTE': '1', 10:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:55 INFO - 'NO_EM_RESTART': '1', 10:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:55 INFO - 'PWD': '/builds/slave/test', 10:13:55 INFO - 'SHELL': '/bin/bash', 10:13:55 INFO - 'SHLVL': '1', 10:13:55 INFO - 'TERM': 'linux', 10:13:55 INFO - 'TMOUT': '86400', 10:13:55 INFO - 'USER': 'cltbld', 10:13:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', 10:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:55 INFO - '_': '/tools/buildbot/bin/python'} 10:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:56 INFO - Downloading/unpacking psutil>=0.7.1 10:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:13:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:58 INFO - Installing collected packages: psutil 10:13:58 INFO - Running setup.py install for psutil 10:13:58 INFO - building 'psutil._psutil_linux' extension 10:13:58 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 10:13:58 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 10:13:58 INFO - building 'psutil._psutil_posix' extension 10:13:58 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 10:13:58 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 10:13:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:58 INFO - Successfully installed psutil 10:13:58 INFO - Cleaning up... 10:13:58 INFO - Return code: 0 10:13:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff8f94b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', '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 10:13:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:13:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:13:58 INFO - Using env: {'DISPLAY': ':0', 10:13:58 INFO - 'HOME': '/home/cltbld', 10:13:58 INFO - 'LANG': 'en_US.UTF-8', 10:13:58 INFO - 'LANGUAGE': 'en_US:en', 10:13:58 INFO - 'LOGNAME': 'cltbld', 10:13:58 INFO - 'MAIL': '/var/mail/cltbld', 10:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:58 INFO - 'MOZ_NO_REMOTE': '1', 10:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:58 INFO - 'NO_EM_RESTART': '1', 10:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:58 INFO - 'PWD': '/builds/slave/test', 10:13:58 INFO - 'SHELL': '/bin/bash', 10:13:58 INFO - 'SHLVL': '1', 10:13:58 INFO - 'TERM': 'linux', 10:13:58 INFO - 'TMOUT': '86400', 10:13:58 INFO - 'USER': 'cltbld', 10:13:58 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', 10:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:58 INFO - '_': '/tools/buildbot/bin/python'} 10:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:13:58 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 10:13:58 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 10:13:58 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 10:13:58 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 10:13:58 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 10:13:58 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 10:14:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:14:00 INFO - Installing collected packages: mozsystemmonitor 10:14:00 INFO - Running setup.py install for mozsystemmonitor 10:14:00 INFO - Successfully installed mozsystemmonitor 10:14:00 INFO - Cleaning up... 10:14:01 INFO - Return code: 0 10:14:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff8f94b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', '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 10:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:14:01 INFO - Using env: {'DISPLAY': ':0', 10:14:01 INFO - 'HOME': '/home/cltbld', 10:14:01 INFO - 'LANG': 'en_US.UTF-8', 10:14:01 INFO - 'LANGUAGE': 'en_US:en', 10:14:01 INFO - 'LOGNAME': 'cltbld', 10:14:01 INFO - 'MAIL': '/var/mail/cltbld', 10:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:01 INFO - 'MOZ_NO_REMOTE': '1', 10:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:01 INFO - 'NO_EM_RESTART': '1', 10:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:01 INFO - 'PWD': '/builds/slave/test', 10:14:01 INFO - 'SHELL': '/bin/bash', 10:14:01 INFO - 'SHLVL': '1', 10:14:01 INFO - 'TERM': 'linux', 10:14:01 INFO - 'TMOUT': '86400', 10:14:01 INFO - 'USER': 'cltbld', 10:14:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', 10:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:01 INFO - '_': '/tools/buildbot/bin/python'} 10:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:01 INFO - Downloading/unpacking blobuploader==1.2.4 10:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:03 INFO - Downloading blobuploader-1.2.4.tar.gz 10:14:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:14:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:14:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:04 INFO - Downloading docopt-0.6.1.tar.gz 10:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:14:04 INFO - Installing collected packages: blobuploader, requests, docopt 10:14:04 INFO - Running setup.py install for blobuploader 10:14:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:14:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:14:04 INFO - Running setup.py install for requests 10:14:04 INFO - Running setup.py install for docopt 10:14:04 INFO - Successfully installed blobuploader requests docopt 10:14:04 INFO - Cleaning up... 10:14:04 INFO - Return code: 0 10:14:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:04 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')]} 10:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:04 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')]} 10:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:04 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 0x7ff8f94b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', '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 10:14:04 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 10:14:04 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 10:14:04 INFO - Using env: {'DISPLAY': ':0', 10:14:04 INFO - 'HOME': '/home/cltbld', 10:14:04 INFO - 'LANG': 'en_US.UTF-8', 10:14:04 INFO - 'LANGUAGE': 'en_US:en', 10:14:04 INFO - 'LOGNAME': 'cltbld', 10:14:04 INFO - 'MAIL': '/var/mail/cltbld', 10:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:04 INFO - 'MOZ_NO_REMOTE': '1', 10:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:04 INFO - 'NO_EM_RESTART': '1', 10:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:04 INFO - 'PWD': '/builds/slave/test', 10:14:04 INFO - 'SHELL': '/bin/bash', 10:14:04 INFO - 'SHLVL': '1', 10:14:04 INFO - 'TERM': 'linux', 10:14:04 INFO - 'TMOUT': '86400', 10:14:04 INFO - 'USER': 'cltbld', 10:14:04 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', 10:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:04 INFO - '_': '/tools/buildbot/bin/python'} 10:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:05 INFO - Running setup.py (path:/tmp/pip-GRYpDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:05 INFO - Running setup.py (path:/tmp/pip-6BnsrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:05 INFO - Running setup.py (path:/tmp/pip-Ns5b5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:05 INFO - Running setup.py (path:/tmp/pip-ze1DVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:05 INFO - Running setup.py (path:/tmp/pip-8EEbAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:05 INFO - Running setup.py (path:/tmp/pip-r3ZuzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:05 INFO - Running setup.py (path:/tmp/pip-e8Ilac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:05 INFO - Running setup.py (path:/tmp/pip-P8ECWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:05 INFO - Running setup.py (path:/tmp/pip-H1b7C8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:05 INFO - Running setup.py (path:/tmp/pip-w0nZIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:05 INFO - Running setup.py (path:/tmp/pip-EShWMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:05 INFO - Running setup.py (path:/tmp/pip-LZIj93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:05 INFO - Running setup.py (path:/tmp/pip-PGNucL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:05 INFO - Running setup.py (path:/tmp/pip-YdaFhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:06 INFO - Running setup.py (path:/tmp/pip-tyQjgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:06 INFO - Running setup.py (path:/tmp/pip-9pngvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:06 INFO - Running setup.py (path:/tmp/pip-HLva0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:14:06 INFO - Running setup.py install for manifestparser 10:14:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:14:06 INFO - Running setup.py install for mozcrash 10:14:06 INFO - Running setup.py install for mozdebug 10:14:06 INFO - Running setup.py install for mozdevice 10:14:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:14:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:14:06 INFO - Running setup.py install for mozfile 10:14:06 INFO - Running setup.py install for mozhttpd 10:14:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:14:06 INFO - Running setup.py install for mozinfo 10:14:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:14:06 INFO - Running setup.py install for mozInstall 10:14:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:14:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:14:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:14:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:14:07 INFO - Running setup.py install for mozleak 10:14:07 INFO - Running setup.py install for mozlog 10:14:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:14:07 INFO - Running setup.py install for moznetwork 10:14:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:14:07 INFO - Running setup.py install for mozprocess 10:14:07 INFO - Running setup.py install for mozprofile 10:14:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:14:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:14:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:14:07 INFO - Running setup.py install for mozrunner 10:14:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:14:07 INFO - Running setup.py install for mozscreenshot 10:14:07 INFO - Running setup.py install for moztest 10:14:07 INFO - Running setup.py install for mozversion 10:14:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:14:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:14:07 INFO - Cleaning up... 10:14:07 INFO - Return code: 0 10:14:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:07 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 0x7ff8f94b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', '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 10:14:07 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 10:14:07 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 10:14:07 INFO - Using env: {'DISPLAY': ':0', 10:14:07 INFO - 'HOME': '/home/cltbld', 10:14:07 INFO - 'LANG': 'en_US.UTF-8', 10:14:07 INFO - 'LANGUAGE': 'en_US:en', 10:14:07 INFO - 'LOGNAME': 'cltbld', 10:14:07 INFO - 'MAIL': '/var/mail/cltbld', 10:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:07 INFO - 'MOZ_NO_REMOTE': '1', 10:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:07 INFO - 'NO_EM_RESTART': '1', 10:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:07 INFO - 'PWD': '/builds/slave/test', 10:14:07 INFO - 'SHELL': '/bin/bash', 10:14:07 INFO - 'SHLVL': '1', 10:14:07 INFO - 'TERM': 'linux', 10:14:07 INFO - 'TMOUT': '86400', 10:14:07 INFO - 'USER': 'cltbld', 10:14:07 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', 10:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:07 INFO - '_': '/tools/buildbot/bin/python'} 10:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:08 INFO - Running setup.py (path:/tmp/pip-lUE40S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:08 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)) 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:08 INFO - Running setup.py (path:/tmp/pip-4bhPd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:08 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)) 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:08 INFO - Running setup.py (path:/tmp/pip-XLuiR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:08 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)) 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:08 INFO - Running setup.py (path:/tmp/pip-1On5MI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:08 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)) 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:08 INFO - Running setup.py (path:/tmp/pip-YeadVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:08 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)) 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:08 INFO - Running setup.py (path:/tmp/pip-XSTIvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:08 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)) 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:08 INFO - Running setup.py (path:/tmp/pip-mgYSah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:08 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)) 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:08 INFO - Running setup.py (path:/tmp/pip-zRnadY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:08 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)) 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:08 INFO - Running setup.py (path:/tmp/pip-ai8X6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:08 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)) 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:08 INFO - Running setup.py (path:/tmp/pip-OtxCQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:08 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)) 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:08 INFO - Running setup.py (path:/tmp/pip-00q8Oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:09 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)) 10:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:09 INFO - Running setup.py (path:/tmp/pip-Nq39sQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:09 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)) 10:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:09 INFO - Running setup.py (path:/tmp/pip-qACzVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:09 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)) 10:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:09 INFO - Running setup.py (path:/tmp/pip-GAKWOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:09 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)) 10:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:09 INFO - Running setup.py (path:/tmp/pip-TCjzNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:09 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)) 10:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:09 INFO - Running setup.py (path:/tmp/pip-XS7mwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:09 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)) 10:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:09 INFO - Running setup.py (path:/tmp/pip-OyIfnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:09 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)) 10:14:09 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)) 10:14:09 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)) 10:14:09 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)) 10:14:09 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)) 10:14:09 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)) 10:14:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:14:09 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 10:14:09 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 10:14:09 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 10:14:09 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 10:14:09 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 10:14:09 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 10:14:11 INFO - Downloading blessings-1.6.tar.gz 10:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:14:11 INFO - Installing collected packages: blessings 10:14:11 INFO - Running setup.py install for blessings 10:14:11 INFO - Successfully installed blessings 10:14:11 INFO - Cleaning up... 10:14:11 INFO - Return code: 0 10:14:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:14:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:11 INFO - Reading from file tmpfile_stdout 10:14:11 INFO - Current package versions: 10:14:11 INFO - argparse == 1.2.1 10:14:11 INFO - blessings == 1.6 10:14:11 INFO - blobuploader == 1.2.4 10:14:11 INFO - docopt == 0.6.1 10:14:11 INFO - manifestparser == 1.1 10:14:11 INFO - mozInstall == 1.12 10:14:11 INFO - mozcrash == 0.17 10:14:11 INFO - mozdebug == 0.1 10:14:11 INFO - mozdevice == 0.48 10:14:11 INFO - mozfile == 1.2 10:14:11 INFO - mozhttpd == 0.7 10:14:11 INFO - mozinfo == 0.9 10:14:11 INFO - mozleak == 0.1 10:14:11 INFO - mozlog == 3.1 10:14:11 INFO - moznetwork == 0.27 10:14:11 INFO - mozprocess == 0.22 10:14:11 INFO - mozprofile == 0.28 10:14:11 INFO - mozrunner == 6.11 10:14:11 INFO - mozscreenshot == 0.1 10:14:11 INFO - mozsystemmonitor == 0.0 10:14:11 INFO - moztest == 0.7 10:14:11 INFO - mozversion == 1.4 10:14:11 INFO - psutil == 3.1.1 10:14:11 INFO - requests == 1.2.3 10:14:11 INFO - wsgiref == 0.1.2 10:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:11 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')]} 10:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:11 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')]} 10:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:11 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 0x7ff8f94b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', '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 10:14:11 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 10:14:11 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 10:14:11 INFO - Using env: {'DISPLAY': ':0', 10:14:11 INFO - 'HOME': '/home/cltbld', 10:14:11 INFO - 'LANG': 'en_US.UTF-8', 10:14:11 INFO - 'LANGUAGE': 'en_US:en', 10:14:11 INFO - 'LOGNAME': 'cltbld', 10:14:11 INFO - 'MAIL': '/var/mail/cltbld', 10:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:11 INFO - 'MOZ_NO_REMOTE': '1', 10:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:11 INFO - 'NO_EM_RESTART': '1', 10:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:11 INFO - 'PWD': '/builds/slave/test', 10:14:11 INFO - 'SHELL': '/bin/bash', 10:14:11 INFO - 'SHLVL': '1', 10:14:11 INFO - 'TERM': 'linux', 10:14:11 INFO - 'TMOUT': '86400', 10:14:11 INFO - 'USER': 'cltbld', 10:14:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', 10:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:11 INFO - '_': '/tools/buildbot/bin/python'} 10:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:11 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)) 10:14:11 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)) 10:14:11 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)) 10:14:11 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)) 10:14:11 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)) 10:14:11 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)) 10:14:11 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)) 10:14:11 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)) 10:14:11 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)) 10:14:12 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)) 10:14:12 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)) 10:14:12 INFO - Cleaning up... 10:14:12 INFO - Return code: 0 10:14:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:14:12 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')]} 10:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:12 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')]} 10:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:12 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 0x7ff8f94b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', '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 10:14:12 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 10:14:12 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 10:14:12 INFO - Using env: {'DISPLAY': ':0', 10:14:12 INFO - 'HOME': '/home/cltbld', 10:14:12 INFO - 'LANG': 'en_US.UTF-8', 10:14:12 INFO - 'LANGUAGE': 'en_US:en', 10:14:12 INFO - 'LOGNAME': 'cltbld', 10:14:12 INFO - 'MAIL': '/var/mail/cltbld', 10:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:12 INFO - 'MOZ_NO_REMOTE': '1', 10:14:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:12 INFO - 'NO_EM_RESTART': '1', 10:14:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:12 INFO - 'PWD': '/builds/slave/test', 10:14:12 INFO - 'SHELL': '/bin/bash', 10:14:12 INFO - 'SHLVL': '1', 10:14:12 INFO - 'TERM': 'linux', 10:14:12 INFO - 'TMOUT': '86400', 10:14:12 INFO - 'USER': 'cltbld', 10:14:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', 10:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:12 INFO - '_': '/tools/buildbot/bin/python'} 10:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:12 INFO - Downloading/unpacking jsonschema 10:14:12 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 10:14:12 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 10:14:12 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 10:14:12 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 10:14:12 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 10:14:12 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 10:14:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:14:14 INFO - Downloading/unpacking functools32 (from jsonschema) 10:14:14 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 10:14:14 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 10:14:14 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 10:14:14 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 10:14:14 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 10:14:14 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 10:14:14 INFO - Downloading functools32-3.2.3-2.tar.gz 10:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:14:14 INFO - warning: no files found matching '*.txt' 10:14:14 INFO - no previously-included directories found matching 'build' 10:14:14 INFO - no previously-included directories found matching 'dist' 10:14:14 INFO - no previously-included directories found matching '.git*' 10:14:14 INFO - Installing collected packages: jsonschema, functools32 10:14:14 INFO - Running setup.py install for functools32 10:14:14 INFO - warning: no files found matching '*.txt' 10:14:14 INFO - no previously-included directories found matching 'build' 10:14:14 INFO - no previously-included directories found matching 'dist' 10:14:14 INFO - no previously-included directories found matching '.git*' 10:14:14 INFO - Successfully installed jsonschema functools32 10:14:14 INFO - Cleaning up... 10:14:14 INFO - Return code: 0 10:14:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:14 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 0x7ff8f94b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13169a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, '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': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', '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 10:14:14 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 10:14:14 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 10:14:14 INFO - Using env: {'DISPLAY': ':0', 10:14:14 INFO - 'HOME': '/home/cltbld', 10:14:14 INFO - 'LANG': 'en_US.UTF-8', 10:14:14 INFO - 'LANGUAGE': 'en_US:en', 10:14:14 INFO - 'LOGNAME': 'cltbld', 10:14:14 INFO - 'MAIL': '/var/mail/cltbld', 10:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:14 INFO - 'MOZ_NO_REMOTE': '1', 10:14:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:14 INFO - 'NO_EM_RESTART': '1', 10:14:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:14 INFO - 'PWD': '/builds/slave/test', 10:14:14 INFO - 'SHELL': '/bin/bash', 10:14:14 INFO - 'SHLVL': '1', 10:14:14 INFO - 'TERM': 'linux', 10:14:14 INFO - 'TMOUT': '86400', 10:14:14 INFO - 'USER': 'cltbld', 10:14:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', 10:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:14 INFO - '_': '/tools/buildbot/bin/python'} 10:14:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:14 INFO - Downloading/unpacking flake8 10:14:14 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 10:14:14 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 10:14:14 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 10:14:14 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 10:14:14 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 10:14:14 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 10:14:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:14:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:14:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:14:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:14:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:14:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:14:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:14:17 INFO - no previously-included directories found matching 'docs/_build' 10:14:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:14:17 INFO - Running setup.py install for pep8 10:14:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:14:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:14:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:14:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:14:17 INFO - no previously-included directories found matching 'docs/_build' 10:14:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:14:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:14:17 INFO - Cleaning up... 10:14:17 INFO - Return code: 0 10:14:17 INFO - Running post-action listener: _resource_record_post_action 10:14:17 INFO - Running post-action listener: _start_resource_monitoring 10:14:17 INFO - Starting resource monitoring. 10:14:17 INFO - ##### 10:14:17 INFO - ##### Running install step. 10:14:17 INFO - ##### 10:14:17 INFO - Running pre-action listener: _resource_record_pre_action 10:14:17 INFO - Running main action method: install 10:14:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:17 INFO - Reading from file tmpfile_stdout 10:14:17 INFO - Detecting whether we're running mozinstall >=1.0... 10:14:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:14:17 INFO - Reading from file tmpfile_stdout 10:14:17 INFO - Output received: 10:14:17 INFO - Usage: mozinstall [options] installer 10:14:17 INFO - Options: 10:14:17 INFO - -h, --help show this help message and exit 10:14:17 INFO - -d DEST, --destination=DEST 10:14:17 INFO - Directory to install application into. [default: 10:14:17 INFO - "/builds/slave/test"] 10:14:17 INFO - --app=APP Application being installed. [default: firefox] 10:14:17 INFO - mkdir: /builds/slave/test/build/application 10:14:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:14:34 INFO - Reading from file tmpfile_stdout 10:14:34 INFO - Output received: 10:14:34 INFO - /builds/slave/test/build/application/firefox/firefox 10:14:34 INFO - Running post-action listener: _resource_record_post_action 10:14:34 INFO - ##### 10:14:34 INFO - ##### Running run-tests step. 10:14:34 INFO - ##### 10:14:34 INFO - Running pre-action listener: _resource_record_pre_action 10:14:34 INFO - Running main action method: run_tests 10:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:14:34 INFO - Python 2.7.3 10:14:34 INFO - Return code: 0 10:14:34 INFO - grabbing minidump binary from tooltool 10:14: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')]} 10:14:34 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 0x13a5810>, '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 0x13a6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a6ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:14:34 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 10:14:34 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 10:14:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:14:34 INFO - Return code: 0 10:14:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:14:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:14:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:14:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:14:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:14:35 INFO - Return code: 0 10:14:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:14:35 INFO - Using env: {'DISPLAY': ':0', 10:14:35 INFO - 'HOME': '/home/cltbld', 10:14:35 INFO - 'LANG': 'en_US.UTF-8', 10:14:35 INFO - 'LANGUAGE': 'en_US:en', 10:14:35 INFO - 'LOGNAME': 'cltbld', 10:14:35 INFO - 'MAIL': '/var/mail/cltbld', 10:14:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:14:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:35 INFO - 'MOZ_NO_REMOTE': '1', 10:14:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:14:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:35 INFO - 'NO_EM_RESTART': '1', 10:14:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:35 INFO - 'PWD': '/builds/slave/test', 10:14:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:14:35 INFO - 'SHELL': '/bin/bash', 10:14:35 INFO - 'SHLVL': '1', 10:14:35 INFO - 'TERM': 'linux', 10:14:35 INFO - 'TMOUT': '86400', 10:14:35 INFO - 'USER': 'cltbld', 10:14:35 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461862186.56488-773782793', 10:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:35 INFO - '_': '/tools/buildbot/bin/python'} 10:14:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:14:35 INFO - mozversion application_buildid: 20160428073800 10:14:35 INFO - mozversion application_changeset: 4292da9df16b220f30921100282264a34cd2ff03 10:14:35 INFO - mozversion application_display_name: Nightly 10:14:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:14:35 INFO - mozversion application_name: Firefox 10:14:35 INFO - mozversion application_remotingname: firefox 10:14:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:14:35 INFO - mozversion application_vendor: Mozilla 10:14:35 INFO - mozversion application_version: 49.0a1 10:14:35 INFO - mozversion platform_buildid: 20160428073800 10:14:35 INFO - mozversion platform_changeset: 4292da9df16b220f30921100282264a34cd2ff03 10:14:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:14:35 INFO - mozversion platform_version: 49.0a1 10:14:35 INFO - using testdate: 1461863675 10:14:35 INFO - actual date: 1461863675 10:14:35 INFO - starting webserver on 'localhost:60668' 10:14:35 INFO - SUITE-START | Running 2 tests 10:14:35 INFO - TEST-START | dromaeo_css 10:14:35 INFO - operating with platform_type : linux_ 10:14:35 INFO - Initialising browser for dromaeo_css test... 10:14:35 INFO - TEST-INFO | started process 9711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB0bUjd/profile http://localhost:60668/getInfo.html) 10:14:39 INFO - PROCESS | 9711 | __metrics Screen width/height:1600/1200 10:14:39 INFO - PROCESS | 9711 | colorDepth:24 10:14:39 INFO - PROCESS | 9711 | Browser inner width/height: 1024/697 10:14:39 INFO - PROCESS | 9711 | __metrics 10:14:40 ERROR - PROCESS | 9711 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:14:41 INFO - TEST-INFO | 9711: exit 0 10:14:41 INFO - Browser initialized. 10:14:41 INFO - Running cycle 1/1 for dromaeo_css test... 10:14:41 INFO - TEST-INFO | started process 9790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB0bUjd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:53 INFO - PROCESS | 9790 | RSS: Main: 155275264 10:14:53 INFO - PROCESS | 9790 | 10:15:44 INFO - PROCESS | 9790 | 1461863744376 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] 10:17:51 INFO - PROCESS | 9790 | Cycle 1(1): loaded http://localhost:60668/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60668/tests/dromaeo/cssquery-ext.html) 10:17:52 INFO - PROCESS | 9790 | RSS: Main: 262860800 10:17:52 INFO - PROCESS | 9790 | 10:20:55 INFO - PROCESS | 9790 | Cycle 1(1): loaded http://localhost:60668/tests/dromaeo/cssquery-ext.html (next: http://localhost:60668/tests/dromaeo/cssquery-jquery.html) 10:20:55 INFO - PROCESS | 9790 | RSS: Main: 232534016 10:20:55 INFO - PROCESS | 9790 | 10:23:57 INFO - PROCESS | 9790 | Cycle 1(1): loaded http://localhost:60668/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60668/tests/dromaeo/cssquery-mootools.html) 10:23:58 INFO - PROCESS | 9790 | RSS: Main: 235450368 10:23:58 INFO - PROCESS | 9790 | 10:27:00 INFO - PROCESS | 9790 | Cycle 1(1): loaded http://localhost:60668/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60668/tests/dromaeo/cssquery-prototype.html) 10:27:00 INFO - PROCESS | 9790 | RSS: Main: 237858816 10:27:00 INFO - PROCESS | 9790 | 10:30:03 INFO - PROCESS | 9790 | Cycle 1(1): loaded http://localhost:60668/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60668/tests/dromaeo/cssquery-yui.html) 10:30:04 INFO - PROCESS | 9790 | RSS: Main: 223408128 10:30:04 INFO - PROCESS | 9790 | 10:33:06 INFO - PROCESS | 9790 | Cycle 1(1): loaded http://localhost:60668/tests/dromaeo/cssquery-yui.html (next: http://localhost:60668/tests/dromaeo/cssquery-dojo.html) 10:33:07 INFO - PROCESS | 9790 | RSS: Main: 262533120 10:33:07 INFO - PROCESS | 9790 | 10:33:07 INFO - PROCESS | 9790 | __start_tp_report 10:33:07 INFO - PROCESS | 9790 | _x_x_mozilla_page_load 10:33:07 INFO - PROCESS | 9790 | _x_x_mozilla_page_load_details 10:33:07 INFO - PROCESS | 9790 | |i|pagename|runs| 10:33:07 INFO - PROCESS | 9790 | |0;dojo.html;3049.9237519062026;3108.3938631966776;3143.2770462793555;3144.135362775235;3188.9795265515036;4938.678985865916;5001.149804533229;5183.144781111117;5192.117340052186;5218.973905130474;5193.272941788153;5208.817691380802;5220.373555173384;5259.079661059319;5281.023010743005;4713;4728;4748.667593268473;4759.071980963713;4908.361912951329;4824.44518880328;4833.444153922291;4865.975670121645;4884.242942343943;4896.46138924718;4663.183942810012;4743.90512189756;4746.335513028144;4758.3100450434495;4762.333273341735;4714.127886341038;4731.858044258678;4735.810567577293;4751.64362672801;4780.545848144456;4583.610393116589;4695.859124226278;4707.176244157259;4707.246840505502;4743.596794272491;5065.442801291855;5072.34059572257;5076.6192535559985;5101.923471147936;5120.641555091145;5441.374241962186;5441.537469315113;5457.181422786574;5506.146547285177;5514.255575497296;5387;5513.42109078549;5518.779248830042;5590.273264475592;5620.859478513029;5225.634205605571;5226.764795584169;5239.318888544503;5252.107141785906;5272.367315922075;5692.089265717465;5704.172894930211;5704.4295570443455;5705.372409035002;5706.743196556165;5227.947720522822;5445.237666726662;5461.590380721462;5531.308586426697;5543.501084902378;5505.559555235572;5510.476504732044;5513.889722205534;5514.365847927459;5516.393196748354;5489.807856725075;5495.313085864267;5497.202905578669;5501.367342755634;5547.1679248113105;5170.121079416508;5453.481919217668;5481.698506582096;5502.2296878437055;5529.723513824292;4225.049363893099;4231.386448964883;4232.047789247395;4238.576142385798;4266.935995960063;3727.440883867387;3774.1130834253927;3783.1487915218854;3809.9713077468928;3834.271488417192;5194;5195.116830138885;5195.818146364859;5198.688078715213;5250.842474725764;5444.183372494158;5500.972495137498;5506.779728810883;5508.7521061552325;5548.0845660466375;5126.846194614168;5182.766775495112;5184.7407629618365;5194.844154675366;5200.115980283285;4689.484156742756;4698.365720627671;4706.670533062721;4742.976285118552;4747.0031293428765;5623.915641265385;5647.322321321386;5648.717564121777;5656.208130861683;5669.688167150764;5442.591805614516;5477.397486276506;5539.307586551681;5606.6636001840025;5621.634593751393;5731.226284451545;5745.454181852718;5746.3966283541295;5752.309722833287;5753.194552762533;5468.589855760754;5469.042917489503;5472.015037293326;5472.261244731911;5472.808451704172;5379.4351593082165;5518.117101263779;5532.861678458071;5559.193916881949;5575.163725441216;5388.976094542025;5392.595555333287;5408.621396502207;5408.945910540844;5410.810621628224;5173.948260517347;5326.920096198638;5333.546648534918;5379.112446446449;5393.7033463159905;5333.759980800951;5357.116075847442;5388.757505912322;5413.702246376487;5431.402545720047;5407.972960135174;5413.621046526705;5432.103702888979;5433.809816656398;5440.156775699773;5201.765920533509;5309.283246761792;5326.600504962066;5344.946550534445;5360.16917377807 10:33:07 INFO - PROCESS | 9790 | |1;ext.html;595.6961949405804;639.9936000639993;653.183520599251;654.6595770199497;663.3068443476564;30943.2264193395;31766.52350214746;31768.364632707333;38206.61793382066;39205.803970980174;43686;44052;44522.10955780883;44591.77704111483;44643.33035004477;8687.478751274912;8910.910890891106;8923.687670931518;8923.866142007842;8927.464352138892;8642.222200002;8653.134686531328;8738.519381434018;8758.912410875906;8760.824783504326;8801.47191168532;8878.978917424514;8898.332625053146;8899.822003559924;8904.59929303183;8749.650013999464;8821.382503224777;8826.69106581273;8827.426217295855;8834.11658834118;8686.522241276727;8806.251468625174;8816.911830881672;8817.470951742851;8827.470351778913;41192.38211426831;41713.374299385534;41744.582554174674;41780.1643967122;41883.79058104721;3420.675035871613;4016.2168377166463;4061.2689715851134;4063;4260.062786187033;30937.381252374827;31069.533956990435;31543.21141971469;31572.210694732814;31962.840185799156;4178.6448151907125;4186.706930514865;4245.3844192591905;4344.608985191317;4394.384786129913;229350;229838;230743;231440;232244.83877580674;44887.77556112198;49829;55274.723626382416;56179;56229.71885140548;52069;52409;52499.73750131225;52573.474265257624;52805;16231.18844057816;16471.094089825176;16476.917615412087;16478.588035299214;16497.505074847533;11579;12388.256704597752;12673.619791406272;12779.424925878358;12842.165259258118;15829.445969391247;16149.677006459806;16154.192290385434;16220.756688649679;16330.591735206477;5976.551758618121;6000.159977603139;6019.277686677539;6079.635221886701;6084.209052823105;1106.363840791532;1118.8992990630882;1152.9942350288195;1168.6143572621015;1171.5723760827236;31775.205619859687;32215;32263;32323.403745557604;32559.674403255663;1152.1128730877178;1155.5031336525208;1156.2542160306555;1238.8312240879395;1243.322389297835;16976.151192440328;17016.23426945766;17059.829401705825;17130.743038854427;17493.7375939361;476800;478417;481725;481760;483813;57945.13082303769;58199.70900145472;58353;58377.416225838046;58395;1369.322185518155;1394.595567285476;1436.1454934314274;1439.1580925158898;1513.7653663682147;30441.543376849808;31032.844835775675;31489.614537171918;31796.68203317937;31953;50375;50685.23972140347;50784.74607626938;50790;50803;236160;407578;409728;410590;413542;35931.820340899176;36458.63541364553;36631.45052824156;36779.63220367762;37373.43939840959;41620.4899643745;41727.791361043;41779.54728013816;41810.790946045076;42778;35581.64418355783;35821.46267805933;35887.46168807522;36117.81941090383;36468.27063458769;37390.95302937356;38542.80728596339;38764.2247155061;38879.22241555097;39346;39083.80458097691;39588.20823583454;39876.401853971634;40140.38385585695;40766.79616601898;33726;34605.30789384148;35385;35412.46881296834;35556;24433.51132977366;25336.619950700384;26871.731282687706;27461.31346716348;27993 10:33:07 INFO - PROCESS | 9790 | |2;jquery.html;392.87428023032635;402.5672402167669;408.10013919307926;410.05891479055566;418.21793246628806;13828.585142445718;17620.118994050295;18040.368587099456;18312.084395780206;18315.17581708823;15354.232288385563;16168.35326586938;19199.616007679837;19200.231990720353;20214.292499762512;5586.832395028156;5757.798477053304;5766.221560089376;5768.913466298009;5778.248827652399;4199.874003779892;5776.277965254343;5819.272590926134;6080.14877917092;6403.935960640404;6319.873602527947;6343.048542718583;6377.489800815923;6379.266384365811;6382.20222472191;6121.173641558399;6255.624662520263;6257.593256438339;6258.5306102042305;6261.686915654199;4956.677815941952;5482.17767334899;5482.424345443751;5495.313085864267;5515.779368825242;12985.285809280485;13183.802242966267;13415.798763018562;13434.596962091153;13440.462381504825;2081.5004398944297;2164.891755412223;2270.3416009357265;2272.943176420586;2483.746292357;9614.423134611945;9840.409575425498;10048.241557727368;10262.7434314142;13428.261445620486;1775.6626241014167;1800.9639807203782;1809.5747499337645;1860.3956700261292;1870.8035656256034;79829.60085199594;81977.59011204906;83495;83521;84023;10558.630447934285;10645;10691.679249622524;10843.783124337628;10898.673039808818;15597.844021559638;15641.921790391203;15652.060876347456;15689.607759805867;15692.450764223197;8044.557549334726;8195.877061844078;8252.876206856901;8364.665413383518;8388;6953.478489113337;8015.118336982927;8067.435279530377;8170.632321545545;8180.959095204605;4225.492940847056;4403.559644035571;4422.535633758409;4515.277555591156;4528.071745292273;1837.1457272368414;1847.3072597775833;1896.630157119376;1900.3253844885144;1921.0490807050599;959.822432849925;960.5437417226901;990.5641517732175;992.156666833186;1035.006393861886;17902.731459028124;18315.267389304277;18474.722879156823;19781.505462363555;19839.30562430308;970.4371464550544;981.8478135888948;1001.9298649094493;1032.4373216596973;1085.7285678580356;10516.158707303397;11110.666679999613;11134.721631959104;11135.94432027851;11170.664880053611;378797;383751;385606;529324;542930;92638;99639.50180249197;99714;100695;102459.4877025625;1042.4162469017374;1065.973350666224;1089.2048804372694;1093.3439936038471;1096.2162054131334;17448.73826892572;17635.470935871945;17699.911500442417;17753.11234438299;18132.27470901202;39452;39751.80124099361;41057;41265.381019284134;41979.95050123771;58589;58691.4130858686;59086;59138.381853723826;60512.394876050676;5559.24950131727;5916.49709774674;8418;8790.340724445565;8798.868016979623;10978.505967231335;13615.52345667897;13819.654508637364;13842.377093030636;13933.651658708613;11328.773424531628;11766.647000589996;11833.526658933546;11847.940760296144;11944.104192185447;11450.141239407245;11537.480813363587;11569.826452603049;11716.355600441717;11798.646040618794;5794.275715535558;9726.902730972599;11190.440477976232;12119.939400302943;12171.148019638895;8574.571271436527;8676.826463470821;8747.956260218658;8786.956065219889;8810.383273170817;8468.322534197372;11189;11938.76122477563;12015.81976270374;12043.698907527381 10:33:07 INFO - PROCESS | 9790 | |3;mootools.html;1342.2416334770849;1496.0574837852153;1502.729508688436;1638.6558822647244;1747.3010795681735;7744.341730952869;8038.799030024237;8092.635831387594;8095.06906705729;8102;7830.138684744687;7915.802104947379;8015.7595272141925;8029.47808392454;8031.076426210988;1951.3072859135016;2142.7857214278524;2209.237812954528;2218.633925402307;2253.8196944244423;2173.793489618484;2173.9239126630573;2174.6194415977143;2181.2474696229774;2182.945426364338;2142.5607750411205;2145.1526646974435;2172.1094351315965;2176.0751680535786;2176.09691977829;1919.606480671466;2111.7782632823564;2166.739991201066;2169.1648715244746;2169.3600387885454;2111.926082587102;2133.3173384516963;2138.262299506683;2140.7217061782026;2141.3468891987936;7810.960945195295;7833.1775163608145;7856.567888766115;7879.0151231096115;7890.250426209558;4680.087382960324;4828.396450443694;4848.345473361122;4853.441854186778;4909.26361045846;3075.2311922019494;3082.1215953453157;3117.5323701444736;3158.96841031589;3167.4140284047294;1003.6286573967606;1010.4089107871904;1065.4885654885697;1066.1470823341297;1067.359584249452;10597.20520960931;10780.78438431227;10813.513391897384;10856.565737370496;11099.112071034378;3964.960350396517;4041.2725709372007;4087.0395457067566;4146.37804329353;4173.144505376391;8448.535330556879;8456.492610443393;8464.280536154496;8480.703175388831;8492.872606910902;4319.200947824663;4741.57325840676;4744.762761861962;4757.881052973634;4763.595094417014;4430.712003719748;4484.013517026249;4500.279955207151;4520.570545798144;4531.912341038127;3446.4485682290715;3506.474028895686;3524.647535246455;3538.3630946429375;3629.564452265692;1030.6701855406197;1073.903348698621;1082.4695899009587;1084.9294795838246;1086.9402182880017;819.2340161948597;824.4435006370676;847.4915050969369;884.0938038510578;923.0723123261214;5191.714455704897;5195.064888320063;5222.608304377187;5244.554212891947;5295.682259064469;390.8983664247316;399.76813448199977;400.2715058593332;407.5354096330186;413.074712643676;3636.7999760013454;3688.6495782900583;3716.275326311343;3720.4605332226674;3778.2065766188857;9716.31985761004;10165.69502914899;10193.898061019296;10205.336653117523;10225.693229203136;9852.753681157885;9878.851817222747;10029.598816047277;10103.292769506212;10204.948975255076;7615.885761713579;7725.806854828675;7729.690812367555;7737.883931741028;7750.728724494616;5068.341115654941;5104.081265372269;5141.048905952411;5255.264263003259;5312.601554883322;9207.677731279373;9268.134553524565;9307.72076837696;9415.340926135379;9430.764230894283;9391.248700103839;9447.385919915183;9549.52252387364;9563.474008929297;9567.234621230424;6286.74853005893;6610.6694665267505;6753.932460675331;6816.965915170393;6840.760573379908;7466.887996679946;7474.663640136098;7537.585432801248;7542.4720269582795;7562.168161502341;6730.6634668265415;6879.071325371011;6888.586684798727;7035.261297563887;7124.038254835738;6830.21452532965;6915.757948471779;6927.376536111774;6930.48021398387;6974.511784175059;6195.721192546436;6220.657863817533;6282.874342513215;6294.15028971083;6314.242290924934;4629.837955671535;4677.742724150205;4707.223308154254;4729.385179926588;4735.21868891629;4824.396950381202;4842.782074806712;4867.561919427269;4872.6832755870755;4914.5822605078965 10:33:07 INFO - PROCESS | 9790 | |4;prototype.html;321.77314992929985;326.31962358482565;328.1582740271205;335.1854992368545;335.61069159774667;5176.715280659567;5238.1357076082495;5257.395399529046;5270.130428479296;5279.683219006857;5161.4322424533275;5164.509371609701;5189.506996835304;5193.195054766507;5202.245674377213;3893.5593830282764;3931.941020884675;4081.8367265309353;4086.1010577672864;4086.284900142478;4034.838606455753;4054.2296963576828;4065.695072869532;4067.959320406788;4092.283850326181;3867.149227170018;4017.8392864285393;4018.6584140348104;4042.6967977401664;4044.8786536403954;3953.6244056814558;4072.165206132736;4075.755454672714;4091.079507110906;4095.5051406236807;3594.8382322795537;3615.4757560153894;3626.746127771057;3633.9636603634153;3636.8363423646;4973.502649735034;4992.40091189056;5020.3724534433195;5032.949670503322;5035.874103147414;4540.432445944257;4618.515055919147;4626.190416677102;4635.281531362644;4660.906781864378;5324.588983919264;5360.463953604608;5368.141097424433;5369.301990741179;5372.973135134338;3941.7437866538585;3952.6245006724316;3966.5240171179353;3982.283189025974;3991.6207960243732;5426.348838139409;5470.890582188334;5539.9169012464845;5582.8325150245155;5637.3517045539875;4026.7583944963394;4042.413849991735;4055.3916912463364;4055.7160998730396;4064.695147863922;4105.794710264475;4113.300738874398;4116.197341518435;4132.586741325904;4137.46212992309;4493.460784705856;4651.348811166439;4664.883377915579;4666.673332866667;4673.485916549177;5411.809401931648;5439.619226654097;5441.6190866639745;5448.882978989298;5453.890922181534;1483.2435457916324;1494.5964589560758;1498.520473448486;1499.392745937897;1502.9549113526612;954.5656726189567;1006.6476733143488;1020.739711373595;1031.0874875734878;1040.4953597505205;5451.700156491352;5557.221689059462;5561.694106824082;5564.165375193753;5569.805056823073;5878.677922220699;5882.470577648032;5893.11603259506;5901.645901245939;5906.084556893688;5388.595855310868;5537.501624853782;5562.471565201299;5577;5587.27365442498;3105.2547388626567;3125.6092988376454;3139.1681204480833;3140.874365025419;3149.118246890874;5884.58807883444;6056.909146362808;6073.453389194905;6106.4809491192855;6106.847328816815;5985.581009329305;6017.398260173947;6018;6018.247719035121;6029.78895738647;5979.940200597938;6019.879602408015;6029.638221706711;6030.517558595302;6046.123312119806;5722.284714410699;5843.2403787507355;5858.062709966385;5863.00328944072;5870.412958704095;5789.594728368974;5799.2750906136735;5804.5356371491025;5817;5833.533317334688;5950.571862752995;6065.939340606537;6068;6092.421219984094;6094.360092190256;4215.388768628471;4265.381519679691;4267.402563641155;4269.210196113729;4278.251306021496;5846.473817356458;5865.354810970704;5898.94101058984;5904.527637789052;5924.822255332347;5539.362973258127;5697.860427914351;5700.486956173964;5705.971470142623;5708.600397972268;5668.5465162787705;5691.146328050825;5694.345150307768;5701.515371193329;5704.971475142598;5119.054759191484;5209.4530074343165;5334.973325133349;5598.468145526169;5611.915821262766;5388.164834450667;5431;5459.481349271971;5467.172978914696;5495.670259784426;5352.625316227826;5358.196270559447;5381.224196015384;5395.919061214006;5406.810761623325 10:33:07 INFO - PROCESS | 9790 | |5;yui.html;731.3198725185575;742.7697413801721;793.8412317536494;812.5409143833733;830.7881490219993;14075.085119467227;14254.002219844615;14311.212883291415;14324.641883952907;14352.425902963882;12888.93555532221;13833.17000979942;13905.721885562283;13970.650733731662;14008.089474184197;813.2761841960645;831.9292860106898;832.2343444031505;832.675256649907;833.7165363776314;817.1746535998625;828.1387357148558;828.6850996621275;829.0176141272611;829.1128492513013;871.8299931513358;873.3624454148476;873.6723728601775;873.698573991975;873.7029410000598;866.2506931504266;867.1415298854153;867.8524650809378;868.0754995929378;868.4355169140047;637.4390536328002;637.9808605741836;638.2596188421455;638.4987784589122;638.6040654794058;12788.936055319664;12805.97552195822;12817.35913204336;12893;13215.60353189406;12368.381580921008;12750.61748147557;12787.232766033974;12814;13550.119242249222;10932.234743567953;10951.780964380669;11084.501197446134;11169.609063682732;11338.886611133948;3786.167043250508;3837.2901013312626;3849.749766265184;3851.5763266040713;3875.4961854958674;41639.7918010408;47809.52190478086;53406.46593534054;53519.19721204185;53753.92492150174;10720.410377429316;10821.080208182393;10983.39591322485;11027.669169924915;11062.944685276521;18680.439586812416;18701;18701;18708.25166993332;18749.531261718566;7693.846123077507;7788.337991270805;7831;7954.960225198837;7993.400494962901;4391.538888416734;4481.843135490242;4518.209313370147;4590.42619672541;4590.724556526619;3292.884749033772;3371.0392538127007;3374.865005399806;3375.8649654013566;3376.7973921564785;573.2347316332742;579.5711173731409;586.8356860079184;587.6386022596158;587.9559033072537;693.2443339655093;711;725.912890453149;749.0262658543871;807.5598798654747;9064.682736104205;9341.392809467363;9361.62553497866;9562.474063926411;9609.567569459392;594.7829042399493;655.1842955520408;670.4301343857682;731.3710209220067;755.8828381600861;4310.892227694333;4336.308839552514;4394.36281739146;4456.22016147173;4648.372469716613;68813.31186688069;70254.2974570258;70879;70915.64542177255;71282;45188;47320;52987;60681.39318606846;63157.68421157865;55409.72295138579;56416;57380.71309643509;57433.71283143641;57480.38975517869;8840.911590884267;9034.096590340914;9047.140521650434;9124.315676324435;9334.859977100485;31256.37487250197;34857.65142348544;35106.64893351034;35340.29319413649;35821.28357432889;47414;47453.288200676325;47827.5217247837;48908.2663760051;49367.7531612354;11896.107791915469;12113.333766642567;12120;12176;12719.491220351083;13046.217226966412;13403.530876419278;13746.793798093237;14118.082324648865;14363.712725745636;13056.151350162208;13144.145630533985;13211.735765284833;13339.733205336033;13388.397522111334;12118.151729378858;13052.282124482865;13187.67030824237;13897;14117.788233176716;12451.937740311241;12502.562410315595;12643.810342845049;13096.148750331198;13144.145630533985;10477.266591338534;11168.72078198019;11280.32318060919;11290.096792256763;11509;11004.504797284302;11063.612773552886;11088.677434831487;11215.60745373908;11529 10:33:07 INFO - PROCESS | 9790 | __end_tp_report 10:33:07 INFO - PROCESS | 9790 | __start_cc_report 10:33:07 INFO - PROCESS | 9790 | _x_x_mozilla_cycle_collect,848 10:33:07 INFO - PROCESS | 9790 | __end_cc_report 10:33:07 INFO - PROCESS | 9790 | __startTimestamp1461864787003__endTimestamp 10:33:07 INFO - PROCESS | 9790 | 10:33:07 INFO - PROCESS | 9790 | ------- Summary: start ------- 10:33:07 INFO - PROCESS | 9790 | Number of tests: 6 10:33:07 INFO - PROCESS | 9790 | 10:33:07 INFO - PROCESS | 9790 | [#0] dojo.html Cycles:165 Average:5138.47 Median:5333.55 stddev:557.51 (10.5%) stddev-sans-first:534.60 10:33:07 INFO - PROCESS | 9790 | Values: 3049.9 3108.4 3143.3 3144.1 3189.0 4938.7 5001.1 5183.1 5192.1 5219.0 5193.3 5208.8 5220.4 5259.1 5281.0 4713.0 4728.0 4748.7 4759.1 4908.4 4824.4 4833.4 4866.0 4884.2 4896.5 4663.2 4743.9 4746.3 4758.3 4762.3 4714.1 4731.9 4735.8 4751.6 4780.5 4583.6 4695.9 4707.2 4707.2 4743.6 5065.4 5072.3 5076.6 5101.9 5120.6 5441.4 5441.5 5457.2 5506.1 5514.3 5387.0 5513.4 5518.8 5590.3 5620.9 5225.6 5226.8 5239.3 5252.1 5272.4 5692.1 5704.2 5704.4 5705.4 5706.7 5227.9 5445.2 5461.6 5531.3 5543.5 5505.6 5510.5 5513.9 5514.4 5516.4 5489.8 5495.3 5497.2 5501.4 5547.2 5170.1 5453.5 5481.7 5502.2 5529.7 4225.0 4231.4 4232.0 4238.6 4266.9 3727.4 3774.1 3783.1 3810.0 3834.3 5194.0 5195.1 5195.8 5198.7 5250.8 5444.2 5501.0 5506.8 5508.8 5548.1 5126.8 5182.8 5184.7 5194.8 5200.1 4689.5 4698.4 4706.7 4743.0 4747.0 5623.9 5647.3 5648.7 5656.2 5669.7 5442.6 5477.4 5539.3 5606.7 5621.6 5731.2 5745.5 5746.4 5752.3 5753.2 5468.6 5469.0 5472.0 5472.3 5472.8 5379.4 5518.1 5532.9 5559.2 5575.2 5389.0 5392.6 5408.6 5408.9 5410.8 5173.9 5326.9 5333.5 5379.1 5393.7 5333.8 5357.1 5388.8 5413.7 5431.4 5408.0 5413.6 5432.1 5433.8 5440.2 5201.8 5309.3 5326.6 5344.9 5360.2 10:33:07 INFO - PROCESS | 9790 | 10:33:07 INFO - PROCESS | 9790 | [#1] ext.html Cycles:180 Average:52645.64 Median:22078.30 stddev:100342.19 (454.5%) stddev-sans-first:100547.57 10:33:07 INFO - PROCESS | 9790 | Values: 595.7 640.0 653.2 654.7 663.3 30943.2 31766.5 31768.4 38206.6 39205.8 43686.0 44052.0 44522.1 44591.8 44643.3 8687.5 8910.9 8923.7 8923.9 8927.5 8642.2 8653.1 8738.5 8758.9 8760.8 8801.5 8879.0 8898.3 8899.8 8904.6 8749.7 8821.4 8826.7 8827.4 8834.1 8686.5 8806.3 8816.9 8817.5 8827.5 41192.4 41713.4 41744.6 41780.2 41883.8 3420.7 4016.2 4061.3 4063.0 4260.1 30937.4 31069.5 31543.2 31572.2 31962.8 4178.6 4186.7 4245.4 4344.6 4394.4 229350.0 229838.0 230743.0 231440.0 232244.8 44887.8 49829.0 55274.7 56179.0 56229.7 52069.0 52409.0 52499.7 52573.5 52805.0 16231.2 16471.1 16476.9 16478.6 16497.5 11579.0 12388.3 12673.6 12779.4 12842.2 15829.4 16149.7 16154.2 16220.8 16330.6 5976.6 6000.2 6019.3 6079.6 6084.2 1106.4 1118.9 1153.0 1168.6 1171.6 31775.2 32215.0 32263.0 32323.4 32559.7 1152.1 1155.5 1156.3 1238.8 1243.3 16976.2 17016.2 17059.8 17130.7 17493.7 476800.0 478417.0 481725.0 481760.0 483813.0 57945.1 58199.7 58353.0 58377.4 58395.0 1369.3 1394.6 1436.1 1439.2 1513.8 30441.5 31032.8 31489.6 31796.7 31953.0 50375.0 50685.2 50784.7 50790.0 50803.0 236160.0 407578.0 409728.0 410590.0 413542.0 35931.8 36458.6 36631.5 36779.6 37373.4 41620.5 41727.8 41779.5 41810.8 42778.0 35581.6 35821.5 35887.5 36117.8 36468.3 37391.0 38542.8 38764.2 38879.2 39346.0 39083.8 39588.2 39876.4 40140.4 40766.8 33726.0 34605.3 35385.0 35412.5 35556.0 24433.5 25336.6 26871.7 27461.3 27993.0 10:33:07 INFO - PROCESS | 9790 | 10:33:07 INFO - PROCESS | 9790 | [#2] jquery.html Cycles:180 Average:27562.73 Median:190640.37 stddev:74848.57 (39.3%) stddev-sans-first:75030.74 10:33:07 INFO - PROCESS | 9790 | Values: 392.9 402.6 408.1 410.1 418.2 13828.6 17620.1 18040.4 18312.1 18315.2 15354.2 16168.4 19199.6 19200.2 20214.3 5586.8 5757.8 5766.2 5768.9 5778.2 4199.9 5776.3 5819.3 6080.1 6403.9 6319.9 6343.0 6377.5 6379.3 6382.2 6121.2 6255.6 6257.6 6258.5 6261.7 4956.7 5482.2 5482.4 5495.3 5515.8 12985.3 13183.8 13415.8 13434.6 13440.5 2081.5 2164.9 2270.3 2272.9 2483.7 9614.4 9840.4 10048.2 10262.7 13428.3 1775.7 1801.0 1809.6 1860.4 1870.8 79829.6 81977.6 83495.0 83521.0 84023.0 10558.6 10645.0 10691.7 10843.8 10898.7 15597.8 15641.9 15652.1 15689.6 15692.5 8044.6 8195.9 8252.9 8364.7 8388.0 6953.5 8015.1 8067.4 8170.6 8181.0 4225.5 4403.6 4422.5 4515.3 4528.1 1837.1 1847.3 1896.6 1900.3 1921.0 959.8 960.5 990.6 992.2 1035.0 17902.7 18315.3 18474.7 19781.5 19839.3 970.4 981.8 1001.9 1032.4 1085.7 10516.2 11110.7 11134.7 11135.9 11170.7 378797.0 383751.0 385606.0 529324.0 542930.0 92638.0 99639.5 99714.0 100695.0 102459.5 1042.4 1066.0 1089.2 1093.3 1096.2 17448.7 17635.5 17699.9 17753.1 18132.3 39452.0 39751.8 41057.0 41265.4 41980.0 58589.0 58691.4 59086.0 59138.4 60512.4 5559.2 5916.5 8418.0 8790.3 8798.9 10978.5 13615.5 13819.7 13842.4 13933.7 11328.8 11766.6 11833.5 11847.9 11944.1 11450.1 11537.5 11569.8 11716.4 11798.6 5794.3 9726.9 11190.4 12119.9 12171.1 8574.6 8676.8 8748.0 8787.0 8810.4 8468.3 11189.0 11938.8 12015.8 12043.7 10:33:07 INFO - PROCESS | 9790 | 10:33:07 INFO - PROCESS | 9790 | [#3] mootools.html Cycles:180 Average:5225.60 Median:4751.32 stddev:2975.26 (62.6%) stddev-sans-first:2969.29 10:33:07 INFO - PROCESS | 9790 | Values: 1342.2 1496.1 1502.7 1638.7 1747.3 7744.3 8038.8 8092.6 8095.1 8102.0 7830.1 7915.8 8015.8 8029.5 8031.1 1951.3 2142.8 2209.2 2218.6 2253.8 2173.8 2173.9 2174.6 2181.2 2182.9 2142.6 2145.2 2172.1 2176.1 2176.1 1919.6 2111.8 2166.7 2169.2 2169.4 2111.9 2133.3 2138.3 2140.7 2141.3 7811.0 7833.2 7856.6 7879.0 7890.3 4680.1 4828.4 4848.3 4853.4 4909.3 3075.2 3082.1 3117.5 3159.0 3167.4 1003.6 1010.4 1065.5 1066.1 1067.4 10597.2 10780.8 10813.5 10856.6 11099.1 3965.0 4041.3 4087.0 4146.4 4173.1 8448.5 8456.5 8464.3 8480.7 8492.9 4319.2 4741.6 4744.8 4757.9 4763.6 4430.7 4484.0 4500.3 4520.6 4531.9 3446.4 3506.5 3524.6 3538.4 3629.6 1030.7 1073.9 1082.5 1084.9 1086.9 819.2 824.4 847.5 884.1 923.1 5191.7 5195.1 5222.6 5244.6 5295.7 390.9 399.8 400.3 407.5 413.1 3636.8 3688.6 3716.3 3720.5 3778.2 9716.3 10165.7 10193.9 10205.3 10225.7 9852.8 9878.9 10029.6 10103.3 10204.9 7615.9 7725.8 7729.7 7737.9 7750.7 5068.3 5104.1 5141.0 5255.3 5312.6 9207.7 9268.1 9307.7 9415.3 9430.8 9391.2 9447.4 9549.5 9563.5 9567.2 6286.7 6610.7 6753.9 6817.0 6840.8 7466.9 7474.7 7537.6 7542.5 7562.2 6730.7 6879.1 6888.6 7035.3 7124.0 6830.2 6915.8 6927.4 6930.5 6974.5 6195.7 6220.7 6282.9 6294.2 6314.2 4629.8 4677.7 4707.2 4729.4 4735.2 4824.4 4842.8 4867.6 4872.7 4914.6 10:33:07 INFO - PROCESS | 9790 | 10:33:07 INFO - PROCESS | 9790 | [#4] prototype.html Cycles:180 Average:4703.49 Median:5302.14 stddev:1393.72 (26.3%) stddev-sans-first:1358.27 10:33:07 INFO - PROCESS | 9790 | Values: 321.8 326.3 328.2 335.2 335.6 5176.7 5238.1 5257.4 5270.1 5279.7 5161.4 5164.5 5189.5 5193.2 5202.2 3893.6 3931.9 4081.8 4086.1 4086.3 4034.8 4054.2 4065.7 4068.0 4092.3 3867.1 4017.8 4018.7 4042.7 4044.9 3953.6 4072.2 4075.8 4091.1 4095.5 3594.8 3615.5 3626.7 3634.0 3636.8 4973.5 4992.4 5020.4 5032.9 5035.9 4540.4 4618.5 4626.2 4635.3 4660.9 5324.6 5360.5 5368.1 5369.3 5373.0 3941.7 3952.6 3966.5 3982.3 3991.6 5426.3 5470.9 5539.9 5582.8 5637.4 4026.8 4042.4 4055.4 4055.7 4064.7 4105.8 4113.3 4116.2 4132.6 4137.5 4493.5 4651.3 4664.9 4666.7 4673.5 5411.8 5439.6 5441.6 5448.9 5453.9 1483.2 1494.6 1498.5 1499.4 1503.0 954.6 1006.6 1020.7 1031.1 1040.5 5451.7 5557.2 5561.7 5564.2 5569.8 5878.7 5882.5 5893.1 5901.6 5906.1 5388.6 5537.5 5562.5 5577.0 5587.3 3105.3 3125.6 3139.2 3140.9 3149.1 5884.6 6056.9 6073.5 6106.5 6106.8 5985.6 6017.4 6018.0 6018.2 6029.8 5979.9 6019.9 6029.6 6030.5 6046.1 5722.3 5843.2 5858.1 5863.0 5870.4 5789.6 5799.3 5804.5 5817.0 5833.5 5950.6 6065.9 6068.0 6092.4 6094.4 4215.4 4265.4 4267.4 4269.2 4278.3 5846.5 5865.4 5898.9 5904.5 5924.8 5539.4 5697.9 5700.5 5706.0 5708.6 5668.5 5691.1 5694.3 5701.5 5705.0 5119.1 5209.5 5335.0 5598.5 5611.9 5388.2 5431.0 5459.5 5467.2 5495.7 5352.6 5358.2 5381.2 5395.9 5406.8 10:33:07 INFO - PROCESS | 9790 | 10:33:07 INFO - PROCESS | 9790 | [#5] yui.html Cycles:180 Average:15141.64 Median:4469.03 stddev:18039.84 (403.7%) stddev-sans-first:18057.99 10:33:07 INFO - PROCESS | 9790 | Values: 731.3 742.8 793.8 812.5 830.8 14075.1 14254.0 14311.2 14324.6 14352.4 12888.9 13833.2 13905.7 13970.7 14008.1 813.3 831.9 832.2 832.7 833.7 817.2 828.1 828.7 829.0 829.1 871.8 873.4 873.7 873.7 873.7 866.3 867.1 867.9 868.1 868.4 637.4 638.0 638.3 638.5 638.6 12788.9 12806.0 12817.4 12893.0 13215.6 12368.4 12750.6 12787.2 12814.0 13550.1 10932.2 10951.8 11084.5 11169.6 11338.9 3786.2 3837.3 3849.7 3851.6 3875.5 41639.8 47809.5 53406.5 53519.2 53753.9 10720.4 10821.1 10983.4 11027.7 11062.9 18680.4 18701.0 18701.0 18708.3 18749.5 7693.8 7788.3 7831.0 7955.0 7993.4 4391.5 4481.8 4518.2 4590.4 4590.7 3292.9 3371.0 3374.9 3375.9 3376.8 573.2 579.6 586.8 587.6 588.0 693.2 711.0 725.9 749.0 807.6 9064.7 9341.4 9361.6 9562.5 9609.6 594.8 655.2 670.4 731.4 755.9 4310.9 4336.3 4394.4 4456.2 4648.4 68813.3 70254.3 70879.0 70915.6 71282.0 45188.0 47320.0 52987.0 60681.4 63157.7 55409.7 56416.0 57380.7 57433.7 57480.4 8840.9 9034.1 9047.1 9124.3 9334.9 31256.4 34857.7 35106.6 35340.3 35821.3 47414.0 47453.3 47827.5 48908.3 49367.8 11896.1 12113.3 12120.0 12176.0 12719.5 13046.2 13403.5 13746.8 14118.1 14363.7 13056.2 13144.1 13211.7 13339.7 13388.4 12118.2 13052.3 13187.7 13897.0 14117.8 12451.9 12502.6 12643.8 13096.1 13144.1 10477.3 11168.7 11280.3 11290.1 11509.0 11004.5 11063.6 11088.7 11215.6 11529.0 10:33:07 INFO - PROCESS | 9790 | -------- Summary: end -------- 10:33:07 INFO - PROCESS | 9790 | 10:33:07 INFO - TEST-INFO | 9790: exit 0 10:33:07 INFO - TEST-OK | dromaeo_css | took 1112051ms 10:33:07 INFO - TEST-START | kraken 10:33:07 INFO - operating with platform_type : linux_ 10:33:07 INFO - Initialising browser for kraken test... 10:33:07 INFO - TEST-INFO | started process 9982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppQgI0c/profile http://localhost:60668/getInfo.html) 10:33:11 INFO - PROCESS | 9982 | __metrics Screen width/height:1600/1200 10:33:11 INFO - PROCESS | 9982 | colorDepth:24 10:33:11 INFO - PROCESS | 9982 | Browser inner width/height: 1024/697 10:33:11 INFO - PROCESS | 9982 | __metrics 10:33:12 ERROR - PROCESS | 9982 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:33:13 INFO - TEST-INFO | 9982: exit 0 10:33:13 INFO - Browser initialized. 10:33:13 INFO - Running cycle 1/1 for kraken test... 10:33:13 INFO - TEST-INFO | started process 10063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppQgI0c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:25 INFO - PROCESS | 10063 | RSS: Main: 154497024 10:33:25 INFO - PROCESS | 10063 | 10:33:27 INFO - PROCESS | 10063 | Cycle 1(1): loaded http://localhost:60668/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60668/tests/kraken/driver.html?testName=audio-beat-detection) 10:33:28 INFO - PROCESS | 10063 | RSS: Main: 210210816 10:33:28 INFO - PROCESS | 10063 | 10:33:31 INFO - PROCESS | 10063 | Cycle 1(1): loaded http://localhost:60668/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60668/tests/kraken/driver.html?testName=audio-dft) 10:33:31 INFO - PROCESS | 10063 | RSS: Main: 195411968 10:33:31 INFO - PROCESS | 10063 | 10:33:35 INFO - PROCESS | 10063 | Cycle 1(1): loaded http://localhost:60668/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60668/tests/kraken/driver.html?testName=audio-fft) 10:33:35 INFO - PROCESS | 10063 | RSS: Main: 265969664 10:33:35 INFO - PROCESS | 10063 | 10:33:37 INFO - PROCESS | 10063 | Cycle 1(1): loaded http://localhost:60668/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60668/tests/kraken/driver.html?testName=audio-oscillator) 10:33:38 INFO - PROCESS | 10063 | RSS: Main: 174223360 10:33:38 INFO - PROCESS | 10063 | 10:33:40 INFO - PROCESS | 10063 | Cycle 1(1): loaded http://localhost:60668/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60668/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:33:41 INFO - PROCESS | 10063 | RSS: Main: 178393088 10:33:41 INFO - PROCESS | 10063 | 10:33:44 INFO - PROCESS | 10063 | Cycle 1(1): loaded http://localhost:60668/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60668/tests/kraken/driver.html?testName=imaging-darkroom) 10:33:44 INFO - PROCESS | 10063 | RSS: Main: 214638592 10:33:44 INFO - PROCESS | 10063 | 10:33:48 INFO - PROCESS | 10063 | Cycle 1(1): loaded http://localhost:60668/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60668/tests/kraken/driver.html?testName=imaging-desaturate) 10:33:48 INFO - PROCESS | 10063 | RSS: Main: 215855104 10:33:48 INFO - PROCESS | 10063 | 10:33:51 INFO - PROCESS | 10063 | Cycle 1(1): loaded http://localhost:60668/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60668/tests/kraken/driver.html?testName=json-parse-financial) 10:33:52 INFO - PROCESS | 10063 | RSS: Main: 215494656 10:33:52 INFO - PROCESS | 10063 | 10:33:53 INFO - PROCESS | 10063 | Cycle 1(1): loaded http://localhost:60668/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60668/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:33:54 INFO - PROCESS | 10063 | RSS: Main: 201637888 10:33:54 INFO - PROCESS | 10063 | 10:33:55 INFO - PROCESS | 10063 | Cycle 1(1): loaded http://localhost:60668/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60668/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:33:56 INFO - PROCESS | 10063 | RSS: Main: 205627392 10:33:56 INFO - PROCESS | 10063 | 10:33:58 INFO - PROCESS | 10063 | Cycle 1(1): loaded http://localhost:60668/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60668/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:33:59 INFO - PROCESS | 10063 | RSS: Main: 216199168 10:33:59 INFO - PROCESS | 10063 | 10:34:01 INFO - PROCESS | 10063 | Cycle 1(1): loaded http://localhost:60668/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:34:02 INFO - PROCESS | 10063 | RSS: Main: 222875648 10:34:02 INFO - PROCESS | 10063 | 10:34:05 INFO - PROCESS | 10063 | Cycle 1(1): loaded http://localhost:60668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:34:05 INFO - PROCESS | 10063 | RSS: Main: 219213824 10:34:05 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | Cycle 1(1): loaded http://localhost:60668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60668/tests/kraken/driver.html?testName=ai-astar) 10:34:07 INFO - PROCESS | 10063 | RSS: Main: 283250688 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | __start_tp_report 10:34:07 INFO - PROCESS | 10063 | _x_x_mozilla_page_load 10:34:07 INFO - PROCESS | 10063 | _x_x_mozilla_page_load_details 10:34:07 INFO - PROCESS | 10063 | |i|pagename|runs| 10:34:07 INFO - PROCESS | 10063 | |0;ai-astar;111;112;106;110;111;111;99;111;110;109 10:34:07 INFO - PROCESS | 10063 | |1;audio-beat-detection;155;130;164;181;132;155;166;128;180;135 10:34:07 INFO - PROCESS | 10063 | |2;audio-dft;160;161;161;159;160;160;162;166;162;160 10:34:07 INFO - PROCESS | 10063 | |3;audio-fft;73;77;104;105;76;76;73;127;103;74 10:34:07 INFO - PROCESS | 10063 | |4;audio-oscillator;97;93;144;92;93;93;145;92;92;144 10:34:07 INFO - PROCESS | 10063 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;116;117 10:34:07 INFO - PROCESS | 10063 | |6;imaging-darkroom;145;146;146;145;145;145;144;145;145;146 10:34:07 INFO - PROCESS | 10063 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;94;94 10:34:07 INFO - PROCESS | 10063 | |8;json-parse-financial;58;59;58;58;61;58;59;78;56;57 10:34:07 INFO - PROCESS | 10063 | |9;json-stringify-tinderbox;61;62;62;62;62;60;61;60;61;61 10:34:07 INFO - PROCESS | 10063 | |10;stanford-crypto-aes;76;74;77;77;77;77;84;77;78;77 10:34:07 INFO - PROCESS | 10063 | |11;stanford-crypto-ccm;122;121;124;121;122;118;124;130;152;128 10:34:07 INFO - PROCESS | 10063 | |12;stanford-crypto-pbkdf2;165;165;172;170;166;167;171;170;171;177 10:34:07 INFO - PROCESS | 10063 | |13;stanford-crypto-sha256-iterative;69;68;68;68;70;67;67;69;70;65 10:34:07 INFO - PROCESS | 10063 | __end_tp_report 10:34:07 INFO - PROCESS | 10063 | __start_cc_report 10:34:07 INFO - PROCESS | 10063 | _x_x_mozilla_cycle_collect,1640 10:34:07 INFO - PROCESS | 10063 | __end_cc_report 10:34:07 INFO - PROCESS | 10063 | __startTimestamp1461864847843__endTimestamp 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | ------- Summary: start ------- 10:34:07 INFO - PROCESS | 10063 | Number of tests: 14 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:3.89 (3.5%) stddev-sans-first:4.06 10:34:07 INFO - PROCESS | 10063 | Values: 111.0 112.0 106.0 110.0 111.0 111.0 99.0 111.0 110.0 109.0 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:159.50 stddev:20.35 (12.8%) stddev-sans-first:21.57 10:34:07 INFO - PROCESS | 10063 | Values: 155.0 130.0 164.0 181.0 132.0 155.0 166.0 128.0 180.0 135.0 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.97 (1.2%) stddev-sans-first:2.05 10:34:07 INFO - PROCESS | 10063 | Values: 160.0 161.0 161.0 159.0 160.0 160.0 162.0 166.0 162.0 160.0 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | [#3] audio-fft Cycles:10 Average:88.80 Median:73.50 stddev:19.26 (26.2%) stddev-sans-first:19.56 10:34:07 INFO - PROCESS | 10063 | Values: 73.0 77.0 104.0 105.0 76.0 76.0 73.0 127.0 103.0 74.0 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:92.50 stddev:24.77 (26.8%) stddev-sans-first:25.92 10:34:07 INFO - PROCESS | 10063 | Values: 97.0 93.0 144.0 92.0 93.0 93.0 145.0 92.0 92.0 144.0 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 10:34:07 INFO - PROCESS | 10063 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 10:34:07 INFO - PROCESS | 10063 | Values: 145.0 146.0 146.0 145.0 145.0 145.0 144.0 145.0 145.0 146.0 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:34:07 INFO - PROCESS | 10063 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:58.50 stddev:6.39 (10.9%) stddev-sans-first:6.73 10:34:07 INFO - PROCESS | 10063 | Values: 58.0 59.0 58.0 58.0 61.0 58.0 59.0 78.0 56.0 57.0 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.50 stddev:0.79 (1.3%) stddev-sans-first:0.83 10:34:07 INFO - PROCESS | 10063 | Values: 61.0 62.0 62.0 62.0 62.0 60.0 61.0 60.0 61.0 61.0 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:77.00 stddev:2.55 (3.3%) stddev-sans-first:2.65 10:34:07 INFO - PROCESS | 10063 | Values: 76.0 74.0 77.0 77.0 77.0 77.0 84.0 77.0 78.0 77.0 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:124.00 stddev:9.72 (7.8%) stddev-sans-first:10.19 10:34:07 INFO - PROCESS | 10063 | Values: 122.0 121.0 124.0 121.0 122.0 118.0 124.0 130.0 152.0 128.0 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:170.50 stddev:3.75 (2.2%) stddev-sans-first:3.62 10:34:07 INFO - PROCESS | 10063 | Values: 165.0 165.0 172.0 170.0 166.0 167.0 171.0 170.0 171.0 177.0 10:34:07 INFO - PROCESS | 10063 | 10:34:07 INFO - PROCESS | 10063 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:1.52 (2.2%) stddev-sans-first:1.58 10:34:07 INFO - PROCESS | 10063 | Values: 69.0 68.0 68.0 68.0 70.0 67.0 67.0 69.0 70.0 65.0 10:34:07 INFO - PROCESS | 10063 | -------- Summary: end -------- 10:34:07 INFO - PROCESS | 10063 | 10:34:08 INFO - TEST-INFO | 10063: exit 0 10:34:08 INFO - TEST-OK | kraken | took 61075ms 10:34:08 INFO - SUITE-END | took 1173s 10:34:08 INFO - Completed test suite (00:19:33) 10:34:08 INFO - javascript benchmark 10:34:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3049.9237519062026, 3108.3938631966776, 3143.2770462793555, 3144.135362775235, 3188.9795265515036, 4938.678985865916, 5001.149804533229, 5183.144781111117, 5192.117340052186, 5218.973905130474, 5193.272941788153, 5208.817691380802, 5220.373555173384, 5259.079661059319, 5281.023010743005, 4713.0, 4728.0, 4748.667593268473, 4759.071980963713, 4908.361912951329, 4824.44518880328, 4833.444153922291, 4865.975670121645, 4884.242942343943, 4896.46138924718, 4663.183942810012, 4743.90512189756, 4746.335513028144, 4758.3100450434495, 4762.333273341735, 4714.127886341038, 4731.858044258678, 4735.810567577293, 4751.64362672801, 4780.545848144456, 4583.610393116589, 4695.859124226278, 4707.176244157259, 4707.246840505502, 4743.596794272491, 5065.442801291855, 5072.34059572257, 5076.6192535559985, 5101.923471147936, 5120.641555091145, 5441.374241962186, 5441.537469315113, 5457.181422786574, 5506.146547285177, 5514.255575497296, 5387.0, 5513.42109078549, 5518.779248830042, 5590.273264475592, 5620.859478513029, 5225.634205605571, 5226.764795584169, 5239.318888544503, 5252.107141785906, 5272.367315922075, 5692.089265717465, 5704.172894930211, 5704.4295570443455, 5705.372409035002, 5706.743196556165, 5227.947720522822, 5445.237666726662, 5461.590380721462, 5531.308586426697, 5543.501084902378, 5505.559555235572, 5510.476504732044, 5513.889722205534, 5514.365847927459, 5516.393196748354, 5489.807856725075, 5495.313085864267, 5497.202905578669, 5501.367342755634, 5547.1679248113105, 5170.121079416508, 5453.481919217668, 5481.698506582096, 5502.2296878437055, 5529.723513824292, 4225.049363893099, 4231.386448964883, 4232.047789247395, 4238.576142385798, 4266.935995960063, 3727.440883867387, 3774.1130834253927, 3783.1487915218854, 3809.9713077468928, 3834.271488417192, 5194.0, 5195.116830138885, 5195.818146364859, 5198.688078715213, 5250.842474725764, 5444.183372494158, 5500.972495137498, 5506.779728810883, 5508.7521061552325, 5548.0845660466375, 5126.846194614168, 5182.766775495112, 5184.7407629618365, 5194.844154675366, 5200.115980283285, 4689.484156742756, 4698.365720627671, 4706.670533062721, 4742.976285118552, 4747.0031293428765, 5623.915641265385, 5647.322321321386, 5648.717564121777, 5656.208130861683, 5669.688167150764, 5442.591805614516, 5477.397486276506, 5539.307586551681, 5606.6636001840025, 5621.634593751393, 5731.226284451545, 5745.454181852718, 5746.3966283541295, 5752.309722833287, 5753.194552762533, 5468.589855760754, 5469.042917489503, 5472.015037293326, 5472.261244731911, 5472.808451704172, 5379.4351593082165, 5518.117101263779, 5532.861678458071, 5559.193916881949, 5575.163725441216, 5388.976094542025, 5392.595555333287, 5408.621396502207, 5408.945910540844, 5410.810621628224, 5173.948260517347, 5326.920096198638, 5333.546648534918, 5379.112446446449, 5393.7033463159905, 5333.759980800951, 5357.116075847442, 5388.757505912322, 5413.702246376487, 5431.402545720047, 5407.972960135174, 5413.621046526705, 5432.103702888979, 5433.809816656398, 5440.156775699773, 5201.765920533509, 5309.283246761792, 5326.600504962066, 5344.946550534445, 5360.16917377807], "value": 5103.07732901431, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.6961949405804, 639.9936000639993, 653.183520599251, 654.6595770199497, 663.3068443476564, 30943.2264193395, 31766.52350214746, 31768.364632707333, 38206.61793382066, 39205.803970980174, 43686.0, 44052.0, 44522.10955780883, 44591.77704111483, 44643.33035004477, 8687.478751274912, 8910.910890891106, 8923.687670931518, 8923.866142007842, 8927.464352138892, 8642.222200002, 8653.134686531328, 8738.519381434018, 8758.912410875906, 8760.824783504326, 8801.47191168532, 8878.978917424514, 8898.332625053146, 8899.822003559924, 8904.59929303183, 8749.650013999464, 8821.382503224777, 8826.69106581273, 8827.426217295855, 8834.11658834118, 8686.522241276727, 8806.251468625174, 8816.911830881672, 8817.470951742851, 8827.470351778913, 41192.38211426831, 41713.374299385534, 41744.582554174674, 41780.1643967122, 41883.79058104721, 3420.675035871613, 4016.2168377166463, 4061.2689715851134, 4063.0, 4260.062786187033, 30937.381252374827, 31069.533956990435, 31543.21141971469, 31572.210694732814, 31962.840185799156, 4178.6448151907125, 4186.706930514865, 4245.3844192591905, 4344.608985191317, 4394.384786129913, 229350.0, 229838.0, 230743.0, 231440.0, 232244.83877580674, 44887.77556112198, 49829.0, 55274.723626382416, 56179.0, 56229.71885140548, 52069.0, 52409.0, 52499.73750131225, 52573.474265257624, 52805.0, 16231.18844057816, 16471.094089825176, 16476.917615412087, 16478.588035299214, 16497.505074847533, 11579.0, 12388.256704597752, 12673.619791406272, 12779.424925878358, 12842.165259258118, 15829.445969391247, 16149.677006459806, 16154.192290385434, 16220.756688649679, 16330.591735206477, 5976.551758618121, 6000.159977603139, 6019.277686677539, 6079.635221886701, 6084.209052823105, 1106.363840791532, 1118.8992990630882, 1152.9942350288195, 1168.6143572621015, 1171.5723760827236, 31775.205619859687, 32215.0, 32263.0, 32323.403745557604, 32559.674403255663, 1152.1128730877178, 1155.5031336525208, 1156.2542160306555, 1238.8312240879395, 1243.322389297835, 16976.151192440328, 17016.23426945766, 17059.829401705825, 17130.743038854427, 17493.7375939361, 476800.0, 478417.0, 481725.0, 481760.0, 483813.0, 57945.13082303769, 58199.70900145472, 58353.0, 58377.416225838046, 58395.0, 1369.322185518155, 1394.595567285476, 1436.1454934314274, 1439.1580925158898, 1513.7653663682147, 30441.543376849808, 31032.844835775675, 31489.614537171918, 31796.68203317937, 31953.0, 50375.0, 50685.23972140347, 50784.74607626938, 50790.0, 50803.0, 236160.0, 407578.0, 409728.0, 410590.0, 413542.0, 35931.820340899176, 36458.63541364553, 36631.45052824156, 36779.63220367762, 37373.43939840959, 41620.4899643745, 41727.791361043, 41779.54728013816, 41810.790946045076, 42778.0, 35581.64418355783, 35821.46267805933, 35887.46168807522, 36117.81941090383, 36468.27063458769, 37390.95302937356, 38542.80728596339, 38764.2247155061, 38879.22241555097, 39346.0, 39083.80458097691, 39588.20823583454, 39876.401853971634, 40140.38385585695, 40766.79616601898, 33726.0, 34605.30789384148, 35385.0, 35412.46881296834, 35556.0, 24433.51132977366, 25336.619950700384, 26871.731282687706, 27461.31346716348, 27993.0], "value": 19341.633357759365, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.87428023032635, 402.5672402167669, 408.10013919307926, 410.05891479055566, 418.21793246628806, 13828.585142445718, 17620.118994050295, 18040.368587099456, 18312.084395780206, 18315.17581708823, 15354.232288385563, 16168.35326586938, 19199.616007679837, 19200.231990720353, 20214.292499762512, 5586.832395028156, 5757.798477053304, 5766.221560089376, 5768.913466298009, 5778.248827652399, 4199.874003779892, 5776.277965254343, 5819.272590926134, 6080.14877917092, 6403.935960640404, 6319.873602527947, 6343.048542718583, 6377.489800815923, 6379.266384365811, 6382.20222472191, 6121.173641558399, 6255.624662520263, 6257.593256438339, 6258.5306102042305, 6261.686915654199, 4956.677815941952, 5482.17767334899, 5482.424345443751, 5495.313085864267, 5515.779368825242, 12985.285809280485, 13183.802242966267, 13415.798763018562, 13434.596962091153, 13440.462381504825, 2081.5004398944297, 2164.891755412223, 2270.3416009357265, 2272.943176420586, 2483.746292357, 9614.423134611945, 9840.409575425498, 10048.241557727368, 10262.7434314142, 13428.261445620486, 1775.6626241014167, 1800.9639807203782, 1809.5747499337645, 1860.3956700261292, 1870.8035656256034, 79829.60085199594, 81977.59011204906, 83495.0, 83521.0, 84023.0, 10558.630447934285, 10645.0, 10691.679249622524, 10843.783124337628, 10898.673039808818, 15597.844021559638, 15641.921790391203, 15652.060876347456, 15689.607759805867, 15692.450764223197, 8044.557549334726, 8195.877061844078, 8252.876206856901, 8364.665413383518, 8388.0, 6953.478489113337, 8015.118336982927, 8067.435279530377, 8170.632321545545, 8180.959095204605, 4225.492940847056, 4403.559644035571, 4422.535633758409, 4515.277555591156, 4528.071745292273, 1837.1457272368414, 1847.3072597775833, 1896.630157119376, 1900.3253844885144, 1921.0490807050599, 959.822432849925, 960.5437417226901, 990.5641517732175, 992.156666833186, 1035.006393861886, 17902.731459028124, 18315.267389304277, 18474.722879156823, 19781.505462363555, 19839.30562430308, 970.4371464550544, 981.8478135888948, 1001.9298649094493, 1032.4373216596973, 1085.7285678580356, 10516.158707303397, 11110.666679999613, 11134.721631959104, 11135.94432027851, 11170.664880053611, 378797.0, 383751.0, 385606.0, 529324.0, 542930.0, 92638.0, 99639.50180249197, 99714.0, 100695.0, 102459.4877025625, 1042.4162469017374, 1065.973350666224, 1089.2048804372694, 1093.3439936038471, 1096.2162054131334, 17448.73826892572, 17635.470935871945, 17699.911500442417, 17753.11234438299, 18132.27470901202, 39452.0, 39751.80124099361, 41057.0, 41265.381019284134, 41979.95050123771, 58589.0, 58691.4130858686, 59086.0, 59138.381853723826, 60512.394876050676, 5559.24950131727, 5916.49709774674, 8418.0, 8790.340724445565, 8798.868016979623, 10978.505967231335, 13615.52345667897, 13819.654508637364, 13842.377093030636, 13933.651658708613, 11328.773424531628, 11766.647000589996, 11833.526658933546, 11847.940760296144, 11944.104192185447, 11450.141239407245, 11537.480813363587, 11569.826452603049, 11716.355600441717, 11798.646040618794, 5794.275715535558, 9726.902730972599, 11190.440477976232, 12119.939400302943, 12171.148019638895, 8574.571271436527, 8676.826463470821, 8747.956260218658, 8786.956065219889, 8810.383273170817, 8468.322534197372, 11189.0, 11938.76122477563, 12015.81976270374, 12043.698907527381], "value": 8989.365330168028, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.2416334770849, 1496.0574837852153, 1502.729508688436, 1638.6558822647244, 1747.3010795681735, 7744.341730952869, 8038.799030024237, 8092.635831387594, 8095.06906705729, 8102.0, 7830.138684744687, 7915.802104947379, 8015.7595272141925, 8029.47808392454, 8031.076426210988, 1951.3072859135016, 2142.7857214278524, 2209.237812954528, 2218.633925402307, 2253.8196944244423, 2173.793489618484, 2173.9239126630573, 2174.6194415977143, 2181.2474696229774, 2182.945426364338, 2142.5607750411205, 2145.1526646974435, 2172.1094351315965, 2176.0751680535786, 2176.09691977829, 1919.606480671466, 2111.7782632823564, 2166.739991201066, 2169.1648715244746, 2169.3600387885454, 2111.926082587102, 2133.3173384516963, 2138.262299506683, 2140.7217061782026, 2141.3468891987936, 7810.960945195295, 7833.1775163608145, 7856.567888766115, 7879.0151231096115, 7890.250426209558, 4680.087382960324, 4828.396450443694, 4848.345473361122, 4853.441854186778, 4909.26361045846, 3075.2311922019494, 3082.1215953453157, 3117.5323701444736, 3158.96841031589, 3167.4140284047294, 1003.6286573967606, 1010.4089107871904, 1065.4885654885697, 1066.1470823341297, 1067.359584249452, 10597.20520960931, 10780.78438431227, 10813.513391897384, 10856.565737370496, 11099.112071034378, 3964.960350396517, 4041.2725709372007, 4087.0395457067566, 4146.37804329353, 4173.144505376391, 8448.535330556879, 8456.492610443393, 8464.280536154496, 8480.703175388831, 8492.872606910902, 4319.200947824663, 4741.57325840676, 4744.762761861962, 4757.881052973634, 4763.595094417014, 4430.712003719748, 4484.013517026249, 4500.279955207151, 4520.570545798144, 4531.912341038127, 3446.4485682290715, 3506.474028895686, 3524.647535246455, 3538.3630946429375, 3629.564452265692, 1030.6701855406197, 1073.903348698621, 1082.4695899009587, 1084.9294795838246, 1086.9402182880017, 819.2340161948597, 824.4435006370676, 847.4915050969369, 884.0938038510578, 923.0723123261214, 5191.714455704897, 5195.064888320063, 5222.608304377187, 5244.554212891947, 5295.682259064469, 390.8983664247316, 399.76813448199977, 400.2715058593332, 407.5354096330186, 413.074712643676, 3636.7999760013454, 3688.6495782900583, 3716.275326311343, 3720.4605332226674, 3778.2065766188857, 9716.31985761004, 10165.69502914899, 10193.898061019296, 10205.336653117523, 10225.693229203136, 9852.753681157885, 9878.851817222747, 10029.598816047277, 10103.292769506212, 10204.948975255076, 7615.885761713579, 7725.806854828675, 7729.690812367555, 7737.883931741028, 7750.728724494616, 5068.341115654941, 5104.081265372269, 5141.048905952411, 5255.264263003259, 5312.601554883322, 9207.677731279373, 9268.134553524565, 9307.72076837696, 9415.340926135379, 9430.764230894283, 9391.248700103839, 9447.385919915183, 9549.52252387364, 9563.474008929297, 9567.234621230424, 6286.74853005893, 6610.6694665267505, 6753.932460675331, 6816.965915170393, 6840.760573379908, 7466.887996679946, 7474.663640136098, 7537.585432801248, 7542.4720269582795, 7562.168161502341, 6730.6634668265415, 6879.071325371011, 6888.586684798727, 7035.261297563887, 7124.038254835738, 6830.21452532965, 6915.757948471779, 6927.376536111774, 6930.48021398387, 6974.511784175059, 6195.721192546436, 6220.657863817533, 6282.874342513215, 6294.15028971083, 6314.242290924934, 4629.837955671535, 4677.742724150205, 4707.223308154254, 4729.385179926588, 4735.21868891629, 4824.396950381202, 4842.782074806712, 4867.561919427269, 4872.6832755870755, 4914.5822605078965], "value": 4119.493456559172, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.77314992929985, 326.31962358482565, 328.1582740271205, 335.1854992368545, 335.61069159774667, 5176.715280659567, 5238.1357076082495, 5257.395399529046, 5270.130428479296, 5279.683219006857, 5161.4322424533275, 5164.509371609701, 5189.506996835304, 5193.195054766507, 5202.245674377213, 3893.5593830282764, 3931.941020884675, 4081.8367265309353, 4086.1010577672864, 4086.284900142478, 4034.838606455753, 4054.2296963576828, 4065.695072869532, 4067.959320406788, 4092.283850326181, 3867.149227170018, 4017.8392864285393, 4018.6584140348104, 4042.6967977401664, 4044.8786536403954, 3953.6244056814558, 4072.165206132736, 4075.755454672714, 4091.079507110906, 4095.5051406236807, 3594.8382322795537, 3615.4757560153894, 3626.746127771057, 3633.9636603634153, 3636.8363423646, 4973.502649735034, 4992.40091189056, 5020.3724534433195, 5032.949670503322, 5035.874103147414, 4540.432445944257, 4618.515055919147, 4626.190416677102, 4635.281531362644, 4660.906781864378, 5324.588983919264, 5360.463953604608, 5368.141097424433, 5369.301990741179, 5372.973135134338, 3941.7437866538585, 3952.6245006724316, 3966.5240171179353, 3982.283189025974, 3991.6207960243732, 5426.348838139409, 5470.890582188334, 5539.9169012464845, 5582.8325150245155, 5637.3517045539875, 4026.7583944963394, 4042.413849991735, 4055.3916912463364, 4055.7160998730396, 4064.695147863922, 4105.794710264475, 4113.300738874398, 4116.197341518435, 4132.586741325904, 4137.46212992309, 4493.460784705856, 4651.348811166439, 4664.883377915579, 4666.673332866667, 4673.485916549177, 5411.809401931648, 5439.619226654097, 5441.6190866639745, 5448.882978989298, 5453.890922181534, 1483.2435457916324, 1494.5964589560758, 1498.520473448486, 1499.392745937897, 1502.9549113526612, 954.5656726189567, 1006.6476733143488, 1020.739711373595, 1031.0874875734878, 1040.4953597505205, 5451.700156491352, 5557.221689059462, 5561.694106824082, 5564.165375193753, 5569.805056823073, 5878.677922220699, 5882.470577648032, 5893.11603259506, 5901.645901245939, 5906.084556893688, 5388.595855310868, 5537.501624853782, 5562.471565201299, 5577.0, 5587.27365442498, 3105.2547388626567, 3125.6092988376454, 3139.1681204480833, 3140.874365025419, 3149.118246890874, 5884.58807883444, 6056.909146362808, 6073.453389194905, 6106.4809491192855, 6106.847328816815, 5985.581009329305, 6017.398260173947, 6018.0, 6018.247719035121, 6029.78895738647, 5979.940200597938, 6019.879602408015, 6029.638221706711, 6030.517558595302, 6046.123312119806, 5722.284714410699, 5843.2403787507355, 5858.062709966385, 5863.00328944072, 5870.412958704095, 5789.594728368974, 5799.2750906136735, 5804.5356371491025, 5817.0, 5833.533317334688, 5950.571862752995, 6065.939340606537, 6068.0, 6092.421219984094, 6094.360092190256, 4215.388768628471, 4265.381519679691, 4267.402563641155, 4269.210196113729, 4278.251306021496, 5846.473817356458, 5865.354810970704, 5898.94101058984, 5904.527637789052, 5924.822255332347, 5539.362973258127, 5697.860427914351, 5700.486956173964, 5705.971470142623, 5708.600397972268, 5668.5465162787705, 5691.146328050825, 5694.345150307768, 5701.515371193329, 5704.971475142598, 5119.054759191484, 5209.4530074343165, 5334.973325133349, 5598.468145526169, 5611.915821262766, 5388.164834450667, 5431.0, 5459.481349271971, 5467.172978914696, 5495.670259784426, 5352.625316227826, 5358.196270559447, 5381.224196015384, 5395.919061214006, 5406.810761623325], "value": 4266.514990104684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.3198725185575, 742.7697413801721, 793.8412317536494, 812.5409143833733, 830.7881490219993, 14075.085119467227, 14254.002219844615, 14311.212883291415, 14324.641883952907, 14352.425902963882, 12888.93555532221, 13833.17000979942, 13905.721885562283, 13970.650733731662, 14008.089474184197, 813.2761841960645, 831.9292860106898, 832.2343444031505, 832.675256649907, 833.7165363776314, 817.1746535998625, 828.1387357148558, 828.6850996621275, 829.0176141272611, 829.1128492513013, 871.8299931513358, 873.3624454148476, 873.6723728601775, 873.698573991975, 873.7029410000598, 866.2506931504266, 867.1415298854153, 867.8524650809378, 868.0754995929378, 868.4355169140047, 637.4390536328002, 637.9808605741836, 638.2596188421455, 638.4987784589122, 638.6040654794058, 12788.936055319664, 12805.97552195822, 12817.35913204336, 12893.0, 13215.60353189406, 12368.381580921008, 12750.61748147557, 12787.232766033974, 12814.0, 13550.119242249222, 10932.234743567953, 10951.780964380669, 11084.501197446134, 11169.609063682732, 11338.886611133948, 3786.167043250508, 3837.2901013312626, 3849.749766265184, 3851.5763266040713, 3875.4961854958674, 41639.7918010408, 47809.52190478086, 53406.46593534054, 53519.19721204185, 53753.92492150174, 10720.410377429316, 10821.080208182393, 10983.39591322485, 11027.669169924915, 11062.944685276521, 18680.439586812416, 18701.0, 18701.0, 18708.25166993332, 18749.531261718566, 7693.846123077507, 7788.337991270805, 7831.0, 7954.960225198837, 7993.400494962901, 4391.538888416734, 4481.843135490242, 4518.209313370147, 4590.42619672541, 4590.724556526619, 3292.884749033772, 3371.0392538127007, 3374.865005399806, 3375.8649654013566, 3376.7973921564785, 573.2347316332742, 579.5711173731409, 586.8356860079184, 587.6386022596158, 587.9559033072537, 693.2443339655093, 711.0, 725.912890453149, 749.0262658543871, 807.5598798654747, 9064.682736104205, 9341.392809467363, 9361.62553497866, 9562.474063926411, 9609.567569459392, 594.7829042399493, 655.1842955520408, 670.4301343857682, 731.3710209220067, 755.8828381600861, 4310.892227694333, 4336.308839552514, 4394.36281739146, 4456.22016147173, 4648.372469716613, 68813.31186688069, 70254.2974570258, 70879.0, 70915.64542177255, 71282.0, 45188.0, 47320.0, 52987.0, 60681.39318606846, 63157.68421157865, 55409.72295138579, 56416.0, 57380.71309643509, 57433.71283143641, 57480.38975517869, 8840.911590884267, 9034.096590340914, 9047.140521650434, 9124.315676324435, 9334.859977100485, 31256.37487250197, 34857.65142348544, 35106.64893351034, 35340.29319413649, 35821.28357432889, 47414.0, 47453.288200676325, 47827.5217247837, 48908.2663760051, 49367.7531612354, 11896.107791915469, 12113.333766642567, 12120.0, 12176.0, 12719.491220351083, 13046.217226966412, 13403.530876419278, 13746.793798093237, 14118.082324648865, 14363.712725745636, 13056.151350162208, 13144.145630533985, 13211.735765284833, 13339.733205336033, 13388.397522111334, 12118.151729378858, 13052.282124482865, 13187.67030824237, 13897.0, 14117.788233176716, 12451.937740311241, 12502.562410315595, 12643.810342845049, 13096.148750331198, 13144.145630533985, 10477.266591338534, 11168.72078198019, 11280.32318060919, 11290.096792256763, 11509.0, 11004.504797284302, 11063.612773552886, 11088.677434831487, 11215.60745373908, 11529.0], "value": 6774.644807870063, "unit": "score"}], "name": "dromaeo_css", "value": 6875.712219520506, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 106.0, 110.0, 111.0, 111.0, 99.0, 111.0, 110.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 164.0, 181.0, 132.0, 155.0, 166.0, 128.0, 180.0, 135.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 159.0, 160.0, 160.0, 162.0, 166.0, 162.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 104.0, 105.0, 76.0, 76.0, 73.0, 127.0, 103.0, 74.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 93.0, 144.0, 92.0, 93.0, 93.0, 145.0, 92.0, 92.0, 144.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 146.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 61.0, 58.0, 59.0, 78.0, 56.0, 57.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 60.0, 61.0, 60.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 77.0, 77.0, 77.0, 84.0, 77.0, 78.0, 77.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 124.0, 121.0, 122.0, 118.0, 124.0, 130.0, 152.0, 128.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 172.0, 170.0, 166.0, 167.0, 171.0, 170.0, 171.0, 177.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 68.0, 70.0, 67.0, 67.0, 69.0, 70.0, 65.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1539.2000000000003, "alertThreshold": 2.0}]} 10:34:09 INFO - Return code: 0 10:34:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:34:09 ERROR - # TBPL SUCCESS # 10:34:09 INFO - Running post-action listener: _resource_record_post_action 10:34:09 INFO - Running post-run listener: _resource_record_post_run 10:34:10 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 163840; Write bytes: 289157120; Read time: 320; Write time: 159440 10:34:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1249280; Read time: 0; Write time: 60 10:34:10 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 163840; Write bytes: 287907840; Read time: 320; Write time: 159380 10:34:10 INFO - Running post-run listener: _upload_blobber_files 10:34:10 INFO - Blob upload gear active. 10:34:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:34:10 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 10:34:10 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'] 10:34:10 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 10:34:10 INFO - (blobuploader) - INFO - Open directory for files ... 10:34:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:34:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:34:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:11 INFO - (blobuploader) - INFO - Done attempting. 10:34:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:34:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:34:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:12 INFO - (blobuploader) - INFO - Done attempting. 10:34:12 INFO - (blobuploader) - INFO - Iteration through files over. 10:34:12 INFO - Return code: 0 10:34:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:34:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:34:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c62a5a36e335787761e53a6dc299b4d6448e8c31e6f8a74275f5d24d64bfadc9562f420b52a989ae314666c19917ad584bf2f98ea1edfec72d17e57afeec0c4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be785865a47469a32ebe1faeb831b0bbac13dbf58cebba7b9d8e957f89055e35f896863bc37e350741c83dc0cf4fd26a4c4fc8f74368e194c8e40d28e0f0b84a"} 10:34:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:34:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:34:12 INFO - Contents: 10:34:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c62a5a36e335787761e53a6dc299b4d6448e8c31e6f8a74275f5d24d64bfadc9562f420b52a989ae314666c19917ad584bf2f98ea1edfec72d17e57afeec0c4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be785865a47469a32ebe1faeb831b0bbac13dbf58cebba7b9d8e957f89055e35f896863bc37e350741c83dc0cf4fd26a4c4fc8f74368e194c8e40d28e0f0b84a"} 10:34:12 INFO - Running post-run listener: copy_logs_to_upload_dir 10:34:12 INFO - Copying logs to upload dir... 10:34:12 INFO - mkdir: /builds/slave/test/build/upload/logs 10:34:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.831513 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-28 10:34:12.410504) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 10:34:12.414063) ========= 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=232498196343f89f466a4a9a000001c8-1461862186.56488-773782793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c62a5a36e335787761e53a6dc299b4d6448e8c31e6f8a74275f5d24d64bfadc9562f420b52a989ae314666c19917ad584bf2f98ea1edfec72d17e57afeec0c4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be785865a47469a32ebe1faeb831b0bbac13dbf58cebba7b9d8e957f89055e35f896863bc37e350741c83dc0cf4fd26a4c4fc8f74368e194c8e40d28e0f0b84a"} build_url:https://queue.taskcluster.net/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011084 build_url: 'https://queue.taskcluster.net/v1/task/QHBCD-I_RY2hoSAiHUN0hQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c62a5a36e335787761e53a6dc299b4d6448e8c31e6f8a74275f5d24d64bfadc9562f420b52a989ae314666c19917ad584bf2f98ea1edfec72d17e57afeec0c4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be785865a47469a32ebe1faeb831b0bbac13dbf58cebba7b9d8e957f89055e35f896863bc37e350741c83dc0cf4fd26a4c4fc8f74368e194c8e40d28e0f0b84a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 10:34:12.438333) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:34:12.438668) ========= 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=232498196343f89f466a4a9a000001c8-1461862186.56488-773782793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:34:12.525356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 10:34:12.525695) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 10:34:12.526001) ========= ========= Total master_lag: 0.17 =========