builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1461974794.03 results: success (0) buildid: 20160429143019 builduid: f63777fa5e9f4d1bbcdc171f8981130e revision: d2674a65a6e8a0bd7c0954cbdf2a2babc8921a57 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 17:06:34.034601) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 17:06:34.035094) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 17:06:34.035367) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 17:06:34.066201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 17:06:34.066633) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 17:06:34-- 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% 44.4M=0s 2016-04-29 17:06:34 (44.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101467 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 17:06:34.182280) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 17:06:34.182596) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019446 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 17:06:34.233140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 17:06:34.233511) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d2674a65a6e8a0bd7c0954cbdf2a2babc8921a57 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d2674a65a6e8a0bd7c0954cbdf2a2babc8921a57 --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=c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 17:06:34,374 truncating revision to first 12 chars 2016-04-29 17:06:34,374 Setting DEBUG logging. 2016-04-29 17:06:34,374 attempt 1/10 2016-04-29 17:06:34,374 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d2674a65a6e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 17:06:34,633 unpacking tar archive at: fx-team-d2674a65a6e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.580465 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 17:06:34.827000) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 17:06:34.827329) ========= script_repo_revision: d2674a65a6e8a0bd7c0954cbdf2a2babc8921a57 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 17:06:34.827717) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 17:06:34.827994) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 17:06:34.836804) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-29 17:06:34.837229) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:06:35 INFO - MultiFileLogger online at 20160429 17:06:35 in /builds/slave/test 17:06:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:06:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:06:35 INFO - {'append_to_log': False, 17:06:35 INFO - 'base_work_dir': '/builds/slave/test', 17:06:35 INFO - 'blob_upload_branch': 'Fx-Team', 17:06:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:06:35 INFO - 'branch': 'Fx-Team', 17:06:35 INFO - 'buildbot_json_path': 'buildprops.json', 17:06:35 INFO - 'config_files': ('talos/linux_config.py',), 17:06:35 INFO - 'default_actions': ('clobber', 17:06:35 INFO - 'read-buildbot-config', 17:06:35 INFO - 'download-and-extract', 17:06:35 INFO - 'populate-webroot', 17:06:35 INFO - 'create-virtualenv', 17:06:35 INFO - 'install', 17:06:35 INFO - 'run-tests'), 17:06:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:06:35 INFO - 'download_minidump_stackwalk': True, 17:06:35 INFO - 'download_symbols': 'ondemand', 17:06:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:06:35 INFO - 'tooltool.py': '/tools/tooltool.py', 17:06:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:06:35 INFO - '/tools/misc-python/virtualenv.py')}, 17:06:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:06:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:06:35 INFO - 'installer_path': 'installer.exe', 17:06:35 INFO - 'log_level': 'info', 17:06:35 INFO - 'log_name': 'talos', 17:06:35 INFO - 'log_to_console': True, 17:06:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:06:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:06:35 INFO - 'opt_config_files': (), 17:06:35 INFO - 'pip_index': False, 17:06:35 INFO - 'sps_profile': False, 17:06:35 INFO - 'sps_profile_interval': 0, 17:06:35 INFO - 'suite': 'dromaeojs-e10s', 17:06:35 INFO - 'system_bits': '32', 17:06:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:06:35 INFO - 'title': 'talos-linux64-ix-004', 17:06:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:06:35 INFO - 'use_talos_json': True, 17:06:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:06:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:06:35 INFO - 'work_dir': 'build'} 17:06:35 INFO - ##### 17:06:35 INFO - ##### Running clobber step. 17:06:35 INFO - ##### 17:06:35 INFO - Running pre-action listener: _resource_record_pre_action 17:06:35 INFO - Running main action method: clobber 17:06:35 INFO - rmtree: /builds/slave/test/build 17:06:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:06:35 INFO - Running post-action listener: _resource_record_post_action 17:06:35 INFO - ##### 17:06:35 INFO - ##### Running read-buildbot-config step. 17:06:35 INFO - ##### 17:06:35 INFO - Running pre-action listener: _resource_record_pre_action 17:06:35 INFO - Running main action method: read_buildbot_config 17:06:35 INFO - Using buildbot properties: 17:06:35 INFO - { 17:06:35 INFO - "project": "", 17:06:35 INFO - "product": "firefox", 17:06:35 INFO - "script_repo_revision": "production", 17:06:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:06:35 INFO - "repository": "", 17:06:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:06:35 INFO - "buildid": "20160429143019", 17:06:35 INFO - "pgo_build": "True", 17:06:35 INFO - "basedir": "/builds/slave/test", 17:06:35 INFO - "buildnumber": 425, 17:06:35 INFO - "slavename": "talos-linux64-ix-004", 17:06:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:06:35 INFO - "platform": "ubuntu64_hw", 17:06:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:06:35 INFO - "branch": "fx-team", 17:06:35 INFO - "repo_path": "integration/fx-team", 17:06:35 INFO - "revision": "d2674a65a6e8a0bd7c0954cbdf2a2babc8921a57", 17:06:35 INFO - "stage_platform": "linux64-pgo", 17:06:35 INFO - "builduid": "f63777fa5e9f4d1bbcdc171f8981130e", 17:06:35 INFO - "slavebuilddir": "test" 17:06:35 INFO - } 17:06:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:06:35 INFO - Running post-action listener: _resource_record_post_action 17:06:35 INFO - ##### 17:06:35 INFO - ##### Running download-and-extract step. 17:06:35 INFO - ##### 17:06:35 INFO - Running pre-action listener: _resource_record_pre_action 17:06:35 INFO - Running main action method: download_and_extract 17:06:35 INFO - mkdir: /builds/slave/test/build/tests 17:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:35 INFO - https://queue.taskcluster.net/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:06:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:06:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:06:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/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 17:06:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/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 17:06:40 INFO - Downloaded 1361 bytes. 17:06:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:06:40 INFO - Using the following test package requirements: 17:06:40 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:40 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:06:40 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:06:40 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:40 INFO - u'jsshell-linux-x86_64.zip'], 17:06:40 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:06:40 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:40 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:06:40 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:06:40 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:06:40 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:06:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:06:40 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')]} 17:06:40 INFO - https://queue.taskcluster.net/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/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 17:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/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 17:06:47 INFO - Downloaded 23873634 bytes. 17:06:47 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'] 17:06:47 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 17:06:48 INFO - Return code: 0 17:06:48 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 17:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:48 INFO - https://queue.taskcluster.net/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/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 17:06:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/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 17:06:59 INFO - Downloaded 23873634 bytes. 17:06:59 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'] 17:06:59 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 17:07:01 INFO - Return code: 0 17:07: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')]} 17:07:01 INFO - https://queue.taskcluster.net/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:07:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:07:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:07:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/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 17:07:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/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 17:07:02 INFO - Downloaded 10840145 bytes. 17:07:02 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'] 17:07:02 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 17:07:02 INFO - Return code: 0 17:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:02 INFO - https://queue.taskcluster.net/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:07:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:07:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:07:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/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 17:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U8kdgV-IR5KtxAwttYaDFw/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 17:07:03 INFO - Downloaded 58385672 bytes. 17:07:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:07:03 INFO - mkdir: /builds/slave/test/properties 17:07:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:07:03 INFO - Writing to file /builds/slave/test/properties/build_url 17:07:03 INFO - Contents: 17:07:03 INFO - build_url:https://queue.taskcluster.net/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:07:04 INFO - Running post-action listener: _resource_record_post_action 17:07:04 INFO - Running post-action listener: set_extra_try_arguments 17:07:04 INFO - ##### 17:07:04 INFO - ##### Running populate-webroot step. 17:07:04 INFO - ##### 17:07:04 INFO - Running pre-action listener: _resource_record_pre_action 17:07:04 INFO - Running main action method: populate_webroot 17:07:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:07:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:07:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:07:04 INFO - '--tppagecycles', 17:07:04 INFO - '7'], 17:07:04 INFO - 'tests': ['tsvgm']}}, 17:07:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:07:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:07:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:07:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:07:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:07:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:07:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['damp', 'tps']}, 17:07:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'tests': ['damp', 'tps']}, 17:07:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['dromaeo_dom']}, 17:07:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:07:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['a11yr', 17:07:04 INFO - 'ts_paint', 17:07:04 INFO - 'tpaint', 17:07:04 INFO - 'sessionrestore', 17:07:04 INFO - 'sessionrestore_no_auto_restore', 17:07:04 INFO - 'tabpaint']}, 17:07:04 INFO - 'other-e10s': {'tests': ['a11yr', 17:07:04 INFO - 'ts_paint', 17:07:04 INFO - 'tpaint', 17:07:04 INFO - 'sessionrestore', 17:07:04 INFO - 'sessionrestore_no_auto_restore', 17:07:04 INFO - 'tabpaint']}, 17:07:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:07:04 INFO - 'ts_paint', 17:07:04 INFO - 'tpaint', 17:07:04 INFO - 'sessionrestore', 17:07:04 INFO - 'sessionrestore_no_auto_restore', 17:07:04 INFO - 'tabpaint']}, 17:07:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:07:04 INFO - 'ts_paint', 17:07:04 INFO - 'tpaint', 17:07:04 INFO - 'sessionrestore', 17:07:04 INFO - 'sessionrestore_no_auto_restore', 17:07:04 INFO - 'tabpaint']}, 17:07:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['a11yr', 17:07:04 INFO - 'ts_paint', 17:07:04 INFO - 'tpaint', 17:07:04 INFO - 'sessionrestore', 17:07:04 INFO - 'sessionrestore_no_auto_restore', 17:07:04 INFO - 'tabpaint']}, 17:07:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['a11yr', 17:07:04 INFO - 'ts_paint', 17:07:04 INFO - 'tpaint', 17:07:04 INFO - 'sessionrestore', 17:07:04 INFO - 'sessionrestore_no_auto_restore', 17:07:04 INFO - 'tabpaint']}, 17:07:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['tsvgx', 17:07:04 INFO - 'tsvgr_opacity', 17:07:04 INFO - 'tart', 17:07:04 INFO - 'tscrollx', 17:07:04 INFO - 'cart']}, 17:07:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:07:04 INFO - 'tsvgr_opacity', 17:07:04 INFO - 'tart', 17:07:04 INFO - 'tscrollx', 17:07:04 INFO - 'cart']}, 17:07:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['tp5o']}, 17:07:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'tests': ['tp5o']}, 17:07:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'talos_options': ['--disable-e10s', 17:07:04 INFO - '--xperf_path', 17:07:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:07:04 INFO - 'tests': ['tp5n']}, 17:07:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'talos_options': ['--xperf_path', 17:07:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:07:04 INFO - 'tests': ['tp5n']}}, 17:07:04 INFO - 'talos.zip': {'path': '', 17:07:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:07:04 INFO - Running post-action listener: _resource_record_post_action 17:07:04 INFO - ##### 17:07:04 INFO - ##### Running create-virtualenv step. 17:07:04 INFO - ##### 17:07:04 INFO - Running pre-action listener: _resource_record_pre_action 17:07:04 INFO - Running main action method: create_virtualenv 17:07:04 INFO - Creating virtualenv /builds/slave/test/build/venv 17:07:04 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 17:07:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:07:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:07:04 INFO - Using real prefix '/usr' 17:07:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:07:05 INFO - Installing distribute.............................................................................................................................................................................................done. 17:07:07 INFO - Installing pip.................done. 17:07:07 INFO - Return code: 0 17:07:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:07: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')]} 17:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07: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')]} 17:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:07 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 0x7f0ab876af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2410>, '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 0x20e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e37a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', '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 17:07:07 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 17:07:07 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 17:07:07 INFO - Using env: {'DISPLAY': ':0', 17:07:07 INFO - 'HOME': '/home/cltbld', 17:07:07 INFO - 'LANG': 'en_US.UTF-8', 17:07:07 INFO - 'LANGUAGE': 'en_US:en', 17:07:07 INFO - 'LOGNAME': 'cltbld', 17:07:07 INFO - 'MAIL': '/var/mail/cltbld', 17:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:07 INFO - 'MOZ_NO_REMOTE': '1', 17:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:07 INFO - 'NO_EM_RESTART': '1', 17:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:07 INFO - 'PWD': '/builds/slave/test', 17:07:07 INFO - 'SHELL': '/bin/bash', 17:07:07 INFO - 'SHLVL': '1', 17:07:07 INFO - 'TERM': 'linux', 17:07:07 INFO - 'TMOUT': '86400', 17:07:07 INFO - 'USER': 'cltbld', 17:07:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', 17:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:07 INFO - '_': '/tools/buildbot/bin/python'} 17:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:07 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 17:07:07 INFO - Cleaning up... 17:07:07 INFO - Return code: 0 17:07:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:07: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')]} 17:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07: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')]} 17:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:07 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 0x7f0ab876af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2410>, '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 0x20e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e37a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', '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 17:07:07 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 17:07:07 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 17:07:07 INFO - Using env: {'DISPLAY': ':0', 17:07:07 INFO - 'HOME': '/home/cltbld', 17:07:07 INFO - 'LANG': 'en_US.UTF-8', 17:07:07 INFO - 'LANGUAGE': 'en_US:en', 17:07:07 INFO - 'LOGNAME': 'cltbld', 17:07:07 INFO - 'MAIL': '/var/mail/cltbld', 17:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:07 INFO - 'MOZ_NO_REMOTE': '1', 17:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:07 INFO - 'NO_EM_RESTART': '1', 17:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:07 INFO - 'PWD': '/builds/slave/test', 17:07:07 INFO - 'SHELL': '/bin/bash', 17:07:07 INFO - 'SHLVL': '1', 17:07:07 INFO - 'TERM': 'linux', 17:07:07 INFO - 'TMOUT': '86400', 17:07:07 INFO - 'USER': 'cltbld', 17:07:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', 17:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:07 INFO - '_': '/tools/buildbot/bin/python'} 17:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:07 INFO - Downloading/unpacking psutil>=0.7.1 17:07:07 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 17:07:07 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 17:07:07 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 17:07:07 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 17:07:07 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 17:07:07 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 17:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:07:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:07:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:07:09 INFO - Installing collected packages: psutil 17:07:09 INFO - Running setup.py install for psutil 17:07:09 INFO - building 'psutil._psutil_linux' extension 17:07:09 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 17:07:09 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 17:07:10 INFO - building 'psutil._psutil_posix' extension 17:07:10 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 17:07:10 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 17:07:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:07:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:07:10 INFO - Successfully installed psutil 17:07:10 INFO - Cleaning up... 17:07:10 INFO - Return code: 0 17:07:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:10 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 0x7f0ab876af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2410>, '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 0x20e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e37a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', '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 17:07:10 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 17:07:10 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 17:07:10 INFO - Using env: {'DISPLAY': ':0', 17:07:10 INFO - 'HOME': '/home/cltbld', 17:07:10 INFO - 'LANG': 'en_US.UTF-8', 17:07:10 INFO - 'LANGUAGE': 'en_US:en', 17:07:10 INFO - 'LOGNAME': 'cltbld', 17:07:10 INFO - 'MAIL': '/var/mail/cltbld', 17:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:10 INFO - 'MOZ_NO_REMOTE': '1', 17:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:10 INFO - 'NO_EM_RESTART': '1', 17:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:10 INFO - 'PWD': '/builds/slave/test', 17:07:10 INFO - 'SHELL': '/bin/bash', 17:07:10 INFO - 'SHLVL': '1', 17:07:10 INFO - 'TERM': 'linux', 17:07:10 INFO - 'TMOUT': '86400', 17:07:10 INFO - 'USER': 'cltbld', 17:07:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', 17:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:10 INFO - '_': '/tools/buildbot/bin/python'} 17:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:07:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:07:12 INFO - Installing collected packages: mozsystemmonitor 17:07:12 INFO - Running setup.py install for mozsystemmonitor 17:07:12 INFO - Successfully installed mozsystemmonitor 17:07:12 INFO - Cleaning up... 17:07:12 INFO - Return code: 0 17:07:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:07: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')]} 17:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07: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')]} 17:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07: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', '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 0x7f0ab876af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2410>, '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 0x20e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e37a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', '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 17:07: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:07: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 blobuploader==1.2.4 17:07:12 INFO - Using env: {'DISPLAY': ':0', 17:07:12 INFO - 'HOME': '/home/cltbld', 17:07:12 INFO - 'LANG': 'en_US.UTF-8', 17:07:12 INFO - 'LANGUAGE': 'en_US:en', 17:07:12 INFO - 'LOGNAME': 'cltbld', 17:07:12 INFO - 'MAIL': '/var/mail/cltbld', 17:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:12 INFO - 'MOZ_NO_REMOTE': '1', 17:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:12 INFO - 'NO_EM_RESTART': '1', 17:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:12 INFO - 'PWD': '/builds/slave/test', 17:07:12 INFO - 'SHELL': '/bin/bash', 17:07:12 INFO - 'SHLVL': '1', 17:07:12 INFO - 'TERM': 'linux', 17:07:12 INFO - 'TMOUT': '86400', 17:07:12 INFO - 'USER': 'cltbld', 17:07:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', 17:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:12 INFO - '_': '/tools/buildbot/bin/python'} 17:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:12 INFO - Downloading/unpacking blobuploader==1.2.4 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07:14 INFO - Downloading blobuploader-1.2.4.tar.gz 17:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:07:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:07:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:15 INFO - Downloading docopt-0.6.1.tar.gz 17:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:07:15 INFO - Installing collected packages: blobuploader, requests, docopt 17:07:15 INFO - Running setup.py install for blobuploader 17:07:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:07:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:07:15 INFO - Running setup.py install for requests 17:07:16 INFO - Running setup.py install for docopt 17:07:16 INFO - Successfully installed blobuploader requests docopt 17:07:16 INFO - Cleaning up... 17:07:16 INFO - Return code: 0 17:07:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:16 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 0x7f0ab876af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2410>, '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 0x20e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e37a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', '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 17:07:16 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 17:07:16 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 17:07:16 INFO - Using env: {'DISPLAY': ':0', 17:07:16 INFO - 'HOME': '/home/cltbld', 17:07:16 INFO - 'LANG': 'en_US.UTF-8', 17:07:16 INFO - 'LANGUAGE': 'en_US:en', 17:07:16 INFO - 'LOGNAME': 'cltbld', 17:07:16 INFO - 'MAIL': '/var/mail/cltbld', 17:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:16 INFO - 'MOZ_NO_REMOTE': '1', 17:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:16 INFO - 'NO_EM_RESTART': '1', 17:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:16 INFO - 'PWD': '/builds/slave/test', 17:07:16 INFO - 'SHELL': '/bin/bash', 17:07:16 INFO - 'SHLVL': '1', 17:07:16 INFO - 'TERM': 'linux', 17:07:16 INFO - 'TMOUT': '86400', 17:07:16 INFO - 'USER': 'cltbld', 17:07:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', 17:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:16 INFO - '_': '/tools/buildbot/bin/python'} 17:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:07:16 INFO - Running setup.py (path:/tmp/pip-cua_0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:07:16 INFO - Running setup.py (path:/tmp/pip-mSsEGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:07:16 INFO - Running setup.py (path:/tmp/pip-4IFB_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:07:16 INFO - Running setup.py (path:/tmp/pip-uJ2pTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:07:16 INFO - Running setup.py (path:/tmp/pip-tVL8Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:07:16 INFO - Running setup.py (path:/tmp/pip-qpHs7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:07:16 INFO - Running setup.py (path:/tmp/pip-sMybTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:07:16 INFO - Running setup.py (path:/tmp/pip-8ku1MK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:07:16 INFO - Running setup.py (path:/tmp/pip-iVS05f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:07:17 INFO - Running setup.py (path:/tmp/pip-lRI1Fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:07:17 INFO - Running setup.py (path:/tmp/pip-ilDbJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:07:17 INFO - Running setup.py (path:/tmp/pip-eel8FI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:07:17 INFO - Running setup.py (path:/tmp/pip-zz34AX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:07:17 INFO - Running setup.py (path:/tmp/pip-BlNi8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:07:17 INFO - Running setup.py (path:/tmp/pip-Zhruyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:07:17 INFO - Running setup.py (path:/tmp/pip-AlMDoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:07:17 INFO - Running setup.py (path:/tmp/pip-KZybQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:07:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:07:17 INFO - Running setup.py install for manifestparser 17:07:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:07:17 INFO - Running setup.py install for mozcrash 17:07:17 INFO - Running setup.py install for mozdebug 17:07:17 INFO - Running setup.py install for mozdevice 17:07:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:07:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:07:18 INFO - Running setup.py install for mozfile 17:07:18 INFO - Running setup.py install for mozhttpd 17:07:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:07:18 INFO - Running setup.py install for mozinfo 17:07:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:07:18 INFO - Running setup.py install for mozInstall 17:07:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:07:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:07:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:07:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:07:18 INFO - Running setup.py install for mozleak 17:07:18 INFO - Running setup.py install for mozlog 17:07:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:07:18 INFO - Running setup.py install for moznetwork 17:07:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:07:18 INFO - Running setup.py install for mozprocess 17:07:18 INFO - Running setup.py install for mozprofile 17:07:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:07:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:07:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:07:18 INFO - Running setup.py install for mozrunner 17:07:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:07:19 INFO - Running setup.py install for mozscreenshot 17:07:19 INFO - Running setup.py install for moztest 17:07:19 INFO - Running setup.py install for mozversion 17:07:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:07:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:07:19 INFO - Cleaning up... 17:07:19 INFO - Return code: 0 17:07:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:19 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 0x7f0ab876af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2410>, '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 0x20e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e37a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', '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 17:07:19 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 17:07:19 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 17:07:19 INFO - Using env: {'DISPLAY': ':0', 17:07:19 INFO - 'HOME': '/home/cltbld', 17:07:19 INFO - 'LANG': 'en_US.UTF-8', 17:07:19 INFO - 'LANGUAGE': 'en_US:en', 17:07:19 INFO - 'LOGNAME': 'cltbld', 17:07:19 INFO - 'MAIL': '/var/mail/cltbld', 17:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:19 INFO - 'MOZ_NO_REMOTE': '1', 17:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:19 INFO - 'NO_EM_RESTART': '1', 17:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:19 INFO - 'PWD': '/builds/slave/test', 17:07:19 INFO - 'SHELL': '/bin/bash', 17:07:19 INFO - 'SHLVL': '1', 17:07:19 INFO - 'TERM': 'linux', 17:07:19 INFO - 'TMOUT': '86400', 17:07:19 INFO - 'USER': 'cltbld', 17:07:19 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', 17:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:19 INFO - '_': '/tools/buildbot/bin/python'} 17:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:07:19 INFO - Running setup.py (path:/tmp/pip-u5Z8Z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:07:19 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)) 17:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:07:19 INFO - Running setup.py (path:/tmp/pip-30hJcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:07:19 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)) 17:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:07:19 INFO - Running setup.py (path:/tmp/pip-udZKqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:07:19 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)) 17:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:07:19 INFO - Running setup.py (path:/tmp/pip-LOtxr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:07:19 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)) 17:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:07:19 INFO - Running setup.py (path:/tmp/pip-o0FrEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:07:19 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)) 17:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:07:19 INFO - Running setup.py (path:/tmp/pip-4ULtRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:07:20 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)) 17:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:07:20 INFO - Running setup.py (path:/tmp/pip-WbIk1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:07:20 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)) 17:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:07:20 INFO - Running setup.py (path:/tmp/pip-0KAiGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:07:20 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)) 17:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:07:20 INFO - Running setup.py (path:/tmp/pip-LIruUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:07:20 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)) 17:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:07:20 INFO - Running setup.py (path:/tmp/pip-4tP84K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:07:20 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)) 17:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:07:20 INFO - Running setup.py (path:/tmp/pip-BYjATv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:07:20 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)) 17:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:07:20 INFO - Running setup.py (path:/tmp/pip-I13jNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:07:20 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)) 17:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:07:20 INFO - Running setup.py (path:/tmp/pip-aPT6KQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:07:20 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)) 17:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:07:20 INFO - Running setup.py (path:/tmp/pip-OLqVui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:07:20 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)) 17:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:07:20 INFO - Running setup.py (path:/tmp/pip-HUb3uB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:07:20 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)) 17:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:07:20 INFO - Running setup.py (path:/tmp/pip-UNchij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:07:20 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)) 17:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:07:20 INFO - Running setup.py (path:/tmp/pip-zqx3CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:07:20 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)) 17:07:20 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)) 17:07:20 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)) 17:07:20 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)) 17:07:20 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)) 17:07:20 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)) 17:07:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:22 INFO - Downloading blessings-1.6.tar.gz 17:07:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:07:22 INFO - Installing collected packages: blessings 17:07:22 INFO - Running setup.py install for blessings 17:07:22 INFO - Successfully installed blessings 17:07:22 INFO - Cleaning up... 17:07:22 INFO - Return code: 0 17:07:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:07:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:07:23 INFO - Reading from file tmpfile_stdout 17:07:23 INFO - Current package versions: 17:07:23 INFO - argparse == 1.2.1 17:07:23 INFO - blessings == 1.6 17:07:23 INFO - blobuploader == 1.2.4 17:07:23 INFO - docopt == 0.6.1 17:07:23 INFO - manifestparser == 1.1 17:07:23 INFO - mozInstall == 1.12 17:07:23 INFO - mozcrash == 0.17 17:07:23 INFO - mozdebug == 0.1 17:07:23 INFO - mozdevice == 0.48 17:07:23 INFO - mozfile == 1.2 17:07:23 INFO - mozhttpd == 0.7 17:07:23 INFO - mozinfo == 0.9 17:07:23 INFO - mozleak == 0.1 17:07:23 INFO - mozlog == 3.1 17:07:23 INFO - moznetwork == 0.27 17:07:23 INFO - mozprocess == 0.22 17:07:23 INFO - mozprofile == 0.28 17:07:23 INFO - mozrunner == 6.11 17:07:23 INFO - mozscreenshot == 0.1 17:07:23 INFO - mozsystemmonitor == 0.0 17:07:23 INFO - moztest == 0.7 17:07:23 INFO - mozversion == 1.4 17:07:23 INFO - psutil == 3.1.1 17:07:23 INFO - requests == 1.2.3 17:07:23 INFO - wsgiref == 0.1.2 17:07:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:07:23 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')]} 17:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:23 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')]} 17:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:23 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 0x7f0ab876af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2410>, '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 0x20e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e37a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', '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 17:07:23 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 17:07:23 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 17:07:23 INFO - Using env: {'DISPLAY': ':0', 17:07:23 INFO - 'HOME': '/home/cltbld', 17:07:23 INFO - 'LANG': 'en_US.UTF-8', 17:07:23 INFO - 'LANGUAGE': 'en_US:en', 17:07:23 INFO - 'LOGNAME': 'cltbld', 17:07:23 INFO - 'MAIL': '/var/mail/cltbld', 17:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:23 INFO - 'MOZ_NO_REMOTE': '1', 17:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:23 INFO - 'NO_EM_RESTART': '1', 17:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:23 INFO - 'PWD': '/builds/slave/test', 17:07:23 INFO - 'SHELL': '/bin/bash', 17:07:23 INFO - 'SHLVL': '1', 17:07:23 INFO - 'TERM': 'linux', 17:07:23 INFO - 'TMOUT': '86400', 17:07:23 INFO - 'USER': 'cltbld', 17:07:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', 17:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:23 INFO - '_': '/tools/buildbot/bin/python'} 17:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:23 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)) 17:07:23 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)) 17:07:23 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)) 17:07:23 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)) 17:07:23 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)) 17:07:23 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)) 17:07:23 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)) 17:07:23 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)) 17:07:23 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)) 17:07:23 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)) 17:07:23 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)) 17:07:23 INFO - Cleaning up... 17:07:23 INFO - Return code: 0 17:07:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:07:23 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')]} 17:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:23 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')]} 17:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:23 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 0x7f0ab876af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2410>, '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 0x20e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e37a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', '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 17:07:23 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 17:07:23 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 17:07:23 INFO - Using env: {'DISPLAY': ':0', 17:07:23 INFO - 'HOME': '/home/cltbld', 17:07:23 INFO - 'LANG': 'en_US.UTF-8', 17:07:23 INFO - 'LANGUAGE': 'en_US:en', 17:07:23 INFO - 'LOGNAME': 'cltbld', 17:07:23 INFO - 'MAIL': '/var/mail/cltbld', 17:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:23 INFO - 'MOZ_NO_REMOTE': '1', 17:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:23 INFO - 'NO_EM_RESTART': '1', 17:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:23 INFO - 'PWD': '/builds/slave/test', 17:07:23 INFO - 'SHELL': '/bin/bash', 17:07:23 INFO - 'SHLVL': '1', 17:07:23 INFO - 'TERM': 'linux', 17:07:23 INFO - 'TMOUT': '86400', 17:07:23 INFO - 'USER': 'cltbld', 17:07:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', 17:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:23 INFO - '_': '/tools/buildbot/bin/python'} 17:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:23 INFO - Downloading/unpacking jsonschema 17:07:23 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 17:07:23 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 17:07:23 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 17:07:23 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 17:07:23 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 17:07:23 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 17:07:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:07:25 INFO - Downloading/unpacking functools32 (from jsonschema) 17:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:25 INFO - Downloading functools32-3.2.3-2.tar.gz 17:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:07:25 INFO - warning: no files found matching '*.txt' 17:07:25 INFO - no previously-included directories found matching 'build' 17:07:25 INFO - no previously-included directories found matching 'dist' 17:07:25 INFO - no previously-included directories found matching '.git*' 17:07:25 INFO - Installing collected packages: jsonschema, functools32 17:07:25 INFO - Running setup.py install for functools32 17:07:25 INFO - warning: no files found matching '*.txt' 17:07:25 INFO - no previously-included directories found matching 'build' 17:07:25 INFO - no previously-included directories found matching 'dist' 17:07:25 INFO - no previously-included directories found matching '.git*' 17:07:25 INFO - Successfully installed jsonschema functools32 17:07:25 INFO - Cleaning up... 17:07:25 INFO - Return code: 0 17:07:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:07:25 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')]} 17:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:25 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')]} 17:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:25 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 0x7f0ab876af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e2410>, '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 0x20e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e37a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', '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 17:07:25 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 17:07:25 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 17:07:25 INFO - Using env: {'DISPLAY': ':0', 17:07:25 INFO - 'HOME': '/home/cltbld', 17:07:25 INFO - 'LANG': 'en_US.UTF-8', 17:07:25 INFO - 'LANGUAGE': 'en_US:en', 17:07:25 INFO - 'LOGNAME': 'cltbld', 17:07:25 INFO - 'MAIL': '/var/mail/cltbld', 17:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:25 INFO - 'MOZ_NO_REMOTE': '1', 17:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:25 INFO - 'NO_EM_RESTART': '1', 17:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:25 INFO - 'PWD': '/builds/slave/test', 17:07:25 INFO - 'SHELL': '/bin/bash', 17:07:25 INFO - 'SHLVL': '1', 17:07:25 INFO - 'TERM': 'linux', 17:07:25 INFO - 'TMOUT': '86400', 17:07:25 INFO - 'USER': 'cltbld', 17:07:25 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', 17:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:25 INFO - '_': '/tools/buildbot/bin/python'} 17:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:26 INFO - Downloading/unpacking flake8 17:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:07:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:07:28 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 17:07:28 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 17:07:28 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 17:07:28 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 17:07:28 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 17:07:28 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 17:07:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:07:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:07:28 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 17:07:28 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 17:07:28 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 17:07:28 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 17:07:28 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 17:07:28 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 17:07:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:07:28 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 17:07:28 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 17:07:28 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 17:07:28 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 17:07:28 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 17:07:28 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 17:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:07:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:07:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:07:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:07:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:07:28 INFO - no previously-included directories found matching 'docs/_build' 17:07:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:07:28 INFO - Running setup.py install for pep8 17:07:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:07:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:07:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:07:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:07:28 INFO - no previously-included directories found matching 'docs/_build' 17:07:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:07:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:07:28 INFO - Cleaning up... 17:07:29 INFO - Return code: 0 17:07:29 INFO - Running post-action listener: _resource_record_post_action 17:07:29 INFO - Running post-action listener: _start_resource_monitoring 17:07:29 INFO - Starting resource monitoring. 17:07:29 INFO - ##### 17:07:29 INFO - ##### Running install step. 17:07:29 INFO - ##### 17:07:29 INFO - Running pre-action listener: _resource_record_pre_action 17:07:29 INFO - Running main action method: install 17:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:07:29 INFO - Reading from file tmpfile_stdout 17:07:29 INFO - Detecting whether we're running mozinstall >=1.0... 17:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:07:29 INFO - Reading from file tmpfile_stdout 17:07:29 INFO - Output received: 17:07:29 INFO - Usage: mozinstall [options] installer 17:07:29 INFO - Options: 17:07:29 INFO - -h, --help show this help message and exit 17:07:29 INFO - -d DEST, --destination=DEST 17:07:29 INFO - Directory to install application into. [default: 17:07:29 INFO - "/builds/slave/test"] 17:07:29 INFO - --app=APP Application being installed. [default: firefox] 17:07:29 INFO - mkdir: /builds/slave/test/build/application 17:07:29 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'] 17:07:29 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 17:07:45 INFO - Reading from file tmpfile_stdout 17:07:45 INFO - Output received: 17:07:45 INFO - /builds/slave/test/build/application/firefox/firefox 17:07:45 INFO - Running post-action listener: _resource_record_post_action 17:07:45 INFO - ##### 17:07:45 INFO - ##### Running run-tests step. 17:07:45 INFO - ##### 17:07:45 INFO - Running pre-action listener: _resource_record_pre_action 17:07:45 INFO - Running main action method: run_tests 17:07:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:07:45 INFO - Python 2.7.3 17:07:45 INFO - Return code: 0 17:07:45 INFO - grabbing minidump binary from tooltool 17:07:45 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')]} 17:07:45 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 0x20e2410>, '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 0x20e3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:07:45 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 17:07:45 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 17:07:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:07:45 INFO - Return code: 0 17:07:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:07:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:07:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:07:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:07:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:07:46 INFO - Return code: 0 17:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:07:46 INFO - Using env: {'DISPLAY': ':0', 17:07:46 INFO - 'HOME': '/home/cltbld', 17:07:46 INFO - 'LANG': 'en_US.UTF-8', 17:07:46 INFO - 'LANGUAGE': 'en_US:en', 17:07:47 INFO - 'LOGNAME': 'cltbld', 17:07:47 INFO - 'MAIL': '/var/mail/cltbld', 17:07:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:07:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:47 INFO - 'MOZ_NO_REMOTE': '1', 17:07:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:47 INFO - 'NO_EM_RESTART': '1', 17:07:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:47 INFO - 'PWD': '/builds/slave/test', 17:07:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:07:47 INFO - 'SHELL': '/bin/bash', 17:07:47 INFO - 'SHLVL': '1', 17:07:47 INFO - 'TERM': 'linux', 17:07:47 INFO - 'TMOUT': '86400', 17:07:47 INFO - 'USER': 'cltbld', 17:07:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027', 17:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:47 INFO - '_': '/tools/buildbot/bin/python'} 17:07:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:07:47 INFO - mozversion application_buildid: 20160429143019 17:07:47 INFO - mozversion application_changeset: d2674a65a6e8a0bd7c0954cbdf2a2babc8921a57 17:07:47 INFO - mozversion application_display_name: Nightly 17:07:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:07:47 INFO - mozversion application_name: Firefox 17:07:47 INFO - mozversion application_remotingname: firefox 17:07:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:07:47 INFO - mozversion application_vendor: Mozilla 17:07:47 INFO - mozversion application_version: 49.0a1 17:07:47 INFO - mozversion platform_buildid: 20160429143019 17:07:47 INFO - mozversion platform_changeset: d2674a65a6e8a0bd7c0954cbdf2a2babc8921a57 17:07:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:07:47 INFO - mozversion platform_version: 49.0a1 17:07:47 INFO - using testdate: 1461974867 17:07:47 INFO - actual date: 1461974867 17:07:47 INFO - starting webserver on 'localhost:50377' 17:07:47 INFO - SUITE-START | Running 2 tests 17:07:47 INFO - TEST-START | dromaeo_css 17:07:47 INFO - operating with platform_type : linux_ 17:07:47 INFO - Initialising browser for dromaeo_css test... 17:07:47 INFO - TEST-INFO | started process 22190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDb_2_d/profile http://localhost:50377/getInfo.html) 17:07:51 INFO - PROCESS | 22190 | 17:07:51 INFO - PROCESS | 22190 | (process:22257): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:07:52 INFO - PROCESS | 22190 | __metrics Screen width/height:1600/1200 17:07:52 INFO - PROCESS | 22190 | colorDepth:24 17:07:52 INFO - PROCESS | 22190 | Browser inner width/height: 1024/697 17:07:52 INFO - PROCESS | 22190 | __metrics 17:07:52 ERROR - PROCESS | 22190 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:07:53 INFO - TEST-INFO | 22190: exit 0 17:07:53 INFO - Browser initialized. 17:07:53 INFO - Running cycle 1/1 for dromaeo_css test... 17:07:53 INFO - TEST-INFO | started process 22308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDb_2_d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:55 INFO - PROCESS | 22308 | 17:07:55 INFO - PROCESS | 22308 | (process:22370): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:08:05 INFO - PROCESS | 22308 | RSS: Main: 164855808 17:08:05 INFO - PROCESS | 22308 | 17:08:54 INFO - PROCESS | 22308 | 1461974934934 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] 17:11:02 INFO - PROCESS | 22308 | Cycle 1(1): loaded http://localhost:50377/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50377/tests/dromaeo/cssquery-ext.html) 17:11:03 INFO - PROCESS | 22308 | RSS: Main: 169353216 17:11:03 INFO - PROCESS | 22308 | 17:14:05 INFO - PROCESS | 22308 | Cycle 1(1): loaded http://localhost:50377/tests/dromaeo/cssquery-ext.html (next: http://localhost:50377/tests/dromaeo/cssquery-jquery.html) 17:14:06 INFO - PROCESS | 22308 | RSS: Main: 167243776 17:14:06 INFO - PROCESS | 22308 | 17:17:08 INFO - PROCESS | 22308 | Cycle 1(1): loaded http://localhost:50377/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50377/tests/dromaeo/cssquery-mootools.html) 17:17:08 INFO - PROCESS | 22308 | RSS: Main: 168009728 17:17:08 INFO - PROCESS | 22308 | 17:20:10 INFO - PROCESS | 22308 | Cycle 1(1): loaded http://localhost:50377/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50377/tests/dromaeo/cssquery-prototype.html) 17:20:10 INFO - PROCESS | 22308 | RSS: Main: 165695488 17:20:10 INFO - PROCESS | 22308 | 17:23:13 INFO - PROCESS | 22308 | Cycle 1(1): loaded http://localhost:50377/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50377/tests/dromaeo/cssquery-yui.html) 17:23:13 INFO - PROCESS | 22308 | RSS: Main: 166916096 17:23:13 INFO - PROCESS | 22308 | 17:26:15 INFO - PROCESS | 22308 | Cycle 1(1): loaded http://localhost:50377/tests/dromaeo/cssquery-yui.html (next: http://localhost:50377/tests/dromaeo/cssquery-dojo.html) 17:26:16 INFO - PROCESS | 22308 | RSS: Main: 168845312 17:26:16 INFO - PROCESS | 22308 | 17:26:16 INFO - PROCESS | 22308 | __start_tp_report 17:26:16 INFO - PROCESS | 22308 | _x_x_mozilla_page_load 17:26:16 INFO - PROCESS | 22308 | _x_x_mozilla_page_load_details 17:26:16 INFO - PROCESS | 22308 | |i|pagename|runs| 17:26:16 INFO - PROCESS | 22308 | |0;dojo.html;3164.1298642873207;3203.7276831469326;3221.9355612887734;3249.4475939090353;3258.8859389921345;5418.620696551243;5432;5437.564994800417;5442.673439593622;5468.562514998801;5394.757235924383;5457.727113644311;5555.777768889239;5557.305336832896;5564.4713752193575;4878;4884.462709101996;4941.802327906879;4949;4963.851084467454;4928.211486162215;5072.594192464594;5094.439611642716;5101.336826212587;5105.617078719092;4965.081459929925;4986.950130498685;4999.650024498286;5011.42368627607;5053.5704465120325;4944.901101977976;4954.43024052235;4956.281339205831;4958.157113290749;4972.577330926875;4931.087748766489;4931.679440836334;4948;4950.084234416644;4973.776180071869;5324.653897496689;5337.733113344318;5360.035193665139;5386.8383948481605;5390.70623050469;5702.344230413514;5721.056025755745;5731.942680573183;5735.885282294373;5744.138379243105;5769.509591684669;5769.567282453832;5772.0476121439915;5781.277340332458;5799.043157878945;5349.732513374316;5434.347878254595;5461.563074954034;5475.863103422406;5501.229827824108;5971.701414929323;5978.073398623221;5978.850528736816;6000.729967151488;6013.248343957005;5720.542356611461;5759.366469688331;5780.046292361797;5781.392953739881;5784.623999440023;5892.234009578728;5923.644581325134;5936.821895343147;5961.195238642815;5988.251468566429;5717.942820571741;5760.971195144081;5773.913391299134;5794.826155215266;5853.912191317134;5765.884682306414;5801.187833703285;5850.063989761703;5854.238948936696;5891.410858914074;4391.187630288407;4418.955810441918;4440.911181776346;4473.7986790594505;4505.7296562206375;3920.4903362563255;3921.0785465415606;3922.666573341241;3953.6441720245316;3955.3869150281753;5452.345718513724;5504.146857237135;5547.057000309957;5548.5838562108;5565.777368905279;5887.411258874078;5938.762449501972;5957.344692083867;5960.821175364746;5985.760569577255;5512.283403157644;5517.806876759294;5518.420565840609;5526.226328314039;5528.391876893538;4953.554180123806;4974.502549745069;4976.178930476503;5003.524665156804;5008.198688209869;6074.878502430015;6099.695015249308;6108.038540470994;6109.922904750062;6127.6502361584835;5863.267091613463;5865.3254875688135;5871.354151043296;5876.882462350814;5888.793892213752;5964.7912323068485;6013.909791353046;6054.788082417094;6082.635041897501;6089.269287685506;5728.54171666274;5749.367569567428;5758.222639943554;5768.394318596655;5790.884182316414;5834.38738932406;5841.1238314253205;5852.4147585241135;5852.912206316823;5863.677497737494;5583.1904373864745;5654.802081927113;5704;5714.942850571441;5734.483896449339;5603.767171222325;5610.8316750495915;5662.886742265214;5673.74468148926;5739.942600573941;5511;5539;5652.519535839335;5661;5673.716314184192;5694.886102278014;5717.37108918027;5738.741756621045;5767.452092051249;5795;5533.087040638249;5650.943490565206;5656.406077361982;5668.914966275592;5673.205751194753 17:26:16 INFO - PROCESS | 22308 | |1;ext.html;603.6498830678207;617.0836308082494;649.7076315657954;663.4195079305607;670.1857243449208;37604;38829.223415531706;38889.24998375073;38951.61048389515;39017;38208.235835283274;38861.22277554454;39328.443651162655;39345.213095738065;39631.207375852464;8468.407211495198;8621.95689021554;8633.827323453559;8681.826363472726;8691.652333906635;8540.78648033798;8595.95702021489;8635.179657932518;8654.09132041136;8727;8698.782530436727;8716.346274029442;8746.431481953685;8769.210771030637;8796.25231855293;8662.566871656423;8755.080716524737;8768.254698350647;8777.605007774666;8791.78020549485;8540.572971351408;8613.655453781841;8627.094155113748;8629;8659.956700216522;38461.42307865384;38796;38797.61202387968;38943;39014.02464938371;3453.309338132384;3597.784132952005;3625.093726568358;3639.217568222845;3717.925641487155;30995.690043099505;31307.53038704421;31424.214394640087;31631.683683163104;31691.366172676648;4066.79666016698;4115.753054816691;4144.119836713486;4200.1179752252065;4375.431193944799;308944;311327;311542;311965;312522.4373878139;33645.15887102842;34002.14994625105;34265.65734342675;58567.70716146477;59745;34594;34794.82602586971;34853;34997.65002349944;35005.47491787625;14913.92543037278;15104.54686359411;15112.924435377752;15116;15135.394584216729;12317.938410307892;12371.876281237252;12384.876151238552;12392.876071239352;12405.813912791315;8680.262177714965;8697.304215662733;8722.084181160886;8777.122287771299;8833.939927208648;3374.4938259260816;3391.609964854024;3400.625931147572;3452.1197094740683;3461.8442170102408;1088.472091035847;1093.191038631423;1126.515598292742;1138.8177891537314;1163.5345861655405;31210.687893121234;31981.360372792413;32421.18947026343;32524.74752524776;32990.83504582462;1109.2401704832216;1164.8485696859354;1179.6932797472548;1181.757739663367;1210.5520957245876;17135.143242837807;17243.827561724473;17349.7397539037;17397.130143492774;17539.912300438416;475158;478340;479500;479984;480875;58320;58948.70525647344;58981.41018589845;59145.40854591485;59384.703076484344;1420.2188796162277;1428.8499707530768;1441.8269807623153;1442.776369662683;1444.7399468095844;31108.066757997298;31405.214869628442;31625.36749265048;31701.20746981344;32144;51703;51895.481045189066;52170.739146304026;52170.739146304026;52218;372262;376239;377890;379135;380536;29062.854685726437;29133.56299655549;29382.85308573529;29385.70614293915;29429.264268392606;48138;48646.75676621594;49241.2613810786;49739.50260497349;49950.50049499459;40982;41299;41503.58496414997;42010.78994605008;43342.783286083366;40523.39214911838;41363.379549306184;41450.79274603607;41667.58332416637;42052.57947420487;40614.18771624492;41127.38308925428;41714.374284386366;42337.364939526546;42748.64882431496;36061.27877442489;37253.62746372502;37294.81352593219;37572.812135939144;37980.24039519139;27879.03482270657;28213.294667633472;28307.43385132327;28462.715372846007;28645.283867902635 17:26:16 INFO - PROCESS | 22308 | |2;jquery.html;394.72566566236475;395.98020098995045;400.9037830920579;408.6853123095217;411.6398151617335;18144.455666330014;18456.907715461402;18658.53353666159;18710.064496775158;20270.493237669067;18842.71735923959;19356.225750969945;19599.510012249666;19644.21423143076;19807.90096049518;5335.733213339317;5576.302962129734;5640.887182256373;5700.201971723962;5907.940920590803;5398.406175320712;5555.8888822223535;5579.497845193931;5620.381758006616;5860.4139586041265;5809.419058094178;5832.708364581775;5833.066709326508;5855.502282306009;5877.382874798127;5795.130730390454;5805.651660900359;5823.446772556622;6417.486601071903;6421.229452465687;5616.634918730269;5698.914516282218;5712.685802280873;5712.714364281811;5726.455986681301;14614.926925365306;22065.558688826295;22427.77572224273;22783.08867645292;22803.88598056999;2207.2716003718897;2230.9776902230933;2232.520008198229;2311.6185829338137;2666.78665706743;9938.453385063818;10177.89822101777;10186.949065254701;10393.740156496073;10504.579816807394;1903.8857668539931;1975.101328895349;2008.6484865148686;2023.271622216001;2035.165582111342;75590;77174.61412692901;77628.22371776267;78524.21475785226;80081.59959200167;10525.578976840841;10934.4532773361;10960.725981850517;11033.179525378222;11140.49867755953;15343.465653434567;15347.693046139015;15426.691466170838;15471.22643867802;15487.225638718019;8247.711330103417;8291.129431409736;8344.207300306462;8432.78918027042;8450.19723126302;7958.442908996431;7975.082865470429;8053.395995300376;8058.0733215679775;8088.9595552021865;4652.930206046912;4723.527647235318;4807.735574543433;4848.393950756155;4850.53919877611;1941.1847024249848;1992.601479704065;2023.5042414608515;2023.6643815081975;2028.2698228637678;903.5708038681705;938.8591711243231;956.660385563129;993.6273897288517;1099.0383414512303;18351.724724129148;18600;18901;19041.619167616846;19291.51771205703;997.6432052408718;1023.0179028132927;1031.5976769060073;1052.9631462898762;1061.3737894642197;10457.633982810717;10780.730481737863;10832.404217768099;10926.399048052275;10970.451477426097;435954;438513;458893;493184;500891;87061.56469217614;91046.54476727574;92956;94052;94891.52554237185;1016.278442305971;1025.497506221946;1028.5834237133972;1033.6537260017978;1041.770810421706;16485.17574121313;16758.916205419384;16929.830701692827;16963.7455438171;17166.828331716522;37416.6258337424;39250.41124383079;39951.80024099861;40929.59070409258;41584.584154158074;55906.44093559012;56323;56492;56708.43291567197;57096.429035710775;7831.804204894923;8172.6730930762105;8184.590770461334;8604.698835540727;8687.565621719015;12020.398980051137;12752.936235318764;12782.488700451877;12858.614241572768;13164.934175329063;10685.626003089854;11447.198696091195;11559.422028898352;11614.187006909435;11658.88341116578;5342.9465705342445;10318.380897146195;10480.68557943263;11202.327860328407;11567.768644626893;11550.075993920298;11685.065194784227;11869;11992.460339284928;12178.878211218129;7936.166702496154;8274.958625206835;8324.256263178388;8614.526201059001;8728.607212675317;11198.21612487118;11873;11961.880381196424;12063.698407539881;12175.878241217828 17:26:16 INFO - PROCESS | 22308 | |3;mootools.html;1534.9079055256682;1557.3147814961417;1725.1460527039117;1785.3572713823014;1797.712366021436;7324.450666200029;7843.490173138742;8147.900033495476;8150.714724984627;8295.460795048317;7935.801604959879;7966.123726390092;7995.320397766182;7996.080450748165;8033.758987230392;2295.9081636734554;2340.3330050935488;2348.7181538215436;2352.047420794581;2356.9175078872245;2239.4177513846435;2253.876036817974;2268.5349503351854;2280.315905228433;2282.1898226129733;2319.721633403994;2335.871527066011;2336.1356298169617;2353.9882300588474;2361.5631108244943;2274.5792028474784;2282.543491301746;2286.4855407533337;2290.6449500327476;2320.721513418384;2283;2294.621387471065;2305.3660243433023;2311.167979527369;2331.1724337859987;8137.349012079019;8154.75535733929;8167.63245653947;8181.959090204511;8185.959070204671;5081.644284900059;5292.682439053669;5316.9202461963105;5324.840254792362;5330.413654498002;3200.7599430042605;3344.0970937846887;3389.474631432132;3414.7609667323295;3418.1967237699123;1073.3452593917705;1079.2499213046935;1087.8477013218076;1092.5083712329483;1123.8651361836633;11878.227915185485;11911.761764764742;11913.22564033335;11927.642170734805;11941.462634181482;4733.810647574127;4781.904361912742;4792.329073929653;4830.975845120752;4831.541003604652;10083.294169408218;10156;10167;10171.54228059739;10175.84736228957;5219.973900130475;5228.581713462914;5237.371515418175;5252.395974462909;5267.130923397596;4490.483594386622;4883.511648835088;4932.556069953722;4945.060438516743;5045.899082018413;3836.76979381238;3851.807409629507;3898.629630185128;3914.784686842194;4024.537178224483;1205.0781152418408;1250.1311588445942;1250.2373552133192;1264.1088032936757;1275.2985857778185;955.2883102088988;1015.7155996321042;1037.5849660136007;1048.145761204631;1063.3672964586058;5862.8534286642325;5869.20765696634;5924.407559244041;5998.550108741862;6187.071939209155;1012.1295685710284;1017.7455636090978;1027.8047171037629;1030.217035053365;1047.2093569355088;4220.451341325669;4223.894402639959;4250.596193361625;4261.232978063917;4264.616184543406;9772.169365604002;10232.693019209435;10293.228007899437;10296.330738501973;10310.175185985103;10054.949725251327;10190.43952582615;10202.948985255174;10207.285490015776;10253.128484078788;7667.8849817252785;7723.845523089619;8075.313598344089;8138.3896207784655;8157.551334676531;5485.369182544058;5706.3152421709665;5740.425957404394;5842.977478941253;5889;9439.575219115293;9645.614175432904;9652.90347096548;10073.19414446857;10077.848832267668;9615.23078153732;9644.276679249224;10077.546510407195;10078.244131690299;10214.080732733792;7423.406127509678;7438.888416673863;7466.4026877848555;7517.548947063194;7525.962370188114;8040.437169398086;8122.75631731049;8123.147069557847;8124.83750325002;8143.8778418324955;7250.3112204340505;7496.062992125984;7517.924820751722;7559.3196612305155;7641.044869391326;7345.118585769742;7422;7444.330010299099;7457.589832559262;7660.34887034586;6840.794776156723;6855.520113592001;6890.138732658418;6921.688524016532;6926.826829329307;5040.974795126001;5118.820841270538;5180.093483640272;5264.763085661231;5293.179557168645;5192.506711862367;5247.344081989751;5294.682319060868;5308.124159513792;5308.840734777808 17:26:16 INFO - PROCESS | 22308 | |4;prototype.html;330.152828809465;336.9957526570819;341.64127665950747;341.93161367726464;344.71216534193945;5402.405735369106;5471.671699698021;5532.640378375408;5587.497125258721;5658;5486.451354864512;5509.807156749514;5552.305961754781;5568.192612071247;5568.440836565758;4308.870733877989;4328.675349348796;4337.7397356158735;4340.65274778017;4343.869683909487;4171.207470580595;4316.374125751764;4324.22164010478;4354.695171338008;4356.869293921188;4250.681198910079;4289.442372491571;4299.742015479065;4302.720323178984;4312.1375724855;4315.4389929309145;4328.50222224445;4333.458317710286;4336.089421221532;4345.175026488882;3559.359315323241;3841.2509560635685;3842.9615703843165;3852.8266228019806;3853.1523064925673;5303.469653034705;5349.224362467459;5378.757955891994;5387.838364849061;5398.541124004425;4858.344123543312;4882.462929077798;4887.584555312803;4895.681780684244;4916.50834916509;5510.889782204374;5783.363829978699;5809.970950145223;5818.44724751148;5854.531637468992;4076.673866090706;4083.1833633273463;4083.958590559418;4084.5098588169312;4113.197926404352;6011.428914253139;6032.698365081728;6048.848778780522;6068.878622427571;6115.6942152892625;4086.7956602169775;4095.406166105898;4188.769617670996;4204.390363397351;4234.3860140279485;4187.267228235047;4189.91620167601;4205.074883525619;4212.726172798758;4218.725782824106;4865.756712164378;4876.975615121973;4888.608911287089;4910.582600478928;4939.234418665041;5264.736763161904;5874.1776151338845;5881.176635271066;5914.497267732205;5931.169636250928;1511.5692027772031;1523.2079318754186;1524.146477972339;1528.5719998400466;1529.7303238312174;1008.3596915958419;1010.959561617527;1021.4024795494719;1030.8917563655857;1031.9071283584362;5967.671778052249;5988.790392336335;5991.981363168272;6052.576319657582;6052.6671033092725;6371.108044873721;6379.425851673279;6422.678866056678;6423.646699431482;6461.25695545009;5859.472647461664;5886.234789477427;5926.733297001645;5951.047832346804;5967.940320596826;3368.3768502827056;3385.0691059958217;3403.4554471284478;3420.931581368359;3422.8801991930163;5983.6708981005595;6320.462760665395;6331.746730130835;6569.967150164219;6606.207255129415;6203.379662033851;6242.906356404657;6277.780277690259;6287.2140982377205;6304.707534955323;6200.906986395207;6328.11406403104;6336.17629708135;6356;6376.33048529907;6099.359567245553;6113.23584551931;6152.200213972155;6161;6219.40915613016;6021.494626343414;6030.4572588467245;6047.879042419039;6069;6093.238345206849;6087.543434242538;6256.530760192913;6266.937330626635;6313.275167651108;6321.54604440972;4171.249175148381;4244.830206791694;4248.7693960670895;4261.318189089855;4269.807858646431;5587.860303492445;5951.851203719942;6039.969800150971;6114.798672477816;6144.324124346408;5775.509081727932;5816.807554451243;5819.214406055128;5848.824535263949;5867.530597552271;5827.475527202572;5852.678102704393;5858.794942177004;5896.380880007538;5902.291724992857;5546.528545073714;5716.628419152742;5781.942180578309;5793.478586927196;5794.942050579609;5800.24596802413;5925.992581261282;5936.762529498772;5951.137085122719;5954.285485741739;5646.85882852932;5721.25623668937;5748.362402336083;5776.508996735324;5794.18881356602 17:26:16 INFO - PROCESS | 22308 | |5;yui.html;799.3165843204057;807.2169995104748;819.6434550970326;827.871679889617;875.0724232313748;13615.79576306355;13699.315034248286;14578.854211457883;14810.00064991226;14880.702385952274;13692.246926419042;13758.449662013507;13759.79360309596;13763.174209547435;13775.035747497679;688.2016860441876;803.8512875118092;842.1073661918356;843.2579330189425;843.5950743643054;815.8409110223508;820.9835803283961;824.814416756231;829.6764261937819;831.6673330667721;873.7640836974014;878.0955615715823;882.2016075451727;883.2271762208068;885.6368888755611;860.8536548786722;870.3081050564816;873.1530415496926;873.2882700599023;874.8119154381775;630.845442866496;635.463033736492;636.0903907412398;637.4645297949744;637.8851806674796;14271.78592321116;14300;14310.64223394413;14324.14055156694;14396.496122635763;14363.856361436356;14423.206723630195;14451.566453006426;14485.130892146504;14521.564353069425;11418.31490110596;11498.367589782558;11545.653630391102;11616.825747613793;11695.298282103102;3862.8454861805776;3909.280811697989;3913.099987002977;3924.2151569686175;3950.723449358546;51440;52189;52586.47413525854;52703.47296527062;53550.19674704882;11136.888631113747;11204.887951120547;11263.380514071805;11306.660800176009;11383.203175777617;19860.10629521646;19893.10481028357;19901.900490497454;20066;20153.596928061357;8266.669333226724;8573.614187361583;8606;8610.827783444422;8728.389012769045;4534.410526631516;4698.718076915396;4720.622350211975;4740.691855029412;4865.805367785249;3281.4749640057476;3301.1747063234193;3343.8996830095134;3353.7987720736833;3354.8490317935753;589.8260013296087;609.9329073801878;622.6233128957007;622.7789134857151;626.2109741725459;738.881778915371;774.4540099230029;777.0946846923271;782.9843403131905;787.2481779900181;9128.406653567497;9655.08276713711;9737.756556086155;9829;9833.557489912972;612.9570930034855;627.3130921640887;640.2413140428607;654.9017647352936;693.1093544794915;4399.5820397062225;4663.556962088596;4696.225122854691;4728.88177795551;4741.478437371887;67322.3267767316;67501;67764.66117669479;67975;69286.65356673184;52427.47572524226;52457.2131418029;55087.724561376934;55348.72325638346;58203.126953095736;53015.20477192768;54323.18515222275;54850.72574637101;55132.724336378866;55590;9065.393489617296;9416.717498475056;9431.198348140484;9479.194268487256;9486.383385079947;32987.34025319528;33773.662263378035;34752.78365257204;34873.82563087168;35269.64730352664;42858.357124642534;44800.55199448094;47150;47896.760516197195;48044.759776200895;11879.406029698654;11950;12078.939605301917;12256.877431225574;12353.197042192229;13185;13328.466861325438;13351.866481335062;13668.65828354299;14654.413823446943;11925;12397.814032789696;12414.131010829155;13188.80216796768;13199.868001319865;12599.811002835148;13250.133429103023;13327.267000315076;13370;13439.2034847542;12561.371931403575;12676.302803345905;12722.491100355883;12765.553205637758;12868.485260589472;10527.263091583516;10887.945560272148;10941.890581094087;10981.231313807957;11362.715932101764;10810.621628242974;10824.458777060958;10909.618163364561;10926.890731092588;11024.559017639205 17:26:16 INFO - PROCESS | 22308 | __end_tp_report 17:26:16 INFO - PROCESS | 22308 | __start_cc_report 17:26:16 INFO - PROCESS | 22308 | _x_x_mozilla_cycle_collect,341 17:26:16 INFO - PROCESS | 22308 | __end_cc_report 17:26:16 INFO - PROCESS | 22308 | __startTimestamp1461975976186__endTimestamp 17:26:16 INFO - PROCESS | 22308 | 17:26:16 INFO - PROCESS | 22308 | ------- Summary: start ------- 17:26:16 INFO - PROCESS | 22308 | Number of tests: 6 17:26:16 INFO - PROCESS | 22308 | 17:26:16 INFO - PROCESS | 22308 | [#0] dojo.html Cycles:165 Average:5423.56 Median:5652.52 stddev:615.65 (10.9%) stddev-sans-first:591.47 17:26:16 INFO - PROCESS | 22308 | Values: 3164.1 3203.7 3221.9 3249.4 3258.9 5418.6 5432.0 5437.6 5442.7 5468.6 5394.8 5457.7 5555.8 5557.3 5564.5 4878.0 4884.5 4941.8 4949.0 4963.9 4928.2 5072.6 5094.4 5101.3 5105.6 4965.1 4987.0 4999.7 5011.4 5053.6 4944.9 4954.4 4956.3 4958.2 4972.6 4931.1 4931.7 4948.0 4950.1 4973.8 5324.7 5337.7 5360.0 5386.8 5390.7 5702.3 5721.1 5731.9 5735.9 5744.1 5769.5 5769.6 5772.0 5781.3 5799.0 5349.7 5434.3 5461.6 5475.9 5501.2 5971.7 5978.1 5978.9 6000.7 6013.2 5720.5 5759.4 5780.0 5781.4 5784.6 5892.2 5923.6 5936.8 5961.2 5988.3 5717.9 5761.0 5773.9 5794.8 5853.9 5765.9 5801.2 5850.1 5854.2 5891.4 4391.2 4419.0 4440.9 4473.8 4505.7 3920.5 3921.1 3922.7 3953.6 3955.4 5452.3 5504.1 5547.1 5548.6 5565.8 5887.4 5938.8 5957.3 5960.8 5985.8 5512.3 5517.8 5518.4 5526.2 5528.4 4953.6 4974.5 4976.2 5003.5 5008.2 6074.9 6099.7 6108.0 6109.9 6127.7 5863.3 5865.3 5871.4 5876.9 5888.8 5964.8 6013.9 6054.8 6082.6 6089.3 5728.5 5749.4 5758.2 5768.4 5790.9 5834.4 5841.1 5852.4 5852.9 5863.7 5583.2 5654.8 5704.0 5714.9 5734.5 5603.8 5610.8 5662.9 5673.7 5739.9 5511.0 5539.0 5652.5 5661.0 5673.7 5694.9 5717.4 5738.7 5767.5 5795.0 5533.1 5650.9 5656.4 5668.9 5673.2 17:26:16 INFO - PROCESS | 22308 | 17:26:16 INFO - PROCESS | 22308 | [#1] ext.html Cycles:180 Average:54173.77 Median:38628.71 stddev:104593.30 (270.8%) stddev-sans-first:104809.37 17:26:16 INFO - PROCESS | 22308 | Values: 603.6 617.1 649.7 663.4 670.2 37604.0 38829.2 38889.2 38951.6 39017.0 38208.2 38861.2 39328.4 39345.2 39631.2 8468.4 8622.0 8633.8 8681.8 8691.7 8540.8 8596.0 8635.2 8654.1 8727.0 8698.8 8716.3 8746.4 8769.2 8796.3 8662.6 8755.1 8768.3 8777.6 8791.8 8540.6 8613.7 8627.1 8629.0 8660.0 38461.4 38796.0 38797.6 38943.0 39014.0 3453.3 3597.8 3625.1 3639.2 3717.9 30995.7 31307.5 31424.2 31631.7 31691.4 4066.8 4115.8 4144.1 4200.1 4375.4 308944.0 311327.0 311542.0 311965.0 312522.4 33645.2 34002.1 34265.7 58567.7 59745.0 34594.0 34794.8 34853.0 34997.7 35005.5 14913.9 15104.5 15112.9 15116.0 15135.4 12317.9 12371.9 12384.9 12392.9 12405.8 8680.3 8697.3 8722.1 8777.1 8833.9 3374.5 3391.6 3400.6 3452.1 3461.8 1088.5 1093.2 1126.5 1138.8 1163.5 31210.7 31981.4 32421.2 32524.7 32990.8 1109.2 1164.8 1179.7 1181.8 1210.6 17135.1 17243.8 17349.7 17397.1 17539.9 475158.0 478340.0 479500.0 479984.0 480875.0 58320.0 58948.7 58981.4 59145.4 59384.7 1420.2 1428.8 1441.8 1442.8 1444.7 31108.1 31405.2 31625.4 31701.2 32144.0 51703.0 51895.5 52170.7 52170.7 52218.0 372262.0 376239.0 377890.0 379135.0 380536.0 29062.9 29133.6 29382.9 29385.7 29429.3 48138.0 48646.8 49241.3 49739.5 49950.5 40982.0 41299.0 41503.6 42010.8 43342.8 40523.4 41363.4 41450.8 41667.6 42052.6 40614.2 41127.4 41714.4 42337.4 42748.6 36061.3 37253.6 37294.8 37572.8 37980.2 27879.0 28213.3 28307.4 28462.7 28645.3 17:26:16 INFO - PROCESS | 22308 | 17:26:16 INFO - PROCESS | 22308 | [#2] jquery.html Cycles:180 Average:27998.33 Median:12557.75 stddev:76962.60 (612.9%) stddev-sans-first:77150.60 17:26:16 INFO - PROCESS | 22308 | Values: 394.7 396.0 400.9 408.7 411.6 18144.5 18456.9 18658.5 18710.1 20270.5 18842.7 19356.2 19599.5 19644.2 19807.9 5335.7 5576.3 5640.9 5700.2 5907.9 5398.4 5555.9 5579.5 5620.4 5860.4 5809.4 5832.7 5833.1 5855.5 5877.4 5795.1 5805.7 5823.4 6417.5 6421.2 5616.6 5698.9 5712.7 5712.7 5726.5 14614.9 22065.6 22427.8 22783.1 22803.9 2207.3 2231.0 2232.5 2311.6 2666.8 9938.5 10177.9 10186.9 10393.7 10504.6 1903.9 1975.1 2008.6 2023.3 2035.2 75590.0 77174.6 77628.2 78524.2 80081.6 10525.6 10934.5 10960.7 11033.2 11140.5 15343.5 15347.7 15426.7 15471.2 15487.2 8247.7 8291.1 8344.2 8432.8 8450.2 7958.4 7975.1 8053.4 8058.1 8089.0 4652.9 4723.5 4807.7 4848.4 4850.5 1941.2 1992.6 2023.5 2023.7 2028.3 903.6 938.9 956.7 993.6 1099.0 18351.7 18600.0 18901.0 19041.6 19291.5 997.6 1023.0 1031.6 1053.0 1061.4 10457.6 10780.7 10832.4 10926.4 10970.5 435954.0 438513.0 458893.0 493184.0 500891.0 87061.6 91046.5 92956.0 94052.0 94891.5 1016.3 1025.5 1028.6 1033.7 1041.8 16485.2 16758.9 16929.8 16963.7 17166.8 37416.6 39250.4 39951.8 40929.6 41584.6 55906.4 56323.0 56492.0 56708.4 57096.4 7831.8 8172.7 8184.6 8604.7 8687.6 12020.4 12752.9 12782.5 12858.6 13164.9 10685.6 11447.2 11559.4 11614.2 11658.9 5342.9 10318.4 10480.7 11202.3 11567.8 11550.1 11685.1 11869.0 11992.5 12178.9 7936.2 8275.0 8324.3 8614.5 8728.6 11198.2 11873.0 11961.9 12063.7 12175.9 17:26:16 INFO - PROCESS | 22308 | 17:26:16 INFO - PROCESS | 22308 | [#3] mootools.html Cycles:180 Average:5640.26 Median:4787.12 stddev:3096.82 (64.7%) stddev-sans-first:3090.14 17:26:16 INFO - PROCESS | 22308 | Values: 1534.9 1557.3 1725.1 1785.4 1797.7 7324.5 7843.5 8147.9 8150.7 8295.5 7935.8 7966.1 7995.3 7996.1 8033.8 2295.9 2340.3 2348.7 2352.0 2356.9 2239.4 2253.9 2268.5 2280.3 2282.2 2319.7 2335.9 2336.1 2354.0 2361.6 2274.6 2282.5 2286.5 2290.6 2320.7 2283.0 2294.6 2305.4 2311.2 2331.2 8137.3 8154.8 8167.6 8182.0 8186.0 5081.6 5292.7 5316.9 5324.8 5330.4 3200.8 3344.1 3389.5 3414.8 3418.2 1073.3 1079.2 1087.8 1092.5 1123.9 11878.2 11911.8 11913.2 11927.6 11941.5 4733.8 4781.9 4792.3 4831.0 4831.5 10083.3 10156.0 10167.0 10171.5 10175.8 5220.0 5228.6 5237.4 5252.4 5267.1 4490.5 4883.5 4932.6 4945.1 5045.9 3836.8 3851.8 3898.6 3914.8 4024.5 1205.1 1250.1 1250.2 1264.1 1275.3 955.3 1015.7 1037.6 1048.1 1063.4 5862.9 5869.2 5924.4 5998.6 6187.1 1012.1 1017.7 1027.8 1030.2 1047.2 4220.5 4223.9 4250.6 4261.2 4264.6 9772.2 10232.7 10293.2 10296.3 10310.2 10054.9 10190.4 10202.9 10207.3 10253.1 7667.9 7723.8 8075.3 8138.4 8157.6 5485.4 5706.3 5740.4 5843.0 5889.0 9439.6 9645.6 9652.9 10073.2 10077.8 9615.2 9644.3 10077.5 10078.2 10214.1 7423.4 7438.9 7466.4 7517.5 7526.0 8040.4 8122.8 8123.1 8124.8 8143.9 7250.3 7496.1 7517.9 7559.3 7641.0 7345.1 7422.0 7444.3 7457.6 7660.3 6840.8 6855.5 6890.1 6921.7 6926.8 5041.0 5118.8 5180.1 5264.8 5293.2 5192.5 5247.3 5294.7 5308.1 5308.8 17:26:16 INFO - PROCESS | 22308 | 17:26:16 INFO - PROCESS | 22308 | [#4] prototype.html Cycles:180 Average:4961.09 Median:5577.97 stddev:1483.70 (26.6%) stddev-sans-first:1446.57 17:26:16 INFO - PROCESS | 22308 | Values: 330.2 337.0 341.6 341.9 344.7 5402.4 5471.7 5532.6 5587.5 5658.0 5486.5 5509.8 5552.3 5568.2 5568.4 4308.9 4328.7 4337.7 4340.7 4343.9 4171.2 4316.4 4324.2 4354.7 4356.9 4250.7 4289.4 4299.7 4302.7 4312.1 4315.4 4328.5 4333.5 4336.1 4345.2 3559.4 3841.3 3843.0 3852.8 3853.2 5303.5 5349.2 5378.8 5387.8 5398.5 4858.3 4882.5 4887.6 4895.7 4916.5 5510.9 5783.4 5810.0 5818.4 5854.5 4076.7 4083.2 4084.0 4084.5 4113.2 6011.4 6032.7 6048.8 6068.9 6115.7 4086.8 4095.4 4188.8 4204.4 4234.4 4187.3 4189.9 4205.1 4212.7 4218.7 4865.8 4877.0 4888.6 4910.6 4939.2 5264.7 5874.2 5881.2 5914.5 5931.2 1511.6 1523.2 1524.1 1528.6 1529.7 1008.4 1011.0 1021.4 1030.9 1031.9 5967.7 5988.8 5992.0 6052.6 6052.7 6371.1 6379.4 6422.7 6423.6 6461.3 5859.5 5886.2 5926.7 5951.0 5967.9 3368.4 3385.1 3403.5 3420.9 3422.9 5983.7 6320.5 6331.7 6570.0 6606.2 6203.4 6242.9 6277.8 6287.2 6304.7 6200.9 6328.1 6336.2 6356.0 6376.3 6099.4 6113.2 6152.2 6161.0 6219.4 6021.5 6030.5 6047.9 6069.0 6093.2 6087.5 6256.5 6266.9 6313.3 6321.5 4171.2 4244.8 4248.8 4261.3 4269.8 5587.9 5951.9 6040.0 6114.8 6144.3 5775.5 5816.8 5819.2 5848.8 5867.5 5827.5 5852.7 5858.8 5896.4 5902.3 5546.5 5716.6 5781.9 5793.5 5794.9 5800.2 5926.0 5936.8 5951.1 5954.3 5646.9 5721.3 5748.4 5776.5 5794.2 17:26:16 INFO - PROCESS | 22308 | 17:26:16 INFO - PROCESS | 22308 | [#5] yui.html Cycles:180 Average:15194.99 Median:4697.47 stddev:17702.67 (376.9%) stddev-sans-first:17719.33 17:26:16 INFO - PROCESS | 22308 | Values: 799.3 807.2 819.6 827.9 875.1 13615.8 13699.3 14578.9 14810.0 14880.7 13692.2 13758.4 13759.8 13763.2 13775.0 688.2 803.9 842.1 843.3 843.6 815.8 821.0 824.8 829.7 831.7 873.8 878.1 882.2 883.2 885.6 860.9 870.3 873.2 873.3 874.8 630.8 635.5 636.1 637.5 637.9 14271.8 14300.0 14310.6 14324.1 14396.5 14363.9 14423.2 14451.6 14485.1 14521.6 11418.3 11498.4 11545.7 11616.8 11695.3 3862.8 3909.3 3913.1 3924.2 3950.7 51440.0 52189.0 52586.5 52703.5 53550.2 11136.9 11204.9 11263.4 11306.7 11383.2 19860.1 19893.1 19901.9 20066.0 20153.6 8266.7 8573.6 8606.0 8610.8 8728.4 4534.4 4698.7 4720.6 4740.7 4865.8 3281.5 3301.2 3343.9 3353.8 3354.8 589.8 609.9 622.6 622.8 626.2 738.9 774.5 777.1 783.0 787.2 9128.4 9655.1 9737.8 9829.0 9833.6 613.0 627.3 640.2 654.9 693.1 4399.6 4663.6 4696.2 4728.9 4741.5 67322.3 67501.0 67764.7 67975.0 69286.7 52427.5 52457.2 55087.7 55348.7 58203.1 53015.2 54323.2 54850.7 55132.7 55590.0 9065.4 9416.7 9431.2 9479.2 9486.4 32987.3 33773.7 34752.8 34873.8 35269.6 42858.4 44800.6 47150.0 47896.8 48044.8 11879.4 11950.0 12078.9 12256.9 12353.2 13185.0 13328.5 13351.9 13668.7 14654.4 11925.0 12397.8 12414.1 13188.8 13199.9 12599.8 13250.1 13327.3 13370.0 13439.2 12561.4 12676.3 12722.5 12765.6 12868.5 10527.3 10887.9 10941.9 10981.2 11362.7 10810.6 10824.5 10909.6 10926.9 11024.6 17:26:16 INFO - PROCESS | 22308 | -------- Summary: end -------- 17:26:16 INFO - PROCESS | 22308 | 17:26:16 INFO - TEST-INFO | 22308: exit 0 17:26:16 INFO - TEST-OK | dromaeo_css | took 1109666ms 17:26:16 INFO - TEST-START | kraken 17:26:16 INFO - operating with platform_type : linux_ 17:26:16 INFO - Initialising browser for kraken test... 17:26:16 INFO - TEST-INFO | started process 22544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2sfWjW/profile http://localhost:50377/getInfo.html) 17:26:20 INFO - PROCESS | 22544 | 17:26:20 INFO - PROCESS | 22544 | (process:22611): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:26:21 INFO - PROCESS | 22544 | __metrics Screen width/height:1600/1200 17:26:21 INFO - PROCESS | 22544 | colorDepth:24 17:26:21 INFO - PROCESS | 22544 | Browser inner width/height: 1024/697 17:26:21 INFO - PROCESS | 22544 | __metrics 17:26:22 ERROR - PROCESS | 22544 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:26:23 INFO - TEST-INFO | 22544: exit 0 17:26:23 INFO - Browser initialized. 17:26:23 INFO - Running cycle 1/1 for kraken test... 17:26:23 INFO - TEST-INFO | started process 22662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2sfWjW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:26:24 INFO - PROCESS | 22662 | 17:26:24 INFO - PROCESS | 22662 | (process:22724): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:26:34 INFO - PROCESS | 22662 | RSS: Main: 164982784 17:26:34 INFO - PROCESS | 22662 | 17:26:37 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50377/tests/kraken/driver.html?testName=audio-beat-detection) 17:26:38 INFO - PROCESS | 22662 | RSS: Main: 169451520 17:26:38 INFO - PROCESS | 22662 | 17:26:40 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50377/tests/kraken/driver.html?testName=audio-dft) 17:26:41 INFO - PROCESS | 22662 | RSS: Main: 173850624 17:26:41 INFO - PROCESS | 22662 | 17:26:44 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50377/tests/kraken/driver.html?testName=audio-fft) 17:26:45 INFO - PROCESS | 22662 | RSS: Main: 163086336 17:26:45 INFO - PROCESS | 22662 | 17:26:47 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50377/tests/kraken/driver.html?testName=audio-oscillator) 17:26:47 INFO - PROCESS | 22662 | RSS: Main: 163643392 17:26:47 INFO - PROCESS | 22662 | 17:26:50 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50377/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:26:50 INFO - PROCESS | 22662 | RSS: Main: 165072896 17:26:50 INFO - PROCESS | 22662 | 17:26:53 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50377/tests/kraken/driver.html?testName=imaging-darkroom) 17:26:54 INFO - PROCESS | 22662 | RSS: Main: 165228544 17:26:54 INFO - PROCESS | 22662 | 17:26:57 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50377/tests/kraken/driver.html?testName=imaging-desaturate) 17:26:58 INFO - PROCESS | 22662 | RSS: Main: 165396480 17:26:58 INFO - PROCESS | 22662 | 17:27:01 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50377/tests/kraken/driver.html?testName=json-parse-financial) 17:27:01 INFO - PROCESS | 22662 | RSS: Main: 167919616 17:27:01 INFO - PROCESS | 22662 | 17:27:03 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50377/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:27:03 INFO - PROCESS | 22662 | RSS: Main: 168026112 17:27:03 INFO - PROCESS | 22662 | 17:27:05 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:27:06 INFO - PROCESS | 22662 | RSS: Main: 167804928 17:27:06 INFO - PROCESS | 22662 | 17:27:08 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:27:09 INFO - PROCESS | 22662 | RSS: Main: 168083456 17:27:09 INFO - PROCESS | 22662 | 17:27:11 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:27:12 INFO - PROCESS | 22662 | RSS: Main: 168718336 17:27:12 INFO - PROCESS | 22662 | 17:27:15 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:27:15 INFO - PROCESS | 22662 | RSS: Main: 168787968 17:27:15 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50377/tests/kraken/driver.html?testName=ai-astar) 17:27:17 INFO - PROCESS | 22662 | RSS: Main: 170033152 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | __start_tp_report 17:27:17 INFO - PROCESS | 22662 | _x_x_mozilla_page_load 17:27:17 INFO - PROCESS | 22662 | _x_x_mozilla_page_load_details 17:27:17 INFO - PROCESS | 22662 | |i|pagename|runs| 17:27:17 INFO - PROCESS | 22662 | |0;ai-astar;114;106;114;112;113;124;112;112;111;114 17:27:17 INFO - PROCESS | 22662 | |1;audio-beat-detection;162;126;155;182;132;163;152;130;181;128 17:27:17 INFO - PROCESS | 22662 | |2;audio-dft;163;164;163;163;161;164;174;163;168;162 17:27:17 INFO - PROCESS | 22662 | |3;audio-fft;76;77;74;148;73;73;73;74;171;77 17:27:17 INFO - PROCESS | 22662 | |4;audio-oscillator;92;92;147;93;92;92;143;92;93;152 17:27:17 INFO - PROCESS | 22662 | |5;imaging-gaussian-blur;118;118;118;118;118;118;118;118;118;118 17:27:17 INFO - PROCESS | 22662 | |6;imaging-darkroom;147;147;147;146;151;148;147;147;148;147 17:27:17 INFO - PROCESS | 22662 | |7;imaging-desaturate;96;95;95;96;95;96;95;95;95;96 17:27:17 INFO - PROCESS | 22662 | |8;json-parse-financial;59;59;59;58;58;63;57;73;57;59 17:27:17 INFO - PROCESS | 22662 | |9;json-stringify-tinderbox;60;61;61;60;61;61;60;60;62;61 17:27:17 INFO - PROCESS | 22662 | |10;stanford-crypto-aes;78;80;78;76;78;77;79;79;79;86 17:27:17 INFO - PROCESS | 22662 | |11;stanford-crypto-ccm;136;129;131;126;127;125;134;131;160;125 17:27:17 INFO - PROCESS | 22662 | |12;stanford-crypto-pbkdf2;175;174;170;169;186;170;169;167;170;174 17:27:17 INFO - PROCESS | 22662 | |13;stanford-crypto-sha256-iterative;69;72;71;70;73;71;70;69;70;69 17:27:17 INFO - PROCESS | 22662 | __end_tp_report 17:27:17 INFO - PROCESS | 22662 | __start_cc_report 17:27:17 INFO - PROCESS | 22662 | _x_x_mozilla_cycle_collect,842 17:27:17 INFO - PROCESS | 22662 | __end_cc_report 17:27:17 INFO - PROCESS | 22662 | __startTimestamp1461976037617__endTimestamp 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | ------- Summary: start ------- 17:27:17 INFO - PROCESS | 22662 | Number of tests: 14 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:4.47 (3.9%) stddev-sans-first:4.73 17:27:17 INFO - PROCESS | 22662 | Values: 114.0 106.0 114.0 112.0 113.0 124.0 112.0 112.0 111.0 114.0 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:158.50 stddev:21.34 (13.5%) stddev-sans-first:22.27 17:27:17 INFO - PROCESS | 22662 | Values: 162.0 126.0 155.0 182.0 132.0 163.0 152.0 130.0 181.0 128.0 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.50 stddev:3.81 (2.3%) stddev-sans-first:4.00 17:27:17 INFO - PROCESS | 22662 | Values: 163.0 164.0 163.0 163.0 161.0 164.0 174.0 163.0 168.0 162.0 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | [#3] audio-fft Cycles:10 Average:91.60 Median:74.00 stddev:36.23 (49.0%) stddev-sans-first:37.98 17:27:17 INFO - PROCESS | 22662 | Values: 76.0 77.0 74.0 148.0 73.0 73.0 73.0 74.0 171.0 77.0 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:92.00 stddev:26.68 (29.0%) stddev-sans-first:27.60 17:27:17 INFO - PROCESS | 22662 | Values: 92.0 92.0 147.0 93.0 92.0 92.0 143.0 92.0 93.0 152.0 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:27:17 INFO - PROCESS | 22662 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 17:27:17 INFO - PROCESS | 22662 | Values: 147.0 147.0 147.0 146.0 151.0 148.0 147.0 147.0 148.0 147.0 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:27:17 INFO - PROCESS | 22662 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:59.00 stddev:4.80 (8.1%) stddev-sans-first:5.07 17:27:17 INFO - PROCESS | 22662 | Values: 59.0 59.0 59.0 58.0 58.0 63.0 57.0 73.0 57.0 59.0 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 17:27:17 INFO - PROCESS | 22662 | Values: 60.0 61.0 61.0 60.0 61.0 61.0 60.0 60.0 62.0 61.0 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:2.71 (3.4%) stddev-sans-first:2.85 17:27:17 INFO - PROCESS | 22662 | Values: 78.0 80.0 78.0 76.0 78.0 77.0 79.0 79.0 79.0 86.0 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:131.00 stddev:10.39 (7.9%) stddev-sans-first:10.94 17:27:17 INFO - PROCESS | 22662 | Values: 136.0 129.0 131.0 126.0 127.0 125.0 134.0 131.0 160.0 125.0 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:172.00 stddev:5.44 (3.2%) stddev-sans-first:5.69 17:27:17 INFO - PROCESS | 22662 | Values: 175.0 174.0 170.0 169.0 186.0 170.0 169.0 167.0 170.0 174.0 17:27:17 INFO - PROCESS | 22662 | 17:27:17 INFO - PROCESS | 22662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:1.35 (1.9%) stddev-sans-first:1.33 17:27:17 INFO - PROCESS | 22662 | Values: 69.0 72.0 71.0 70.0 73.0 71.0 70.0 69.0 70.0 69.0 17:27:17 INFO - PROCESS | 22662 | -------- Summary: end -------- 17:27:17 INFO - PROCESS | 22662 | 17:27:18 INFO - TEST-INFO | 22662: exit 0 17:27:18 INFO - TEST-OK | kraken | took 61711ms 17:27:18 INFO - SUITE-END | took 1171s 17:27:18 INFO - Completed test suite (00:19:31) 17:27:18 INFO - javascript benchmark 17:27:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3164.1298642873207, 3203.7276831469326, 3221.9355612887734, 3249.4475939090353, 3258.8859389921345, 5418.620696551243, 5432.0, 5437.564994800417, 5442.673439593622, 5468.562514998801, 5394.757235924383, 5457.727113644311, 5555.777768889239, 5557.305336832896, 5564.4713752193575, 4878.0, 4884.462709101996, 4941.802327906879, 4949.0, 4963.851084467454, 4928.211486162215, 5072.594192464594, 5094.439611642716, 5101.336826212587, 5105.617078719092, 4965.081459929925, 4986.950130498685, 4999.650024498286, 5011.42368627607, 5053.5704465120325, 4944.901101977976, 4954.43024052235, 4956.281339205831, 4958.157113290749, 4972.577330926875, 4931.087748766489, 4931.679440836334, 4948.0, 4950.084234416644, 4973.776180071869, 5324.653897496689, 5337.733113344318, 5360.035193665139, 5386.8383948481605, 5390.70623050469, 5702.344230413514, 5721.056025755745, 5731.942680573183, 5735.885282294373, 5744.138379243105, 5769.509591684669, 5769.567282453832, 5772.0476121439915, 5781.277340332458, 5799.043157878945, 5349.732513374316, 5434.347878254595, 5461.563074954034, 5475.863103422406, 5501.229827824108, 5971.701414929323, 5978.073398623221, 5978.850528736816, 6000.729967151488, 6013.248343957005, 5720.542356611461, 5759.366469688331, 5780.046292361797, 5781.392953739881, 5784.623999440023, 5892.234009578728, 5923.644581325134, 5936.821895343147, 5961.195238642815, 5988.251468566429, 5717.942820571741, 5760.971195144081, 5773.913391299134, 5794.826155215266, 5853.912191317134, 5765.884682306414, 5801.187833703285, 5850.063989761703, 5854.238948936696, 5891.410858914074, 4391.187630288407, 4418.955810441918, 4440.911181776346, 4473.7986790594505, 4505.7296562206375, 3920.4903362563255, 3921.0785465415606, 3922.666573341241, 3953.6441720245316, 3955.3869150281753, 5452.345718513724, 5504.146857237135, 5547.057000309957, 5548.5838562108, 5565.777368905279, 5887.411258874078, 5938.762449501972, 5957.344692083867, 5960.821175364746, 5985.760569577255, 5512.283403157644, 5517.806876759294, 5518.420565840609, 5526.226328314039, 5528.391876893538, 4953.554180123806, 4974.502549745069, 4976.178930476503, 5003.524665156804, 5008.198688209869, 6074.878502430015, 6099.695015249308, 6108.038540470994, 6109.922904750062, 6127.6502361584835, 5863.267091613463, 5865.3254875688135, 5871.354151043296, 5876.882462350814, 5888.793892213752, 5964.7912323068485, 6013.909791353046, 6054.788082417094, 6082.635041897501, 6089.269287685506, 5728.54171666274, 5749.367569567428, 5758.222639943554, 5768.394318596655, 5790.884182316414, 5834.38738932406, 5841.1238314253205, 5852.4147585241135, 5852.912206316823, 5863.677497737494, 5583.1904373864745, 5654.802081927113, 5704.0, 5714.942850571441, 5734.483896449339, 5603.767171222325, 5610.8316750495915, 5662.886742265214, 5673.74468148926, 5739.942600573941, 5511.0, 5539.0, 5652.519535839335, 5661.0, 5673.716314184192, 5694.886102278014, 5717.37108918027, 5738.741756621045, 5767.452092051249, 5795.0, 5533.087040638249, 5650.943490565206, 5656.406077361982, 5668.914966275592, 5673.205751194753], "value": 5382.253703615551, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.6498830678207, 617.0836308082494, 649.7076315657954, 663.4195079305607, 670.1857243449208, 37604.0, 38829.223415531706, 38889.24998375073, 38951.61048389515, 39017.0, 38208.235835283274, 38861.22277554454, 39328.443651162655, 39345.213095738065, 39631.207375852464, 8468.407211495198, 8621.95689021554, 8633.827323453559, 8681.826363472726, 8691.652333906635, 8540.78648033798, 8595.95702021489, 8635.179657932518, 8654.09132041136, 8727.0, 8698.782530436727, 8716.346274029442, 8746.431481953685, 8769.210771030637, 8796.25231855293, 8662.566871656423, 8755.080716524737, 8768.254698350647, 8777.605007774666, 8791.78020549485, 8540.572971351408, 8613.655453781841, 8627.094155113748, 8629.0, 8659.956700216522, 38461.42307865384, 38796.0, 38797.61202387968, 38943.0, 39014.02464938371, 3453.309338132384, 3597.784132952005, 3625.093726568358, 3639.217568222845, 3717.925641487155, 30995.690043099505, 31307.53038704421, 31424.214394640087, 31631.683683163104, 31691.366172676648, 4066.79666016698, 4115.753054816691, 4144.119836713486, 4200.1179752252065, 4375.431193944799, 308944.0, 311327.0, 311542.0, 311965.0, 312522.4373878139, 33645.15887102842, 34002.14994625105, 34265.65734342675, 58567.70716146477, 59745.0, 34594.0, 34794.82602586971, 34853.0, 34997.65002349944, 35005.47491787625, 14913.92543037278, 15104.54686359411, 15112.924435377752, 15116.0, 15135.394584216729, 12317.938410307892, 12371.876281237252, 12384.876151238552, 12392.876071239352, 12405.813912791315, 8680.262177714965, 8697.304215662733, 8722.084181160886, 8777.122287771299, 8833.939927208648, 3374.4938259260816, 3391.609964854024, 3400.625931147572, 3452.1197094740683, 3461.8442170102408, 1088.472091035847, 1093.191038631423, 1126.515598292742, 1138.8177891537314, 1163.5345861655405, 31210.687893121234, 31981.360372792413, 32421.18947026343, 32524.74752524776, 32990.83504582462, 1109.2401704832216, 1164.8485696859354, 1179.6932797472548, 1181.757739663367, 1210.5520957245876, 17135.143242837807, 17243.827561724473, 17349.7397539037, 17397.130143492774, 17539.912300438416, 475158.0, 478340.0, 479500.0, 479984.0, 480875.0, 58320.0, 58948.70525647344, 58981.41018589845, 59145.40854591485, 59384.703076484344, 1420.2188796162277, 1428.8499707530768, 1441.8269807623153, 1442.776369662683, 1444.7399468095844, 31108.066757997298, 31405.214869628442, 31625.36749265048, 31701.20746981344, 32144.0, 51703.0, 51895.481045189066, 52170.739146304026, 52170.739146304026, 52218.0, 372262.0, 376239.0, 377890.0, 379135.0, 380536.0, 29062.854685726437, 29133.56299655549, 29382.85308573529, 29385.70614293915, 29429.264268392606, 48138.0, 48646.75676621594, 49241.2613810786, 49739.50260497349, 49950.50049499459, 40982.0, 41299.0, 41503.58496414997, 42010.78994605008, 43342.783286083366, 40523.39214911838, 41363.379549306184, 41450.79274603607, 41667.58332416637, 42052.57947420487, 40614.18771624492, 41127.38308925428, 41714.374284386366, 42337.364939526546, 42748.64882431496, 36061.27877442489, 37253.62746372502, 37294.81352593219, 37572.812135939144, 37980.24039519139, 27879.03482270657, 28213.294667633472, 28307.43385132327, 28462.715372846007, 28645.283867902635], "value": 18564.399079741113, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.72566566236475, 395.98020098995045, 400.9037830920579, 408.6853123095217, 411.6398151617335, 18144.455666330014, 18456.907715461402, 18658.53353666159, 18710.064496775158, 20270.493237669067, 18842.71735923959, 19356.225750969945, 19599.510012249666, 19644.21423143076, 19807.90096049518, 5335.733213339317, 5576.302962129734, 5640.887182256373, 5700.201971723962, 5907.940920590803, 5398.406175320712, 5555.8888822223535, 5579.497845193931, 5620.381758006616, 5860.4139586041265, 5809.419058094178, 5832.708364581775, 5833.066709326508, 5855.502282306009, 5877.382874798127, 5795.130730390454, 5805.651660900359, 5823.446772556622, 6417.486601071903, 6421.229452465687, 5616.634918730269, 5698.914516282218, 5712.685802280873, 5712.714364281811, 5726.455986681301, 14614.926925365306, 22065.558688826295, 22427.77572224273, 22783.08867645292, 22803.88598056999, 2207.2716003718897, 2230.9776902230933, 2232.520008198229, 2311.6185829338137, 2666.78665706743, 9938.453385063818, 10177.89822101777, 10186.949065254701, 10393.740156496073, 10504.579816807394, 1903.8857668539931, 1975.101328895349, 2008.6484865148686, 2023.271622216001, 2035.165582111342, 75590.0, 77174.61412692901, 77628.22371776267, 78524.21475785226, 80081.59959200167, 10525.578976840841, 10934.4532773361, 10960.725981850517, 11033.179525378222, 11140.49867755953, 15343.465653434567, 15347.693046139015, 15426.691466170838, 15471.22643867802, 15487.225638718019, 8247.711330103417, 8291.129431409736, 8344.207300306462, 8432.78918027042, 8450.19723126302, 7958.442908996431, 7975.082865470429, 8053.395995300376, 8058.0733215679775, 8088.9595552021865, 4652.930206046912, 4723.527647235318, 4807.735574543433, 4848.393950756155, 4850.53919877611, 1941.1847024249848, 1992.601479704065, 2023.5042414608515, 2023.6643815081975, 2028.2698228637678, 903.5708038681705, 938.8591711243231, 956.660385563129, 993.6273897288517, 1099.0383414512303, 18351.724724129148, 18600.0, 18901.0, 19041.619167616846, 19291.51771205703, 997.6432052408718, 1023.0179028132927, 1031.5976769060073, 1052.9631462898762, 1061.3737894642197, 10457.633982810717, 10780.730481737863, 10832.404217768099, 10926.399048052275, 10970.451477426097, 435954.0, 438513.0, 458893.0, 493184.0, 500891.0, 87061.56469217614, 91046.54476727574, 92956.0, 94052.0, 94891.52554237185, 1016.278442305971, 1025.497506221946, 1028.5834237133972, 1033.6537260017978, 1041.770810421706, 16485.17574121313, 16758.916205419384, 16929.830701692827, 16963.7455438171, 17166.828331716522, 37416.6258337424, 39250.41124383079, 39951.80024099861, 40929.59070409258, 41584.584154158074, 55906.44093559012, 56323.0, 56492.0, 56708.43291567197, 57096.429035710775, 7831.804204894923, 8172.6730930762105, 8184.590770461334, 8604.698835540727, 8687.565621719015, 12020.398980051137, 12752.936235318764, 12782.488700451877, 12858.614241572768, 13164.934175329063, 10685.626003089854, 11447.198696091195, 11559.422028898352, 11614.187006909435, 11658.88341116578, 5342.9465705342445, 10318.380897146195, 10480.68557943263, 11202.327860328407, 11567.768644626893, 11550.075993920298, 11685.065194784227, 11869.0, 11992.460339284928, 12178.878211218129, 7936.166702496154, 8274.958625206835, 8324.256263178388, 8614.526201059001, 8728.607212675317, 11198.21612487118, 11873.0, 11961.880381196424, 12063.698407539881, 12175.878241217828], "value": 9127.64106864555, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1534.9079055256682, 1557.3147814961417, 1725.1460527039117, 1785.3572713823014, 1797.712366021436, 7324.450666200029, 7843.490173138742, 8147.900033495476, 8150.714724984627, 8295.460795048317, 7935.801604959879, 7966.123726390092, 7995.320397766182, 7996.080450748165, 8033.758987230392, 2295.9081636734554, 2340.3330050935488, 2348.7181538215436, 2352.047420794581, 2356.9175078872245, 2239.4177513846435, 2253.876036817974, 2268.5349503351854, 2280.315905228433, 2282.1898226129733, 2319.721633403994, 2335.871527066011, 2336.1356298169617, 2353.9882300588474, 2361.5631108244943, 2274.5792028474784, 2282.543491301746, 2286.4855407533337, 2290.6449500327476, 2320.721513418384, 2283.0, 2294.621387471065, 2305.3660243433023, 2311.167979527369, 2331.1724337859987, 8137.349012079019, 8154.75535733929, 8167.63245653947, 8181.959090204511, 8185.959070204671, 5081.644284900059, 5292.682439053669, 5316.9202461963105, 5324.840254792362, 5330.413654498002, 3200.7599430042605, 3344.0970937846887, 3389.474631432132, 3414.7609667323295, 3418.1967237699123, 1073.3452593917705, 1079.2499213046935, 1087.8477013218076, 1092.5083712329483, 1123.8651361836633, 11878.227915185485, 11911.761764764742, 11913.22564033335, 11927.642170734805, 11941.462634181482, 4733.810647574127, 4781.904361912742, 4792.329073929653, 4830.975845120752, 4831.541003604652, 10083.294169408218, 10156.0, 10167.0, 10171.54228059739, 10175.84736228957, 5219.973900130475, 5228.581713462914, 5237.371515418175, 5252.395974462909, 5267.130923397596, 4490.483594386622, 4883.511648835088, 4932.556069953722, 4945.060438516743, 5045.899082018413, 3836.76979381238, 3851.807409629507, 3898.629630185128, 3914.784686842194, 4024.537178224483, 1205.0781152418408, 1250.1311588445942, 1250.2373552133192, 1264.1088032936757, 1275.2985857778185, 955.2883102088988, 1015.7155996321042, 1037.5849660136007, 1048.145761204631, 1063.3672964586058, 5862.8534286642325, 5869.20765696634, 5924.407559244041, 5998.550108741862, 6187.071939209155, 1012.1295685710284, 1017.7455636090978, 1027.8047171037629, 1030.217035053365, 1047.2093569355088, 4220.451341325669, 4223.894402639959, 4250.596193361625, 4261.232978063917, 4264.616184543406, 9772.169365604002, 10232.693019209435, 10293.228007899437, 10296.330738501973, 10310.175185985103, 10054.949725251327, 10190.43952582615, 10202.948985255174, 10207.285490015776, 10253.128484078788, 7667.8849817252785, 7723.845523089619, 8075.313598344089, 8138.3896207784655, 8157.551334676531, 5485.369182544058, 5706.3152421709665, 5740.425957404394, 5842.977478941253, 5889.0, 9439.575219115293, 9645.614175432904, 9652.90347096548, 10073.19414446857, 10077.848832267668, 9615.23078153732, 9644.276679249224, 10077.546510407195, 10078.244131690299, 10214.080732733792, 7423.406127509678, 7438.888416673863, 7466.4026877848555, 7517.548947063194, 7525.962370188114, 8040.437169398086, 8122.75631731049, 8123.147069557847, 8124.83750325002, 8143.8778418324955, 7250.3112204340505, 7496.062992125984, 7517.924820751722, 7559.3196612305155, 7641.044869391326, 7345.118585769742, 7422.0, 7444.330010299099, 7457.589832559262, 7660.34887034586, 6840.794776156723, 6855.520113592001, 6890.138732658418, 6921.688524016532, 6926.826829329307, 5040.974795126001, 5118.820841270538, 5180.093483640272, 5264.763085661231, 5293.179557168645, 5192.506711862367, 5247.344081989751, 5294.682319060868, 5308.124159513792, 5308.840734777808], "value": 4580.181701249261, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.152828809465, 336.9957526570819, 341.64127665950747, 341.93161367726464, 344.71216534193945, 5402.405735369106, 5471.671699698021, 5532.640378375408, 5587.497125258721, 5658.0, 5486.451354864512, 5509.807156749514, 5552.305961754781, 5568.192612071247, 5568.440836565758, 4308.870733877989, 4328.675349348796, 4337.7397356158735, 4340.65274778017, 4343.869683909487, 4171.207470580595, 4316.374125751764, 4324.22164010478, 4354.695171338008, 4356.869293921188, 4250.681198910079, 4289.442372491571, 4299.742015479065, 4302.720323178984, 4312.1375724855, 4315.4389929309145, 4328.50222224445, 4333.458317710286, 4336.089421221532, 4345.175026488882, 3559.359315323241, 3841.2509560635685, 3842.9615703843165, 3852.8266228019806, 3853.1523064925673, 5303.469653034705, 5349.224362467459, 5378.757955891994, 5387.838364849061, 5398.541124004425, 4858.344123543312, 4882.462929077798, 4887.584555312803, 4895.681780684244, 4916.50834916509, 5510.889782204374, 5783.363829978699, 5809.970950145223, 5818.44724751148, 5854.531637468992, 4076.673866090706, 4083.1833633273463, 4083.958590559418, 4084.5098588169312, 4113.197926404352, 6011.428914253139, 6032.698365081728, 6048.848778780522, 6068.878622427571, 6115.6942152892625, 4086.7956602169775, 4095.406166105898, 4188.769617670996, 4204.390363397351, 4234.3860140279485, 4187.267228235047, 4189.91620167601, 4205.074883525619, 4212.726172798758, 4218.725782824106, 4865.756712164378, 4876.975615121973, 4888.608911287089, 4910.582600478928, 4939.234418665041, 5264.736763161904, 5874.1776151338845, 5881.176635271066, 5914.497267732205, 5931.169636250928, 1511.5692027772031, 1523.2079318754186, 1524.146477972339, 1528.5719998400466, 1529.7303238312174, 1008.3596915958419, 1010.959561617527, 1021.4024795494719, 1030.8917563655857, 1031.9071283584362, 5967.671778052249, 5988.790392336335, 5991.981363168272, 6052.576319657582, 6052.6671033092725, 6371.108044873721, 6379.425851673279, 6422.678866056678, 6423.646699431482, 6461.25695545009, 5859.472647461664, 5886.234789477427, 5926.733297001645, 5951.047832346804, 5967.940320596826, 3368.3768502827056, 3385.0691059958217, 3403.4554471284478, 3420.931581368359, 3422.8801991930163, 5983.6708981005595, 6320.462760665395, 6331.746730130835, 6569.967150164219, 6606.207255129415, 6203.379662033851, 6242.906356404657, 6277.780277690259, 6287.2140982377205, 6304.707534955323, 6200.906986395207, 6328.11406403104, 6336.17629708135, 6356.0, 6376.33048529907, 6099.359567245553, 6113.23584551931, 6152.200213972155, 6161.0, 6219.40915613016, 6021.494626343414, 6030.4572588467245, 6047.879042419039, 6069.0, 6093.238345206849, 6087.543434242538, 6256.530760192913, 6266.937330626635, 6313.275167651108, 6321.54604440972, 4171.249175148381, 4244.830206791694, 4248.7693960670895, 4261.318189089855, 4269.807858646431, 5587.860303492445, 5951.851203719942, 6039.969800150971, 6114.798672477816, 6144.324124346408, 5775.509081727932, 5816.807554451243, 5819.214406055128, 5848.824535263949, 5867.530597552271, 5827.475527202572, 5852.678102704393, 5858.794942177004, 5896.380880007538, 5902.291724992857, 5546.528545073714, 5716.628419152742, 5781.942180578309, 5793.478586927196, 5794.942050579609, 5800.24596802413, 5925.992581261282, 5936.762529498772, 5951.137085122719, 5954.285485741739, 5646.85882852932, 5721.25623668937, 5748.362402336083, 5776.508996735324, 5794.18881356602], "value": 4488.865143354204, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.3165843204057, 807.2169995104748, 819.6434550970326, 827.871679889617, 875.0724232313748, 13615.79576306355, 13699.315034248286, 14578.854211457883, 14810.00064991226, 14880.702385952274, 13692.246926419042, 13758.449662013507, 13759.79360309596, 13763.174209547435, 13775.035747497679, 688.2016860441876, 803.8512875118092, 842.1073661918356, 843.2579330189425, 843.5950743643054, 815.8409110223508, 820.9835803283961, 824.814416756231, 829.6764261937819, 831.6673330667721, 873.7640836974014, 878.0955615715823, 882.2016075451727, 883.2271762208068, 885.6368888755611, 860.8536548786722, 870.3081050564816, 873.1530415496926, 873.2882700599023, 874.8119154381775, 630.845442866496, 635.463033736492, 636.0903907412398, 637.4645297949744, 637.8851806674796, 14271.78592321116, 14300.0, 14310.64223394413, 14324.14055156694, 14396.496122635763, 14363.856361436356, 14423.206723630195, 14451.566453006426, 14485.130892146504, 14521.564353069425, 11418.31490110596, 11498.367589782558, 11545.653630391102, 11616.825747613793, 11695.298282103102, 3862.8454861805776, 3909.280811697989, 3913.099987002977, 3924.2151569686175, 3950.723449358546, 51440.0, 52189.0, 52586.47413525854, 52703.47296527062, 53550.19674704882, 11136.888631113747, 11204.887951120547, 11263.380514071805, 11306.660800176009, 11383.203175777617, 19860.10629521646, 19893.10481028357, 19901.900490497454, 20066.0, 20153.596928061357, 8266.669333226724, 8573.614187361583, 8606.0, 8610.827783444422, 8728.389012769045, 4534.410526631516, 4698.718076915396, 4720.622350211975, 4740.691855029412, 4865.805367785249, 3281.4749640057476, 3301.1747063234193, 3343.8996830095134, 3353.7987720736833, 3354.8490317935753, 589.8260013296087, 609.9329073801878, 622.6233128957007, 622.7789134857151, 626.2109741725459, 738.881778915371, 774.4540099230029, 777.0946846923271, 782.9843403131905, 787.2481779900181, 9128.406653567497, 9655.08276713711, 9737.756556086155, 9829.0, 9833.557489912972, 612.9570930034855, 627.3130921640887, 640.2413140428607, 654.9017647352936, 693.1093544794915, 4399.5820397062225, 4663.556962088596, 4696.225122854691, 4728.88177795551, 4741.478437371887, 67322.3267767316, 67501.0, 67764.66117669479, 67975.0, 69286.65356673184, 52427.47572524226, 52457.2131418029, 55087.724561376934, 55348.72325638346, 58203.126953095736, 53015.20477192768, 54323.18515222275, 54850.72574637101, 55132.724336378866, 55590.0, 9065.393489617296, 9416.717498475056, 9431.198348140484, 9479.194268487256, 9486.383385079947, 32987.34025319528, 33773.662263378035, 34752.78365257204, 34873.82563087168, 35269.64730352664, 42858.357124642534, 44800.55199448094, 47150.0, 47896.760516197195, 48044.759776200895, 11879.406029698654, 11950.0, 12078.939605301917, 12256.877431225574, 12353.197042192229, 13185.0, 13328.466861325438, 13351.866481335062, 13668.65828354299, 14654.413823446943, 11925.0, 12397.814032789696, 12414.131010829155, 13188.80216796768, 13199.868001319865, 12599.811002835148, 13250.133429103023, 13327.267000315076, 13370.0, 13439.2034847542, 12561.371931403575, 12676.302803345905, 12722.491100355883, 12765.553205637758, 12868.485260589472, 10527.263091583516, 10887.945560272148, 10941.890581094087, 10981.231313807957, 11362.715932101764, 10810.621628242974, 10824.458777060958, 10909.618163364561, 10926.890731092588, 11024.559017639205], "value": 6870.511963839303, "unit": "score"}], "name": "dromaeo_css", "value": 7106.819625909198, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 114.0, 112.0, 113.0, 124.0, 112.0, 112.0, 111.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 126.0, 155.0, 182.0, 132.0, 163.0, 152.0, 130.0, 181.0, 128.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 161.0, 164.0, 174.0, 163.0, 168.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 74.0, 148.0, 73.0, 73.0, 73.0, 74.0, 171.0, 77.0], "value": 91.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 147.0, 93.0, 92.0, 92.0, 143.0, 92.0, 93.0, 152.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 151.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 58.0, 58.0, 63.0, 57.0, 73.0, 57.0, 59.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 60.0, 62.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 78.0, 76.0, 78.0, 77.0, 79.0, 79.0, 79.0, 86.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 129.0, 131.0, 126.0, 127.0, 125.0, 134.0, 131.0, 160.0, 125.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 170.0, 169.0, 186.0, 170.0, 169.0, 167.0, 170.0, 174.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 71.0, 70.0, 73.0, 71.0, 70.0, 69.0, 70.0, 69.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1565.2000000000003, "alertThreshold": 2.0}]} 17:27:18 INFO - Return code: 0 17:27:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:27:18 ERROR - # TBPL SUCCESS # 17:27:18 INFO - Running post-action listener: _resource_record_post_action 17:27:18 INFO - Running post-run listener: _resource_record_post_run 17:27:19 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 536625152; Read time: 24; Write time: 528800 17:27:19 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244834304; Read time: 0; Write time: 317188 17:27:19 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291790848; Read time: 24; Write time: 211612 17:27:19 INFO - Running post-run listener: _upload_blobber_files 17:27:19 INFO - Blob upload gear active. 17:27:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:27:19 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 17:27:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:27:20 INFO - (blobuploader) - INFO - Open directory for files ... 17:27:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:27:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:27:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:27:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:27:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:27:21 INFO - (blobuploader) - INFO - Done attempting. 17:27:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:27:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:27:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:27:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:27:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:27:22 INFO - (blobuploader) - INFO - Done attempting. 17:27:22 INFO - (blobuploader) - INFO - Iteration through files over. 17:27:22 INFO - Return code: 0 17:27:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:27:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:27:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/464982f1815b76ca0385af60a647b03a0310cd598bde174cb2ba97df9b4426ec8d6c86a4f4ec5cc07c79435a82a3a21e432d8e7c27343feba108fcf286b2b7e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/167a5228c7b1c4aaad71fb12207cfef563663154abdf0c19d0ffed7daa8dd20c471966e8d2cd7f8ce937e43ab646fac73396dd83f1ca852a1adfdb6fc0d72d08"} 17:27:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:27:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:27:22 INFO - Contents: 17:27:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/464982f1815b76ca0385af60a647b03a0310cd598bde174cb2ba97df9b4426ec8d6c86a4f4ec5cc07c79435a82a3a21e432d8e7c27343feba108fcf286b2b7e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/167a5228c7b1c4aaad71fb12207cfef563663154abdf0c19d0ffed7daa8dd20c471966e8d2cd7f8ce937e43ab646fac73396dd83f1ca852a1adfdb6fc0d72d08"} 17:27:22 INFO - Running post-run listener: copy_logs_to_upload_dir 17:27:22 INFO - Copying logs to upload dir... 17:27:22 INFO - mkdir: /builds/slave/test/build/upload/logs 17:27:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.112418 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-29 17:27:21.967110) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 17:27:21.970647) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/464982f1815b76ca0385af60a647b03a0310cd598bde174cb2ba97df9b4426ec8d6c86a4f4ec5cc07c79435a82a3a21e432d8e7c27343feba108fcf286b2b7e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/167a5228c7b1c4aaad71fb12207cfef563663154abdf0c19d0ffed7daa8dd20c471966e8d2cd7f8ce937e43ab646fac73396dd83f1ca852a1adfdb6fc0d72d08"} build_url:https://queue.taskcluster.net/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/U8kdgV-IR5KtxAwttYaDFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/464982f1815b76ca0385af60a647b03a0310cd598bde174cb2ba97df9b4426ec8d6c86a4f4ec5cc07c79435a82a3a21e432d8e7c27343feba108fcf286b2b7e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/167a5228c7b1c4aaad71fb12207cfef563663154abdf0c19d0ffed7daa8dd20c471966e8d2cd7f8ce937e43ab646fac73396dd83f1ca852a1adfdb6fc0d72d08"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 17:27:21.996170) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 17:27:21.996528) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461973593.169718-1887070027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 17:27:22.082275) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 17:27:22.082733) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 17:27:22.083168) ========= ========= Total master_lag: 0.17 =========