builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1460766969.75 results: success (0) buildid: 20160415150621 builduid: 49945ae2feea4af287fd42ded6f83459 revision: aca518830db248be63b2e879d12bfb899fc39ec1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 17:36:09.750757) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 17:36:09.751162) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 17:36:09.751428) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 17:36:09.771480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:36:09.771735) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 17:36:10-- 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% 40.6M=0s 2016-04-15 17:36:10 (40.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.444277 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:36:10.232135) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:36:10.232453) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017509 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:36:10.281549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 17:36:10.281853) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev aca518830db248be63b2e879d12bfb899fc39ec1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev aca518830db248be63b2e879d12bfb899fc39ec1 --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=6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 17:36:10,794 truncating revision to first 12 chars 2016-04-15 17:36:10,794 Setting DEBUG logging. 2016-04-15 17:36:10,794 attempt 1/10 2016-04-15 17:36:10,794 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/aca518830db2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 17:36:11,561 unpacking tar archive at: mozilla-aurora-aca518830db2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.040959 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 17:36:11.346725) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 17:36:11.347086) ========= script_repo_revision: aca518830db248be63b2e879d12bfb899fc39ec1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 17:36:11.347551) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 17:36:11.347939) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 17:36:11.371868) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-15 17:36:11.372189) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:36:11 INFO - MultiFileLogger online at 20160415 17:36:11 in /builds/slave/test 17:36:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:36:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:36:11 INFO - {'append_to_log': False, 17:36:11 INFO - 'base_work_dir': '/builds/slave/test', 17:36:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:36:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:36:11 INFO - 'branch': 'Mozilla-Aurora', 17:36:11 INFO - 'buildbot_json_path': 'buildprops.json', 17:36:11 INFO - 'config_files': ('talos/linux_config.py',), 17:36:11 INFO - 'default_actions': ('clobber', 17:36:11 INFO - 'read-buildbot-config', 17:36:11 INFO - 'download-and-extract', 17:36:11 INFO - 'populate-webroot', 17:36:11 INFO - 'create-virtualenv', 17:36:11 INFO - 'install', 17:36:11 INFO - 'run-tests'), 17:36:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:36:11 INFO - 'download_minidump_stackwalk': True, 17:36:11 INFO - 'download_symbols': 'ondemand', 17:36:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:36:11 INFO - 'tooltool.py': '/tools/tooltool.py', 17:36:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:36:11 INFO - '/tools/misc-python/virtualenv.py')}, 17:36:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:36:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:36:11 INFO - 'installer_path': 'installer.exe', 17:36:11 INFO - 'log_level': 'info', 17:36:11 INFO - 'log_name': 'talos', 17:36:11 INFO - 'log_to_console': True, 17:36:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:36:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:36:11 INFO - 'opt_config_files': (), 17:36:11 INFO - 'pip_index': False, 17:36:11 INFO - 'sps_profile': False, 17:36:11 INFO - 'sps_profile_interval': 0, 17:36:11 INFO - 'suite': 'dromaeojs', 17:36:11 INFO - 'system_bits': '32', 17:36:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:36:11 INFO - 'title': 'talos-linux64-ix-023', 17:36:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:36:11 INFO - 'use_talos_json': True, 17:36:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:36:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:36:11 INFO - 'work_dir': 'build'} 17:36:11 INFO - ##### 17:36:11 INFO - ##### Running clobber step. 17:36:11 INFO - ##### 17:36:11 INFO - Running pre-action listener: _resource_record_pre_action 17:36:11 INFO - Running main action method: clobber 17:36:11 INFO - rmtree: /builds/slave/test/build 17:36:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:36:12 INFO - Running post-action listener: _resource_record_post_action 17:36:12 INFO - ##### 17:36:12 INFO - ##### Running read-buildbot-config step. 17:36:12 INFO - ##### 17:36:12 INFO - Running pre-action listener: _resource_record_pre_action 17:36:12 INFO - Running main action method: read_buildbot_config 17:36:12 INFO - Using buildbot properties: 17:36:12 INFO - { 17:36:12 INFO - "project": "", 17:36:12 INFO - "product": "firefox", 17:36:12 INFO - "script_repo_revision": "production", 17:36:12 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 17:36:12 INFO - "repository": "", 17:36:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 17:36:12 INFO - "buildid": "20160415150621", 17:36:12 INFO - "pgo_build": "True", 17:36:12 INFO - "basedir": "/builds/slave/test", 17:36:12 INFO - "buildnumber": 170, 17:36:12 INFO - "slavename": "talos-linux64-ix-023", 17:36:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:36:12 INFO - "platform": "ubuntu64_hw", 17:36:12 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:36:12 INFO - "branch": "mozilla-aurora", 17:36:12 INFO - "repo_path": "releases/mozilla-aurora", 17:36:12 INFO - "revision": "aca518830db248be63b2e879d12bfb899fc39ec1", 17:36:12 INFO - "stage_platform": "linux64-pgo", 17:36:12 INFO - "builduid": "49945ae2feea4af287fd42ded6f83459", 17:36:12 INFO - "slavebuilddir": "test" 17:36:12 INFO - } 17:36:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 17:36:12 INFO - Running post-action listener: _resource_record_post_action 17:36:12 INFO - ##### 17:36:12 INFO - ##### Running download-and-extract step. 17:36:12 INFO - ##### 17:36:12 INFO - Running pre-action listener: _resource_record_pre_action 17:36:12 INFO - Running main action method: download_and_extract 17:36:12 INFO - mkdir: /builds/slave/test/build/tests 17:36: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:36:12 INFO - https://queue.taskcluster.net/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:36:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:36:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:36:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:36:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:36:20 INFO - Downloaded 1448 bytes. 17:36:20 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:36:20 INFO - Using the following test package requirements: 17:36:20 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 17:36:20 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:36:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:36:20 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:36:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:36:20 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:36:20 INFO - u'jsshell-linux-x86_64.zip'], 17:36:20 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:36:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:36:20 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 17:36:20 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:36:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:36:20 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:36:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:36:20 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:36:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:36:20 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 17:36:20 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:36:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:36:20 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:36:20 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:36:20 INFO - https://queue.taskcluster.net/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:36:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:36:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:36:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:36:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:36:27 INFO - Downloaded 23352099 bytes. 17:36:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:36:28 INFO - Return code: 0 17:36:28 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:28 INFO - https://queue.taskcluster.net/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:36:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:36:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:36:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:36:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:36:35 INFO - Downloaded 23352099 bytes. 17:36:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:36:36 INFO - Return code: 0 17:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:36 INFO - https://queue.taskcluster.net/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:36:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 17:36:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 17:36:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 17:36:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:36:37 INFO - Downloaded 10845168 bytes. 17:36:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:36:38 INFO - Return code: 0 17:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:38 INFO - https://queue.taskcluster.net/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:36:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:36:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:36:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:36:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:36:40 INFO - Downloaded 60578515 bytes. 17:36:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:36:40 INFO - mkdir: /builds/slave/test/properties 17:36:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:36:40 INFO - Writing to file /builds/slave/test/properties/build_url 17:36:40 INFO - Contents: 17:36:40 INFO - build_url:https://queue.taskcluster.net/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:36:41 INFO - Running post-action listener: _resource_record_post_action 17:36:41 INFO - Running post-action listener: set_extra_try_arguments 17:36:41 INFO - ##### 17:36:41 INFO - ##### Running populate-webroot step. 17:36:41 INFO - ##### 17:36:41 INFO - Running pre-action listener: _resource_record_pre_action 17:36:41 INFO - Running main action method: populate_webroot 17:36:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:36:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:36:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:36:41 INFO - '--tppagecycles', 17:36:41 INFO - '7'], 17:36:41 INFO - 'tests': ['tsvgm']}}, 17:36:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:36:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:36:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:36:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:36:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:36:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:36:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:41 INFO - 'talos_options': ['--e10s'], 17:36:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:41 INFO - 'tests': ['damp', 'tps']}, 17:36:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:41 INFO - 'talos_options': ['--e10s'], 17:36:41 INFO - 'tests': ['damp', 'tps']}, 17:36:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:36:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:36:41 INFO - 'other': {'tests': ['a11yr', 17:36:41 INFO - 'ts_paint', 17:36:41 INFO - 'tpaint', 17:36:41 INFO - 'sessionrestore', 17:36:41 INFO - 'sessionrestore_no_auto_restore', 17:36:41 INFO - 'tabpaint']}, 17:36:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:36:41 INFO - 'tests': ['a11yr', 17:36:41 INFO - 'ts_paint', 17:36:41 INFO - 'tpaint', 17:36:41 INFO - 'sessionrestore', 17:36:41 INFO - 'sessionrestore_no_auto_restore', 17:36:41 INFO - 'tabpaint']}, 17:36:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:36:41 INFO - 'tests': ['a11yr', 17:36:41 INFO - 'ts_paint', 17:36:41 INFO - 'tpaint', 17:36:41 INFO - 'sessionrestore', 17:36:41 INFO - 'sessionrestore_no_auto_restore', 17:36:41 INFO - 'tabpaint']}, 17:36:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:36:41 INFO - 'tests': ['a11yr', 17:36:41 INFO - 'ts_paint', 17:36:41 INFO - 'tpaint', 17:36:41 INFO - 'sessionrestore', 17:36:41 INFO - 'sessionrestore_no_auto_restore', 17:36:41 INFO - 'tabpaint']}, 17:36:41 INFO - 'other_l64': {'tests': ['a11yr', 17:36:41 INFO - 'ts_paint', 17:36:41 INFO - 'tpaint', 17:36:41 INFO - 'sessionrestore', 17:36:41 INFO - 'sessionrestore_no_auto_restore', 17:36:41 INFO - 'tabpaint']}, 17:36:41 INFO - 'other_nol64': {'tests': ['a11yr', 17:36:41 INFO - 'ts_paint', 17:36:41 INFO - 'tpaint', 17:36:41 INFO - 'sessionrestore', 17:36:41 INFO - 'sessionrestore_no_auto_restore', 17:36:41 INFO - 'tabpaint']}, 17:36:41 INFO - 'svgr': {'tests': ['tsvgx', 17:36:41 INFO - 'tsvgr_opacity', 17:36:41 INFO - 'tart', 17:36:41 INFO - 'tscrollx', 17:36:41 INFO - 'cart']}, 17:36:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:36:41 INFO - 'tests': ['tsvgx', 17:36:41 INFO - 'tsvgr_opacity', 17:36:41 INFO - 'tart', 17:36:41 INFO - 'tscrollx', 17:36:41 INFO - 'cart']}, 17:36:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:41 INFO - 'tests': ['tp5o']}, 17:36:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:41 INFO - 'talos_options': ['--e10s'], 17:36:41 INFO - 'tests': ['tp5o']}, 17:36:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:41 INFO - 'talos_options': ['--xperf_path', 17:36:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:41 INFO - 'tests': ['tp5n']}, 17:36:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:41 INFO - 'talos_options': ['--e10s', 17:36:41 INFO - '--xperf_path', 17:36:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:41 INFO - 'tests': ['tp5n']}}, 17:36:41 INFO - 'talos.zip': {'path': '', 17:36:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:36:41 INFO - Running post-action listener: _resource_record_post_action 17:36:41 INFO - ##### 17:36:41 INFO - ##### Running create-virtualenv step. 17:36:41 INFO - ##### 17:36:41 INFO - Running pre-action listener: _resource_record_pre_action 17:36:41 INFO - Running main action method: create_virtualenv 17:36:41 INFO - Creating virtualenv /builds/slave/test/build/venv 17:36:41 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:36:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:36:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:36:41 INFO - Using real prefix '/usr' 17:36:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:36:41 INFO - Installing distribute.............................................................................................................................................................................................done. 17:36:43 INFO - Installing pip.................done. 17:36:43 INFO - Return code: 0 17:36:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b884baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184f160>, '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 0x1850060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18504f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', '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:36:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:36:43 INFO - Using env: {'DISPLAY': ':0', 17:36:43 INFO - 'HOME': '/home/cltbld', 17:36:43 INFO - 'LANG': 'en_US.UTF-8', 17:36:43 INFO - 'LANGUAGE': 'en_US:en', 17:36:43 INFO - 'LOGNAME': 'cltbld', 17:36:43 INFO - 'MAIL': '/var/mail/cltbld', 17:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:43 INFO - 'MOZ_NO_REMOTE': '1', 17:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:43 INFO - 'NO_EM_RESTART': '1', 17:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:43 INFO - 'PWD': '/builds/slave/test', 17:36:43 INFO - 'SHELL': '/bin/bash', 17:36:43 INFO - 'SHLVL': '1', 17:36:43 INFO - 'TERM': 'linux', 17:36:43 INFO - 'TMOUT': '86400', 17:36:43 INFO - 'USER': 'cltbld', 17:36:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', 17:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:43 INFO - '_': '/tools/buildbot/bin/python'} 17:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:36:43 INFO - Cleaning up... 17:36:43 INFO - Return code: 0 17:36:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b884baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184f160>, '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 0x1850060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18504f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', '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:36:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:36:43 INFO - Using env: {'DISPLAY': ':0', 17:36:43 INFO - 'HOME': '/home/cltbld', 17:36:43 INFO - 'LANG': 'en_US.UTF-8', 17:36:43 INFO - 'LANGUAGE': 'en_US:en', 17:36:43 INFO - 'LOGNAME': 'cltbld', 17:36:43 INFO - 'MAIL': '/var/mail/cltbld', 17:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:43 INFO - 'MOZ_NO_REMOTE': '1', 17:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:43 INFO - 'NO_EM_RESTART': '1', 17:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:43 INFO - 'PWD': '/builds/slave/test', 17:36:43 INFO - 'SHELL': '/bin/bash', 17:36:43 INFO - 'SHLVL': '1', 17:36:43 INFO - 'TERM': 'linux', 17:36:43 INFO - 'TMOUT': '86400', 17:36:43 INFO - 'USER': 'cltbld', 17:36:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', 17:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:43 INFO - '_': '/tools/buildbot/bin/python'} 17:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:44 INFO - Downloading/unpacking psutil>=0.7.1 17:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:36:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:46 INFO - Installing collected packages: psutil 17:36:46 INFO - Running setup.py install for psutil 17:36:46 INFO - building 'psutil._psutil_linux' extension 17:36:46 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:36:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:36:46 INFO - building 'psutil._psutil_posix' extension 17:36:46 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:36:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:36:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:46 INFO - Successfully installed psutil 17:36:46 INFO - Cleaning up... 17:36:46 INFO - Return code: 0 17:36:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b884baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184f160>, '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 0x1850060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18504f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', '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:36:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:36:46 INFO - Using env: {'DISPLAY': ':0', 17:36:46 INFO - 'HOME': '/home/cltbld', 17:36:46 INFO - 'LANG': 'en_US.UTF-8', 17:36:46 INFO - 'LANGUAGE': 'en_US:en', 17:36:46 INFO - 'LOGNAME': 'cltbld', 17:36:46 INFO - 'MAIL': '/var/mail/cltbld', 17:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:46 INFO - 'MOZ_NO_REMOTE': '1', 17:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:46 INFO - 'NO_EM_RESTART': '1', 17:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:46 INFO - 'PWD': '/builds/slave/test', 17:36:46 INFO - 'SHELL': '/bin/bash', 17:36:46 INFO - 'SHLVL': '1', 17:36:46 INFO - 'TERM': 'linux', 17:36:46 INFO - 'TMOUT': '86400', 17:36:46 INFO - 'USER': 'cltbld', 17:36:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', 17:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:46 INFO - '_': '/tools/buildbot/bin/python'} 17:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:36:48 INFO - Installing collected packages: mozsystemmonitor 17:36:48 INFO - Running setup.py install for mozsystemmonitor 17:36:48 INFO - Successfully installed mozsystemmonitor 17:36:48 INFO - Cleaning up... 17:36:48 INFO - Return code: 0 17:36:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:36: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:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b884baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184f160>, '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 0x1850060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18504f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', '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:36:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:36:48 INFO - Using env: {'DISPLAY': ':0', 17:36:48 INFO - 'HOME': '/home/cltbld', 17:36:48 INFO - 'LANG': 'en_US.UTF-8', 17:36:48 INFO - 'LANGUAGE': 'en_US:en', 17:36:48 INFO - 'LOGNAME': 'cltbld', 17:36:48 INFO - 'MAIL': '/var/mail/cltbld', 17:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:48 INFO - 'MOZ_NO_REMOTE': '1', 17:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:48 INFO - 'NO_EM_RESTART': '1', 17:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:48 INFO - 'PWD': '/builds/slave/test', 17:36:48 INFO - 'SHELL': '/bin/bash', 17:36:48 INFO - 'SHLVL': '1', 17:36:48 INFO - 'TERM': 'linux', 17:36:48 INFO - 'TMOUT': '86400', 17:36:48 INFO - 'USER': 'cltbld', 17:36:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', 17:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:48 INFO - '_': '/tools/buildbot/bin/python'} 17:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:49 INFO - Downloading/unpacking blobuploader==1.2.4 17:36:49 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:36:49 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:36:49 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:36:49 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:36:49 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:36:49 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:36:51 INFO - Downloading blobuploader-1.2.4.tar.gz 17:36:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:36:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:36:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:51 INFO - Downloading docopt-0.6.1.tar.gz 17:36:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:36:51 INFO - Installing collected packages: blobuploader, requests, docopt 17:36:51 INFO - Running setup.py install for blobuploader 17:36:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:36:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:36:51 INFO - Running setup.py install for requests 17:36:52 INFO - Running setup.py install for docopt 17:36:52 INFO - Successfully installed blobuploader requests docopt 17:36:52 INFO - Cleaning up... 17:36:52 INFO - Return code: 0 17:36:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:52 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:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:52 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:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:52 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 0x7f3b884baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184f160>, '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 0x1850060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18504f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', '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:36:52 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:36:52 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:36:52 INFO - Using env: {'DISPLAY': ':0', 17:36:52 INFO - 'HOME': '/home/cltbld', 17:36:52 INFO - 'LANG': 'en_US.UTF-8', 17:36:52 INFO - 'LANGUAGE': 'en_US:en', 17:36:52 INFO - 'LOGNAME': 'cltbld', 17:36:52 INFO - 'MAIL': '/var/mail/cltbld', 17:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:52 INFO - 'MOZ_NO_REMOTE': '1', 17:36:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:52 INFO - 'NO_EM_RESTART': '1', 17:36:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:52 INFO - 'PWD': '/builds/slave/test', 17:36:52 INFO - 'SHELL': '/bin/bash', 17:36:52 INFO - 'SHLVL': '1', 17:36:52 INFO - 'TERM': 'linux', 17:36:52 INFO - 'TMOUT': '86400', 17:36:52 INFO - 'USER': 'cltbld', 17:36:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', 17:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:52 INFO - '_': '/tools/buildbot/bin/python'} 17:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:36:52 INFO - Running setup.py (path:/tmp/pip-n5RAg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:36:52 INFO - Running setup.py (path:/tmp/pip-Bk91Lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:36:52 INFO - Running setup.py (path:/tmp/pip-w_GUEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:36:52 INFO - Running setup.py (path:/tmp/pip-bca4fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:36:52 INFO - Running setup.py (path:/tmp/pip-Vmi_jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:36:53 INFO - Running setup.py (path:/tmp/pip-IXf7Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:36:53 INFO - Running setup.py (path:/tmp/pip-_xHoCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:36:53 INFO - Running setup.py (path:/tmp/pip-GtGlXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:36:53 INFO - Running setup.py (path:/tmp/pip-HxyUIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:36:53 INFO - Running setup.py (path:/tmp/pip-XaEyIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:36:53 INFO - Running setup.py (path:/tmp/pip-_5azHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:36:53 INFO - Running setup.py (path:/tmp/pip-Qx1S_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:36:53 INFO - Running setup.py (path:/tmp/pip-tUZoWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:36:53 INFO - Running setup.py (path:/tmp/pip-efOfYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:53 INFO - Running setup.py (path:/tmp/pip-btc14S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:36:53 INFO - Running setup.py (path:/tmp/pip-ZI4JzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:36:53 INFO - Running setup.py (path:/tmp/pip-PWPaEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:36:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:36:53 INFO - Running setup.py install for manifestparser 17:36:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:36:53 INFO - Running setup.py install for mozcrash 17:36:54 INFO - Running setup.py install for mozdebug 17:36:54 INFO - Running setup.py install for mozdevice 17:36:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:36:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:36:54 INFO - Running setup.py install for mozfile 17:36:54 INFO - Running setup.py install for mozhttpd 17:36:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:36:54 INFO - Running setup.py install for mozinfo 17:36:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:36:54 INFO - Running setup.py install for mozInstall 17:36:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:36:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:36:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:36:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:36:54 INFO - Running setup.py install for mozleak 17:36:54 INFO - Running setup.py install for mozlog 17:36:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:36:54 INFO - Running setup.py install for moznetwork 17:36:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:36:54 INFO - Running setup.py install for mozprocess 17:36:55 INFO - Running setup.py install for mozprofile 17:36:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:36:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:36:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:36:55 INFO - Running setup.py install for mozrunner 17:36:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:36:55 INFO - Running setup.py install for mozscreenshot 17:36:55 INFO - Running setup.py install for moztest 17:36:55 INFO - Running setup.py install for mozversion 17:36:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:36:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:36:55 INFO - Cleaning up... 17:36:55 INFO - Return code: 0 17:36:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b884baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184f160>, '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 0x1850060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18504f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', '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:36:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:36:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:36:55 INFO - Using env: {'DISPLAY': ':0', 17:36:55 INFO - 'HOME': '/home/cltbld', 17:36:55 INFO - 'LANG': 'en_US.UTF-8', 17:36:55 INFO - 'LANGUAGE': 'en_US:en', 17:36:55 INFO - 'LOGNAME': 'cltbld', 17:36:55 INFO - 'MAIL': '/var/mail/cltbld', 17:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:55 INFO - 'MOZ_NO_REMOTE': '1', 17:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:55 INFO - 'NO_EM_RESTART': '1', 17:36:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:55 INFO - 'PWD': '/builds/slave/test', 17:36:55 INFO - 'SHELL': '/bin/bash', 17:36:55 INFO - 'SHLVL': '1', 17:36:55 INFO - 'TERM': 'linux', 17:36:55 INFO - 'TMOUT': '86400', 17:36:55 INFO - 'USER': 'cltbld', 17:36:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', 17:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:55 INFO - '_': '/tools/buildbot/bin/python'} 17:36:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:36:55 INFO - Running setup.py (path:/tmp/pip-Jqj4K3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:36:55 INFO - Running setup.py (path:/tmp/pip-Lx81dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:36:55 INFO - Running setup.py (path:/tmp/pip-cltIju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:36:56 INFO - Running setup.py (path:/tmp/pip-ddDb2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:36:56 INFO - Running setup.py (path:/tmp/pip-JJNXkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:36:56 INFO - Running setup.py (path:/tmp/pip-JTb7vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:36:56 INFO - Running setup.py (path:/tmp/pip-CkfWAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:36:56 INFO - Running setup.py (path:/tmp/pip-1xWsxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:36:56 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:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:36:56 INFO - Running setup.py (path:/tmp/pip-HceocE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:36:56 INFO - Running setup.py (path:/tmp/pip-g5wfNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:36:56 INFO - Running setup.py (path:/tmp/pip-0SrAzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:36:56 INFO - Running setup.py (path:/tmp/pip-TX_8cA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:36:56 INFO - Running setup.py (path:/tmp/pip-RFLu3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:36:56 INFO - Running setup.py (path:/tmp/pip-W5oItC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:56 INFO - Running setup.py (path:/tmp/pip-lYLqP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:36:56 INFO - Running setup.py (path:/tmp/pip-NH4ZUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:36:57 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:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:36:57 INFO - Running setup.py (path:/tmp/pip-AfNvUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:58 INFO - Downloading blessings-1.6.tar.gz 17:36:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:36:59 INFO - Installing collected packages: blessings 17:36:59 INFO - Running setup.py install for blessings 17:36:59 INFO - Successfully installed blessings 17:36:59 INFO - Cleaning up... 17:36:59 INFO - Return code: 0 17:36:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:36:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:36:59 INFO - Reading from file tmpfile_stdout 17:36:59 INFO - Current package versions: 17:36:59 INFO - argparse == 1.2.1 17:36:59 INFO - blessings == 1.6 17:36:59 INFO - blobuploader == 1.2.4 17:36:59 INFO - docopt == 0.6.1 17:36:59 INFO - manifestparser == 1.1 17:36:59 INFO - mozInstall == 1.12 17:36:59 INFO - mozcrash == 0.17 17:36:59 INFO - mozdebug == 0.1 17:36:59 INFO - mozdevice == 0.48 17:36:59 INFO - mozfile == 1.2 17:36:59 INFO - mozhttpd == 0.7 17:36:59 INFO - mozinfo == 0.9 17:36:59 INFO - mozleak == 0.1 17:36:59 INFO - mozlog == 3.1 17:36:59 INFO - moznetwork == 0.27 17:36:59 INFO - mozprocess == 0.22 17:36:59 INFO - mozprofile == 0.28 17:36:59 INFO - mozrunner == 6.11 17:36:59 INFO - mozscreenshot == 0.1 17:36:59 INFO - mozsystemmonitor == 0.0 17:36:59 INFO - moztest == 0.7 17:36:59 INFO - mozversion == 1.4 17:36:59 INFO - psutil == 3.1.1 17:36:59 INFO - requests == 1.2.3 17:36:59 INFO - wsgiref == 0.1.2 17:36:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b884baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184f160>, '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 0x1850060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18504f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', '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:36:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:36:59 INFO - Using env: {'DISPLAY': ':0', 17:36:59 INFO - 'HOME': '/home/cltbld', 17:36:59 INFO - 'LANG': 'en_US.UTF-8', 17:36:59 INFO - 'LANGUAGE': 'en_US:en', 17:36:59 INFO - 'LOGNAME': 'cltbld', 17:36:59 INFO - 'MAIL': '/var/mail/cltbld', 17:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:59 INFO - 'MOZ_NO_REMOTE': '1', 17:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:59 INFO - 'NO_EM_RESTART': '1', 17:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:59 INFO - 'PWD': '/builds/slave/test', 17:36:59 INFO - 'SHELL': '/bin/bash', 17:36:59 INFO - 'SHLVL': '1', 17:36:59 INFO - 'TERM': 'linux', 17:36:59 INFO - 'TMOUT': '86400', 17:36:59 INFO - 'USER': 'cltbld', 17:36:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', 17:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:59 INFO - '_': '/tools/buildbot/bin/python'} 17:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:36:59 INFO - Cleaning up... 17:36:59 INFO - Return code: 0 17:36:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b884baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184f160>, '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 0x1850060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18504f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', '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:36:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:36:59 INFO - Using env: {'DISPLAY': ':0', 17:36:59 INFO - 'HOME': '/home/cltbld', 17:36:59 INFO - 'LANG': 'en_US.UTF-8', 17:36:59 INFO - 'LANGUAGE': 'en_US:en', 17:36:59 INFO - 'LOGNAME': 'cltbld', 17:36:59 INFO - 'MAIL': '/var/mail/cltbld', 17:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:59 INFO - 'MOZ_NO_REMOTE': '1', 17:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:59 INFO - 'NO_EM_RESTART': '1', 17:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:59 INFO - 'PWD': '/builds/slave/test', 17:36:59 INFO - 'SHELL': '/bin/bash', 17:36:59 INFO - 'SHLVL': '1', 17:36:59 INFO - 'TERM': 'linux', 17:36:59 INFO - 'TMOUT': '86400', 17:36:59 INFO - 'USER': 'cltbld', 17:36:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', 17:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:59 INFO - '_': '/tools/buildbot/bin/python'} 17:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:59 INFO - Downloading/unpacking jsonschema 17:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:37:01 INFO - Downloading/unpacking functools32 (from jsonschema) 17:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:01 INFO - Downloading functools32-3.2.3-2.tar.gz 17:37:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:37:02 INFO - warning: no files found matching '*.txt' 17:37:02 INFO - no previously-included directories found matching 'build' 17:37:02 INFO - no previously-included directories found matching 'dist' 17:37:02 INFO - no previously-included directories found matching '.git*' 17:37:02 INFO - Installing collected packages: jsonschema, functools32 17:37:02 INFO - Running setup.py install for functools32 17:37:02 INFO - warning: no files found matching '*.txt' 17:37:02 INFO - no previously-included directories found matching 'build' 17:37:02 INFO - no previously-included directories found matching 'dist' 17:37:02 INFO - no previously-included directories found matching '.git*' 17:37:02 INFO - Successfully installed jsonschema functools32 17:37:02 INFO - Cleaning up... 17:37:02 INFO - Return code: 0 17:37:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:37: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:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37: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:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:02 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 0x7f3b884baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184f160>, '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 0x1850060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18504f0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', '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:37:02 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:37:02 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:37:02 INFO - Using env: {'DISPLAY': ':0', 17:37:02 INFO - 'HOME': '/home/cltbld', 17:37:02 INFO - 'LANG': 'en_US.UTF-8', 17:37:02 INFO - 'LANGUAGE': 'en_US:en', 17:37:02 INFO - 'LOGNAME': 'cltbld', 17:37:02 INFO - 'MAIL': '/var/mail/cltbld', 17:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:02 INFO - 'MOZ_NO_REMOTE': '1', 17:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:02 INFO - 'NO_EM_RESTART': '1', 17:37:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:02 INFO - 'PWD': '/builds/slave/test', 17:37:02 INFO - 'SHELL': '/bin/bash', 17:37:02 INFO - 'SHLVL': '1', 17:37:02 INFO - 'TERM': 'linux', 17:37:02 INFO - 'TMOUT': '86400', 17:37:02 INFO - 'USER': 'cltbld', 17:37:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', 17:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:02 INFO - '_': '/tools/buildbot/bin/python'} 17:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:02 INFO - Downloading/unpacking flake8 17:37:02 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:37:02 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:37:02 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:37:02 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:37:02 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:37:02 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:37:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:37:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:37:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:37:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:37:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:37:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:37:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:37:04 INFO - no previously-included directories found matching 'docs/_build' 17:37:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:37:05 INFO - Running setup.py install for pep8 17:37:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:37:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:37:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:37:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:37:05 INFO - no previously-included directories found matching 'docs/_build' 17:37:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:37:05 INFO - Cleaning up... 17:37:05 INFO - Return code: 0 17:37:05 INFO - Running post-action listener: _resource_record_post_action 17:37:05 INFO - Running post-action listener: _start_resource_monitoring 17:37:05 INFO - Starting resource monitoring. 17:37:05 INFO - ##### 17:37:05 INFO - ##### Running install step. 17:37:05 INFO - ##### 17:37:05 INFO - Running pre-action listener: _resource_record_pre_action 17:37:05 INFO - Running main action method: install 17:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:37:05 INFO - Reading from file tmpfile_stdout 17:37:05 INFO - Detecting whether we're running mozinstall >=1.0... 17:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:37:05 INFO - Reading from file tmpfile_stdout 17:37:05 INFO - Output received: 17:37:05 INFO - Usage: mozinstall [options] installer 17:37:05 INFO - Options: 17:37:05 INFO - -h, --help show this help message and exit 17:37:05 INFO - -d DEST, --destination=DEST 17:37:05 INFO - Directory to install application into. [default: 17:37:05 INFO - "/builds/slave/test"] 17:37:05 INFO - --app=APP Application being installed. [default: firefox] 17:37:05 INFO - mkdir: /builds/slave/test/build/application 17:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:37:20 INFO - Reading from file tmpfile_stdout 17:37:20 INFO - Output received: 17:37:20 INFO - /builds/slave/test/build/application/firefox/firefox 17:37:20 INFO - Running post-action listener: _resource_record_post_action 17:37:20 INFO - ##### 17:37:20 INFO - ##### Running run-tests step. 17:37:20 INFO - ##### 17:37:20 INFO - Running pre-action listener: _resource_record_pre_action 17:37:20 INFO - Running main action method: run_tests 17:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:37:20 INFO - Python 2.7.3 17:37:20 INFO - Return code: 0 17:37:20 INFO - grabbing minidump binary from tooltool 17:37:20 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:37:20 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 0x184f160>, '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 0x1850060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18504f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:37:20 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:37:20 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:37:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:37:20 INFO - Return code: 0 17:37:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:37:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:37:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:37:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:37:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:37:21 INFO - Return code: 0 17:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:37:21 INFO - Using env: {'DISPLAY': ':0', 17:37:21 INFO - 'HOME': '/home/cltbld', 17:37:21 INFO - 'LANG': 'en_US.UTF-8', 17:37:21 INFO - 'LANGUAGE': 'en_US:en', 17:37:21 INFO - 'LOGNAME': 'cltbld', 17:37:21 INFO - 'MAIL': '/var/mail/cltbld', 17:37:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:37:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:21 INFO - 'MOZ_NO_REMOTE': '1', 17:37:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:21 INFO - 'NO_EM_RESTART': '1', 17:37:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:21 INFO - 'PWD': '/builds/slave/test', 17:37:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:37:21 INFO - 'SHELL': '/bin/bash', 17:37:21 INFO - 'SHLVL': '1', 17:37:21 INFO - 'TERM': 'linux', 17:37:21 INFO - 'TMOUT': '86400', 17:37:21 INFO - 'USER': 'cltbld', 17:37:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561', 17:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:21 INFO - '_': '/tools/buildbot/bin/python'} 17:37:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:37:22 INFO - mozversion application_buildid: 20160415150621 17:37:22 INFO - mozversion application_changeset: aca518830db248be63b2e879d12bfb899fc39ec1 17:37:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:37:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:37:22 INFO - mozversion application_name: Firefox 17:37:22 INFO - mozversion application_remotingname: firefox-dev 17:37:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:37:22 INFO - mozversion application_vendor: Mozilla 17:37:22 INFO - mozversion application_version: 47.0a2 17:37:22 INFO - mozversion platform_buildid: 20160415150621 17:37:22 INFO - mozversion platform_changeset: aca518830db248be63b2e879d12bfb899fc39ec1 17:37:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:37:22 INFO - mozversion platform_version: 47.0a2 17:37:22 INFO - using testdate: 1460767042 17:37:22 INFO - actual date: 1460767042 17:37:22 INFO - starting webserver on 'localhost:50027' 17:37:22 INFO - SUITE-START | Running 2 tests 17:37:22 INFO - TEST-START | dromaeo_css 17:37:22 INFO - operating with platform_type : linux_ 17:37:22 INFO - Initialising browser for dromaeo_css test... 17:37:22 INFO - TEST-INFO | started process 6789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzX6yKP/profile http://localhost:50027/getInfo.html) 17:37:25 INFO - PROCESS | 6789 | __metrics Screen width/height:1600/1200 17:37:25 INFO - PROCESS | 6789 | colorDepth:24 17:37:25 INFO - PROCESS | 6789 | Browser inner width/height: 1024/697 17:37:25 INFO - PROCESS | 6789 | __metrics 17:37:27 INFO - PROCESS | 6789 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:37:28 INFO - TEST-INFO | 6789: exit 0 17:37:28 INFO - Browser initialized. 17:37:28 INFO - Running cycle 1/1 for dromaeo_css test... 17:37:28 INFO - TEST-INFO | started process 6879 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzX6yKP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:39 INFO - PROCESS | 6879 | RSS: Main: 140976128 17:37:39 INFO - PROCESS | 6879 | 17:38:31 INFO - PROCESS | 6879 | 1460767111267 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:40:38 INFO - PROCESS | 6879 | Cycle 1(1): loaded http://localhost:50027/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50027/tests/dromaeo/cssquery-ext.html) 17:40:39 INFO - PROCESS | 6879 | RSS: Main: 292401152 17:40:39 INFO - PROCESS | 6879 | 17:43:41 INFO - PROCESS | 6879 | Cycle 1(1): loaded http://localhost:50027/tests/dromaeo/cssquery-ext.html (next: http://localhost:50027/tests/dromaeo/cssquery-jquery.html) 17:43:42 INFO - PROCESS | 6879 | RSS: Main: 226979840 17:43:42 INFO - PROCESS | 6879 | 17:46:44 INFO - PROCESS | 6879 | Cycle 1(1): loaded http://localhost:50027/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50027/tests/dromaeo/cssquery-mootools.html) 17:46:44 INFO - PROCESS | 6879 | RSS: Main: 234635264 17:46:44 INFO - PROCESS | 6879 | 17:49:46 INFO - PROCESS | 6879 | Cycle 1(1): loaded http://localhost:50027/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50027/tests/dromaeo/cssquery-prototype.html) 17:49:47 INFO - PROCESS | 6879 | RSS: Main: 196169728 17:49:47 INFO - PROCESS | 6879 | 17:52:49 INFO - PROCESS | 6879 | Cycle 1(1): loaded http://localhost:50027/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50027/tests/dromaeo/cssquery-yui.html) 17:52:50 INFO - PROCESS | 6879 | RSS: Main: 213020672 17:52:50 INFO - PROCESS | 6879 | 17:55:52 INFO - PROCESS | 6879 | Cycle 1(1): loaded http://localhost:50027/tests/dromaeo/cssquery-yui.html (next: http://localhost:50027/tests/dromaeo/cssquery-dojo.html) 17:55:52 INFO - PROCESS | 6879 | RSS: Main: 262434816 17:55:52 INFO - PROCESS | 6879 | 17:55:52 INFO - PROCESS | 6879 | __start_tp_report 17:55:52 INFO - PROCESS | 6879 | _x_x_mozilla_page_load 17:55:52 INFO - PROCESS | 6879 | _x_x_mozilla_page_load_details 17:55:52 INFO - PROCESS | 6879 | |i|pagename|runs| 17:55:52 INFO - PROCESS | 6879 | |0;dojo.html;3289.3750187464384;3338.933221335572;3355.6308806031334;3362.61329947056;3383.171123074847;5313.362396512419;5314.973425132874;5345.786168553258;5348.117560602496;5385.649932754368;5353;5377.462253774621;5379.139337705968;5390.460953904608;5390.973045134779;4717.245240761479;4917;4919.729414882189;4957.702537847741;4992.850214493553;4806.182948898696;4881.267809828536;4897.8040878365;4899.8040078396825;4903.779329930162;4936.259561065833;4995.425526064513;4996.1756310208775;4996.25056241563;5004.424491183524;4823.493533179001;4927.384076990376;4973.975130124344;4979.576735977446;4993.0263598598285;4774.618030557547;4897;4917.901641967141;4944.9258261126115;4949.975250123763;5116.795328186868;5193.402758682762;5213.244079608474;5213.2701421800975;5242.5281724644965;5772.220750198753;5790.739416726257;5792.913106303409;5793.275840519935;5799.18811366409;5631.915521267184;5723.627964182315;5804.2744656917885;5823.56323275756;5842.036064049426;5419.295491586147;5420.105682562373;5420.593455490814;5426.294581704393;5452.263944367499;5901.439363260483;5903.675297858659;5905.734241959036;5913.319968203626;5936.525077993837;5485.067538518461;5616.326040875121;5701.914471282934;5703.144528320702;5705.258316418839;5778.6821724804695;5786.07422812348;5787.276590426197;5794.304683438015;5797.043487824461;5751.4536119068625;5773.480386765212;5782.306123265235;5787.884242315215;5791.739371728282;5598.748056337475;5664.6601203927075;5764.221830052889;5765.279340082489;5771.105478650816;4465.419495465569;4467.352233926063;4469.2849144137435;4469.754163521037;4491.663125265618;4007.2586571484367;4014.7390419623216;4016.6184212499766;4055.878323650295;4062.878113656595;5412.377576578744;5514.255575497336;5560.471755183251;5609.887802243932;5619.100943848965;5829.09649004405;5881.1178323251;5891.086881533369;5891.086881533369;5892.558058145571;5395.703236321961;5574.247476590689;5599.636023658449;5622.353429355595;5624.21261023457;4984.90030199394;5043.293938848564;5063.088644044107;5076.340075790197;5088.567471764942;5970.164177015221;5971.134185543072;5971.373005834324;5972.820815375546;5975.790847320323;5627.521660658726;5701.828945131652;5705.258316418839;5709.400512946081;5713.171590119409;5994.3705910878725;6018.277806663228;6023.969880150571;6029;6054.122152287981;5656.434356564475;5659.801906933402;5676.659400435987;5696.0316746154085;5696.943030569641;5717.42825717425;5730.226419433323;5751.798687045934;5763.394843541368;5842.298924129132;5680.6591604503865;5682.147677848356;5683.943160568341;5686.402927692533;5688.203651488878;5659.971700141473;5668.688222147656;5668.829935101953;5671.688057156896;5673.149027645886;5369.5167434931045;5447.618666693294;5554.1946417770005;5566.805161819317;5618.887622247614;5519.834404967857;5558.166275058774;5585.636933599303;5592.105263157875;5722.542196624343;5447.319085114361;5479.643823151482;5497.422770609029;5540.501354877919;5544.556435485232 17:55:52 INFO - PROCESS | 6879 | |1;ext.html;545.6098889294155;562.9183768353588;563.6111083352487;584.3221862639334;589.8024161905761;30233;30780.230494237654;38565.614343856556;38988;39029.804850975706;42640.36039459411;43038;43195.3520697189;43208.56791432085;43264.35103473443;8859.246964008067;9085.409448385866;9092.59083341248;9093.136152065543;9097.499637519933;8859.822803543926;8948.373613847034;8985.640574377017;8997.100289970984;9016.143466370684;9212.078792120801;9296.488693121875;9301.255899528021;9304.720858374225;9307.395019323721;9117.772055698595;9195.172434480863;9199.172074513259;9201.677941272057;9203.907960920373;9105.726828195166;9249.676261330822;9270.814583708288;9270.90729092714;9280.95359523198;44489.55510444919;45028.3245751314;45031.549684503065;45039.32441013387;45093.774531127136;3199.1842080269616;3378.45944648855;3488.3023395320783;3865.6714179294795;3867.168558759852;32344;32886.6711332886;33042.33915321704;33046.33907321864;34142;4281.507626622947;4303.0963497665525;4327.307630779092;4339.327404252346;4340.457442819647;294225;295566;295642;296505;297469.12654367194;45003.32495012512;46132;63152.68423657852;63271;63604;45212;45326.54673453223;45424.09151816945;45511.317330240076;45561;15325.616859578377;15460.458883939009;15463.226838658022;15493;15510.767338489932;12140.150189486827;12149.635510934686;12190.81713774294;12196.695082622828;12203.877961220453;15782.763258551131;15881.126538040287;15891.364345426286;15907.602309942113;15928.203589820463;5860.769238459886;5917.260342457193;5927.585069045212;5963.197297270276;6152.600080994811;1052.4737631184407;1081.1026847716375;1081.1350919264714;1108.3903852880883;1132.592266783957;29389.559156612668;29420;30045.69954300473;30326;30332.54501182484;1073.6295977887617;1085.733995171188;1105.8120119579692;1196.670915498245;1197.9278545701548;14610.415583376545;14671.92664036673;14727.852721472862;15051.698966020618;15153.62115947088;342147;347300;347559;347649;349249;58132;59261.40738592645;59303.70348148232;59453.40546594565;59461.702691486265;1329.0762919770666;1379.0760190672274;1446.3419144289323;1470.4632809024629;1475.9335829887682;28937.42125157443;29429.411411772075;29465.55801662934;29628.703712962593;29959.400811983203;46058.76970615125;46423;46466.67666616723;46479.535204647524;46536.767316163205;227855;228545;229335;229504;230035;30171.849140754155;34626;35057.64942350646;35288.647113529565;35666.10834729153;52270.73864630653;55006.44993550013;57161.142582860455;57816;58418.707906461896;39385.01537461586;39582.20835583215;39664.80167599144;39799.80100099481;40011.399829003174;38653.806730966164;39491.80254098711;40259.79870100631;40312.19375612413;40475.59524404718;39579.01052473711;40313;40453;40532;40885.591144088175;34035.4894676585;35005.64994350024;35263.64736352706;35501.112472188404;35523.28953420969;27210.455790883676;27295;27601.447971040867;27616.585751213344;27675.689654314458 17:55:52 INFO - PROCESS | 6879 | |2;jquery.html;375.25886374410544;383.566569776153;395.4740195539932;396.7084193118059;396.9364901615742;17219.569510762223;19225.807741922577;19428;19793.208271669133;19839.10724017419;18185.454236389924;18223.17995690194;18417.53956151097;18424.723629145574;18464.261429542803;5506.779728810853;5751.4536119068625;5755.740991655385;5783;5790.102534107199;4378.496472905609;6128.20333356663;6388.073729309247;6415.422611964922;6420.967895160517;5439.700816455093;6330.240371155444;6331.936680633204;6362.745490180388;6363.777267795628;5596.888062238752;5615.971920140414;5628.71856407178;5632.662040277576;5641.464060914227;3983.960160398388;5488.094464413367;5709.571782116316;5716.228309178249;5716.857078573027;13292.26892520911;13857.930710346485;13875.37560809766;13923.58229253124;13949.651258718613;2338.5790557699606;2370.928872133839;2406.6750988616486;2434.0993832281993;2447.9265622031367;10347.32742371751;10394.844077338847;10732.946335268352;11905.226160299639;14352.784708229385;1866.2908094923978;1978.6339527187517;1985.6822908334598;2011.6580181369056;2058.87646741196;63403.68298158526;66960.33039669639;68252.31747682509;69283.30716692819;69685;10504.684859454228;10592.576296948037;10704.518296676668;10744.838827417596;10824.783504330027;15032.924835375972;15053.548393548212;15082.924585377223;15093.849061509463;15098.54704358871;7760.18518055596;7867.252611001945;7954.363650907913;7995.720149794729;8029.3175080118845;7199.280071992864;7292.19785823559;7299.124105107421;7454.366378857858;7743.070831500143;4646.721196728207;4749.572538471554;4778.92116929137;4782.402199725035;4796.2805579163405;1636.9017858928503;1833.8349548540696;1917.6001518891287;1949.9220031198877;1965.7837637859825;840.684743221292;919.793046564531;952.3143336797494;963.5086106085946;996.342414006752;15853.286602102702;16070.276837542338;16288.755668664979;16602.50192494227;16821;913.8126684029758;914.1772404835568;921.3918813583138;949.7862980829258;1015.6952914125881;9401;9713.66002189934;9723.270754693285;9726.610935562498;9913.702588922344;457110;465281;477375;505253;512729;74729.62635186789;80026;80602.19397805947;81004;81692;1097.4183682648209;1106.0377471599759;1112.6495154026618;1121.0191082802548;1129.711923459529;14747.631309217355;14978.1013139212;15021.474248401253;15118.274755615515;15265.160416176772;32663.18342041468;33111.668883311824;33802;34043.489347659306;34079.82960085184;50071.99856002932;51397.22904156515;52153.7392313036;52243;53289;8152.225538573826;8177.9591102044105;8265.710700125466;8290.06257872131;8341.290990265896;12869;13381.330933453482;13407.530736424178;13669.726605467637;13857.237851918242;8373.665053397795;10201.775786905619;11771.882281177079;12166.20919640256;12255.938720306342;10899.564017439214;11031.669049928514;11131.220814542905;11146.386948717898;11282.830757538808;11064.723381915517;11279.154063445438;12123.818142728043;12209.938950305192;12296.323702196465;8938.352405942294;8975.685850995445;8990.100989900957;9091.272698183997;9098.454092754457;9536.284778641491;11735.530578776754;12158.392080396121;12239.816402753788;12313.384330783247 17:55:52 INFO - PROCESS | 6879 | |3;mootools.html;1473.0572433642465;1601.2314089237166;1621.9351225950963;1859.3864024871784;1951.5901660651261;8059.234372734588;8387.538685372301;8397.91602083979;8400.621972011259;8410.28512576431;8237.258646721793;8432.789180270496;8435.367347448935;8449.535275559841;8450.619722112504;2067.328118361531;2315.907363705454;2342.625179971205;2399.8800059997016;2458.963115553268;2418.022353228946;2452.5462789383932;2454.7422520635346;2467.568175569268;2468.0744720729726;2408.8313818032657;2446.633005049248;2446.9143579974702;2448.6204638281006;2451.7180524239675;2018.465106746706;2331.9533609327805;2379.702537182852;2384.213209640823;2387.045181927243;2300.907963681451;2335.8437573401106;2340.7776261255153;2340.8829558522007;2342.6837376954063;8235;8252.8349433011;8269;8295.460795048362;8295.626696798598;5170.741462926839;5264.710440925747;5278.340207474066;5324.733763311858;5324.8136315228785;3187.729043031345;3191.329820737648;3226.0644413120167;3246;3281.278118813857;1058.4125810175349;2056.5784014277037;2071.564971356017;2097.9895100524554;2111.0711287033655;11616.186866919319;11682.415879206006;11694.532218711242;11697.473613687405;11704.122190835637;4403.53762854902;4510.932336014962;4547.977260113678;4564.2240819060835;4594.793234304398;9573.712788616353;9604.615815367446;9625.374350667324;9631.951840240894;9646;4543;5174.275601415805;5176.06830770465;5210.140326846104;5223.686578805284;4497.482789479186;4553.248713962225;4596.333531637893;4599.977000115045;4613.700109492872;3676.613955534684;3705.8517659293866;3706.629337066272;3746.0822098586023;3809.142942837839;1114.8383484394717;1114.9386783726973;1117.1677100560134;1129.5594718059963;1132.1678566253797;1414.3069895751214;1415.0519152167867;1436.2603259321459;1447.254663848119;1467.9779803302958;8228.958855205685;8340.791480212922;8341.082480927093;8341.124181960928;8351.749447516584;469.3358897160548;474.64875991766536;474.6890786534825;474.87178461815114;484.4646665434714;6299.086632438362;6313.779017734358;6334.5249106317215;6357.078223657544;6408.871822563523;10052.396856188652;10305.948470257601;10314.48427578618;10397.532111055021;10421.791564168674;9966.750831229132;10226.23303252259;10230.539625716712;10275.486225688686;10305.072543471124;8142.267195952274;8156.510609363457;8191.344692424592;8201.13888041747;8228.588570571566;7617.466777325534;7669.271419215165;7826.373890088893;7882.84234315299;7885.960570197341;9252.259819214312;9354.25165986733;9398.2951278653;9464.810703786023;9573.473458959825;9363.157315841607;9738.513074346396;9811.16605088547;9841.606335746776;9957.502124893581;6802.523823332319;7245.529040612343;7436.033315669145;7698.92301076982;7873.645685944031;8190.221928916743;8192.590370481572;8211.055728591049;8230.053543842534;8234.258916697527;7141.928580714334;7464.738734144279;7473.551586904586;7592.696292148473;7595.962020189863;7154.892676609751;7160.283971602798;7205.315495027964;7226.024486694229;7258.637068146466;7645.1972542882195;7654.808629784077;7687.692492300245;7694.192109828387;7703.037120359955;6931.792046238621;7016.6842492089;7022.578645281299;7038.753643622448;7062.71749130029;7260.818479538054;7364.889526656997;7369.705211791683;7381;7386 17:55:52 INFO - PROCESS | 6879 | |4;prototype.html;362.3477740067878;366.6754921894123;366.72129181821816;367.3809630772149;377.3566069850904;5931.466168044875;5944.316403613586;5954.374790646979;5968.432998865101;6023.30731965823;5884.764609415618;5890.617109887854;5901.881962360751;5905.143754155645;5922.792702255422;4436.024074703576;4498.302763071729;4543.5002149763495;4582.037772067853;4627.583517483435;4582.19811532982;4594.632429405656;4616.376789133475;4627.3521706961055;4628.606568441686;4547.954520454803;4593.311003349491;4600.125976064537;4600.332951721998;4601.723896566216;4395.05506316142;4477.999999999984;4549.863504094882;4555.339475776027;4586.449626044896;4041.6766658667234;4069.2065047315787;4070.7761073140964;4077.4087757275324;4079.102597428561;5628.43715628438;5639.041362968264;5643.407442218549;5644.491995720405;5644.8024319148635;5362.758675859595;5363.168708850135;5364.892702145935;5370.731463426813;5374.140137578008;6258.71835767387;6274.247090349141;6277.340879207663;6279.058141278799;6292.1820163378925;4456.041950980555;4498.190325741365;4540.046590216059;4559.566841150086;4572.245579479382;6535.509836762214;6553.803385898431;6558.311377305362;6562.179727534059;6582.045603387482;4671.205894997858;4680.485146633868;4681.836135735233;4684.297355396649;4695.319178719066;4697.989932164601;4720.362751028636;4723.976380118077;4726.361941137971;4728.456227533878;5370.624056316098;5382.381026182039;5384.057789886754;5388.191771234347;5389.946100539023;6092.908606370908;6318.336574659686;6338.080978258126;6345.460635845912;6415.903761443582;1585.0885740698914;1592.7690484879627;1601.3594562175224;1606.7027599894056;1608.107500337324;993.4734590666958;1061.7080302916606;1067.146282973618;1082.2748758331936;1099.197585762398;6025.367336429699;6035.30593981689;6041.184440100618;6043.607165534227;6048.516118710492;6343.841403964845;6398.488120950313;6470.611763294218;6472.288048314682;6492.156019717407;6122.877542449126;6145.907811382833;6148.323684394713;6151.108089327023;6156.353582873823;3452.102453362144;3488.686018258318;3490.703290220309;3492.371373152806;3498.003069125287;6674.16572928384;6810.318968103249;6845.931540684529;6934.549254298455;6941.409980151642;6714.731410743613;6725.159355080615;6738.932610673831;6744.089547911068;6761.729530818712;6844.760433384808;6909.723611055602;6911.7926462205205;6911.827204319932;6919;6525.086487891604;6560.639164845979;6561.1470508833545;6568.310327415553;6585.604863708193;6255.593386429868;6457.289698133108;6463.935360646521;6476.255230648348;6481.287058423664;6851.931480685129;6881.827954301182;6900.723971041303;6903;6905.585664860125;4527.524609915911;4547.477040140294;4547.545245475426;4548.181327361107;4548.795304211252;6546.476281897341;6570;6575.079488871657;6585.407313341822;6587.2753997061245;6162.352952939877;6450.580712253689;6481.837954050998;6502.544821862424;6508.023796430573;6427;6435.324290949383;6439.549231553746;6441.67791610427;6490.935090649033;6312.810615681537;6315.021171718391;6315.5894866833505;6317.052442133533;6321.336259692666;6456.870862582816;6464.5798023128345;6467;6469.870602587827;6479.51403644738;5982.341942386421;6082.60463069899;6299.811005669837;6312.3687631238345;6318.115463834974 17:55:52 INFO - PROCESS | 6879 | |5;yui.html;804.5655346113099;804.9315808156307;821.8027673358392;822.3133683374382;900.5677274908041;13955.372008259626;14167.079139855929;14169.929150354259;14170.504032358856;14175.149491030545;13832.792508112387;13939.442422303122;13969.58091257264;13981.370838312276;13991;768.8385439057805;902.1745103230536;926.6200857648365;928.3640706116298;929.2658799548349;929.3401684803797;932.8693982842408;933.4585940154694;936.8782058332407;937.0863408177041;817.2113910076774;982.2780256511459;984.271638987148;985.2167526816198;985.5318723606266;955.5365647660878;974.0405700385115;974.1670871404917;975.2149519636689;975.229568640773;717.7667258141125;718.8957601147804;720.0351528951178;720.4452571519953;720.6000669628354;13791.379387927567;13900.16599004063;13919.443222271097;13920.095193812369;13933.790993135111;13794.65513362164;14230.28848557568;14232.857671423257;14504.782428263585;15022.549323520312;11599.594014209546;11763.117766167572;11779.7055073623;11806.173567850254;11972.341521216329;3927.0967677434064;3931.331673615464;3962.841486340543;3985.342418500944;3991.5409727881374;51632.22551661728;52195;52916.735416323056;54049.729751351384;54443.45556544424;11560;11629;11805.527778888749;12019.939900300618;12046.397680115959;19915.60168796616;20017.799822001885;20035.09842057111;20080.39758807238;20092.89953550252;8045.637946292431;8143;8164.224398682116;8318.168183181755;8633.91366086331;4759.143354196209;4859.927101093486;4862.5380588844;4934.1611925972675;4987.775550100254;3409.2670075933793;3476.3568739782713;3479.6694314040124;3499.0377646147513;3499.3176330615283;623.3392603839853;626.4236902050034;631.2204427531994;632.5129650169343;655.3610230025687;573.0315766354847;624.5628060357768;698.9405900498515;723.504399486343;727.7380143148463;9195.402298850553;9342.486163261086;9501.667441639509;9536.189423899046;9668.178204852526;653.9346065393518;655.6754406568779;735.1949615171379;736.6721808795035;751.0499218488616;4039.8788036358956;4364.388985542027;4372.868813935587;4412.33814927757;4441.933370999438;52079.47920520822;57544.71227643835;57839.42160578424;57977.13034304489;58294.4170558289;50755.23867141996;51662.48337516652;52056.47943520516;52172;52710.736446317525;46451;46525;46882.765586172536;47025.5297447028;47685.52314476811;9005.639774409212;9312.674056407994;9447.763805904908;9462.148406643435;9727.805443891224;34970.47544286888;34986.12534686653;35024.64975350214;36975.26049479049;37517.624823751416;45223.54776452325;45624.31563526616;45705;46216.909475781344;46704;11316.94341528287;11790.587329443428;11834.881651183377;11901;11915.761684766083;12827.166234194747;13062.281574513492;13094.214347139203;13187.802182967454;13464.730705386033;12736.172148810298;12843.743125137631;12993.545225917047;13029.283389413295;13215.405306761026;11820.76358472843;11989;12306.692332691755;12963.546275880677;13013;12434.440450179945;12445.25328480294;12485.75028499443;12497.18768280059;12498.43757030954;10173.643922462677;10177.92919744813;10259.384436933808;10421.218408619232;10734.785304294026;10258.980951151929;10342.224333174892;10355.94822025885;10357.17142628603;10377.636782712569 17:55:52 INFO - PROCESS | 6879 | __end_tp_report 17:55:52 INFO - PROCESS | 6879 | __start_cc_report 17:55:52 INFO - PROCESS | 6879 | _x_x_mozilla_cycle_collect,1175 17:55:52 INFO - PROCESS | 6879 | __end_cc_report 17:55:52 INFO - PROCESS | 6879 | __startTimestamp1460768152744__endTimestamp 17:55:52 INFO - PROCESS | 6879 | 17:55:52 INFO - PROCESS | 6879 | ------- Summary: start ------- 17:55:52 INFO - PROCESS | 6879 | Number of tests: 6 17:55:52 INFO - PROCESS | 6879 | 17:55:52 INFO - PROCESS | 6879 | [#0] dojo.html Cycles:165 Average:5372.86 Median:5585.64 stddev:574.46 (10.3%) stddev-sans-first:552.48 17:55:52 INFO - PROCESS | 6879 | Values: 3289.4 3338.9 3355.6 3362.6 3383.2 5313.4 5315.0 5345.8 5348.1 5385.6 5353.0 5377.5 5379.1 5390.5 5391.0 4717.2 4917.0 4919.7 4957.7 4992.9 4806.2 4881.3 4897.8 4899.8 4903.8 4936.3 4995.4 4996.2 4996.3 5004.4 4823.5 4927.4 4974.0 4979.6 4993.0 4774.6 4897.0 4917.9 4944.9 4950.0 5116.8 5193.4 5213.2 5213.3 5242.5 5772.2 5790.7 5792.9 5793.3 5799.2 5631.9 5723.6 5804.3 5823.6 5842.0 5419.3 5420.1 5420.6 5426.3 5452.3 5901.4 5903.7 5905.7 5913.3 5936.5 5485.1 5616.3 5701.9 5703.1 5705.3 5778.7 5786.1 5787.3 5794.3 5797.0 5751.5 5773.5 5782.3 5787.9 5791.7 5598.7 5664.7 5764.2 5765.3 5771.1 4465.4 4467.4 4469.3 4469.8 4491.7 4007.3 4014.7 4016.6 4055.9 4062.9 5412.4 5514.3 5560.5 5609.9 5619.1 5829.1 5881.1 5891.1 5891.1 5892.6 5395.7 5574.2 5599.6 5622.4 5624.2 4984.9 5043.3 5063.1 5076.3 5088.6 5970.2 5971.1 5971.4 5972.8 5975.8 5627.5 5701.8 5705.3 5709.4 5713.2 5994.4 6018.3 6024.0 6029.0 6054.1 5656.4 5659.8 5676.7 5696.0 5696.9 5717.4 5730.2 5751.8 5763.4 5842.3 5680.7 5682.1 5683.9 5686.4 5688.2 5660.0 5668.7 5668.8 5671.7 5673.1 5369.5 5447.6 5554.2 5566.8 5618.9 5519.8 5558.2 5585.6 5592.1 5722.5 5447.3 5479.6 5497.4 5540.5 5544.6 17:55:52 INFO - PROCESS | 6879 | 17:55:52 INFO - PROCESS | 6879 | [#1] ext.html Cycles:180 Average:46936.45 Median:39207.41 stddev:77022.14 (196.4%) stddev-sans-first:77159.44 17:55:52 INFO - PROCESS | 6879 | Values: 545.6 562.9 563.6 584.3 589.8 30233.0 30780.2 38565.6 38988.0 39029.8 42640.4 43038.0 43195.4 43208.6 43264.4 8859.2 9085.4 9092.6 9093.1 9097.5 8859.8 8948.4 8985.6 8997.1 9016.1 9212.1 9296.5 9301.3 9304.7 9307.4 9117.8 9195.2 9199.2 9201.7 9203.9 9105.7 9249.7 9270.8 9270.9 9281.0 44489.6 45028.3 45031.5 45039.3 45093.8 3199.2 3378.5 3488.3 3865.7 3867.2 32344.0 32886.7 33042.3 33046.3 34142.0 4281.5 4303.1 4327.3 4339.3 4340.5 294225.0 295566.0 295642.0 296505.0 297469.1 45003.3 46132.0 63152.7 63271.0 63604.0 45212.0 45326.5 45424.1 45511.3 45561.0 15325.6 15460.5 15463.2 15493.0 15510.8 12140.2 12149.6 12190.8 12196.7 12203.9 15782.8 15881.1 15891.4 15907.6 15928.2 5860.8 5917.3 5927.6 5963.2 6152.6 1052.5 1081.1 1081.1 1108.4 1132.6 29389.6 29420.0 30045.7 30326.0 30332.5 1073.6 1085.7 1105.8 1196.7 1197.9 14610.4 14671.9 14727.9 15051.7 15153.6 342147.0 347300.0 347559.0 347649.0 349249.0 58132.0 59261.4 59303.7 59453.4 59461.7 1329.1 1379.1 1446.3 1470.5 1475.9 28937.4 29429.4 29465.6 29628.7 29959.4 46058.8 46423.0 46466.7 46479.5 46536.8 227855.0 228545.0 229335.0 229504.0 230035.0 30171.8 34626.0 35057.6 35288.6 35666.1 52270.7 55006.4 57161.1 57816.0 58418.7 39385.0 39582.2 39664.8 39799.8 40011.4 38653.8 39491.8 40259.8 40312.2 40475.6 39579.0 40313.0 40453.0 40532.0 40885.6 34035.5 35005.6 35263.6 35501.1 35523.3 27210.5 27295.0 27601.4 27616.6 27675.7 17:55:52 INFO - PROCESS | 6879 | 17:55:52 INFO - PROCESS | 6879 | [#2] jquery.html Cycles:180 Average:27228.49 Median:389.52 stddev:79358.28 (20373.3%) stddev-sans-first:79555.28 17:55:52 INFO - PROCESS | 6879 | Values: 375.3 383.6 395.5 396.7 396.9 17219.6 19225.8 19428.0 19793.2 19839.1 18185.5 18223.2 18417.5 18424.7 18464.3 5506.8 5751.5 5755.7 5783.0 5790.1 4378.5 6128.2 6388.1 6415.4 6421.0 5439.7 6330.2 6331.9 6362.7 6363.8 5596.9 5616.0 5628.7 5632.7 5641.5 3984.0 5488.1 5709.6 5716.2 5716.9 13292.3 13857.9 13875.4 13923.6 13949.7 2338.6 2370.9 2406.7 2434.1 2447.9 10347.3 10394.8 10732.9 11905.2 14352.8 1866.3 1978.6 1985.7 2011.7 2058.9 63403.7 66960.3 68252.3 69283.3 69685.0 10504.7 10592.6 10704.5 10744.8 10824.8 15032.9 15053.5 15082.9 15093.8 15098.5 7760.2 7867.3 7954.4 7995.7 8029.3 7199.3 7292.2 7299.1 7454.4 7743.1 4646.7 4749.6 4778.9 4782.4 4796.3 1636.9 1833.8 1917.6 1949.9 1965.8 840.7 919.8 952.3 963.5 996.3 15853.3 16070.3 16288.8 16602.5 16821.0 913.8 914.2 921.4 949.8 1015.7 9401.0 9713.7 9723.3 9726.6 9913.7 457110.0 465281.0 477375.0 505253.0 512729.0 74729.6 80026.0 80602.2 81004.0 81692.0 1097.4 1106.0 1112.6 1121.0 1129.7 14747.6 14978.1 15021.5 15118.3 15265.2 32663.2 33111.7 33802.0 34043.5 34079.8 50072.0 51397.2 52153.7 52243.0 53289.0 8152.2 8178.0 8265.7 8290.1 8341.3 12869.0 13381.3 13407.5 13669.7 13857.2 8373.7 10201.8 11771.9 12166.2 12255.9 10899.6 11031.7 11131.2 11146.4 11282.8 11064.7 11279.2 12123.8 12209.9 12296.3 8938.4 8975.7 8990.1 9091.3 9098.5 9536.3 11735.5 12158.4 12239.8 12313.4 17:55:52 INFO - PROCESS | 6879 | 17:55:52 INFO - PROCESS | 6879 | [#3] mootools.html Cycles:180 Average:5937.19 Median:5271.53 stddev:3119.95 (59.2%) stddev-sans-first:3110.66 17:55:52 INFO - PROCESS | 6879 | Values: 1473.1 1601.2 1621.9 1859.4 1951.6 8059.2 8387.5 8397.9 8400.6 8410.3 8237.3 8432.8 8435.4 8449.5 8450.6 2067.3 2315.9 2342.6 2399.9 2459.0 2418.0 2452.5 2454.7 2467.6 2468.1 2408.8 2446.6 2446.9 2448.6 2451.7 2018.5 2332.0 2379.7 2384.2 2387.0 2300.9 2335.8 2340.8 2340.9 2342.7 8235.0 8252.8 8269.0 8295.5 8295.6 5170.7 5264.7 5278.3 5324.7 5324.8 3187.7 3191.3 3226.1 3246.0 3281.3 1058.4 2056.6 2071.6 2098.0 2111.1 11616.2 11682.4 11694.5 11697.5 11704.1 4403.5 4510.9 4548.0 4564.2 4594.8 9573.7 9604.6 9625.4 9632.0 9646.0 4543.0 5174.3 5176.1 5210.1 5223.7 4497.5 4553.2 4596.3 4600.0 4613.7 3676.6 3705.9 3706.6 3746.1 3809.1 1114.8 1114.9 1117.2 1129.6 1132.2 1414.3 1415.1 1436.3 1447.3 1468.0 8229.0 8340.8 8341.1 8341.1 8351.7 469.3 474.6 474.7 474.9 484.5 6299.1 6313.8 6334.5 6357.1 6408.9 10052.4 10305.9 10314.5 10397.5 10421.8 9966.8 10226.2 10230.5 10275.5 10305.1 8142.3 8156.5 8191.3 8201.1 8228.6 7617.5 7669.3 7826.4 7882.8 7886.0 9252.3 9354.3 9398.3 9464.8 9573.5 9363.2 9738.5 9811.2 9841.6 9957.5 6802.5 7245.5 7436.0 7698.9 7873.6 8190.2 8192.6 8211.1 8230.1 8234.3 7141.9 7464.7 7473.6 7592.7 7596.0 7154.9 7160.3 7205.3 7226.0 7258.6 7645.2 7654.8 7687.7 7694.2 7703.0 6931.8 7016.7 7022.6 7038.8 7062.7 7260.8 7364.9 7369.7 7381.0 7386.0 17:55:52 INFO - PROCESS | 6879 | 17:55:52 INFO - PROCESS | 6879 | [#4] prototype.html Cycles:180 Average:5335.79 Median:6030.34 stddev:1600.62 (26.5%) stddev-sans-first:1560.98 17:55:52 INFO - PROCESS | 6879 | Values: 362.3 366.7 366.7 367.4 377.4 5931.5 5944.3 5954.4 5968.4 6023.3 5884.8 5890.6 5901.9 5905.1 5922.8 4436.0 4498.3 4543.5 4582.0 4627.6 4582.2 4594.6 4616.4 4627.4 4628.6 4548.0 4593.3 4600.1 4600.3 4601.7 4395.1 4478.0 4549.9 4555.3 4586.4 4041.7 4069.2 4070.8 4077.4 4079.1 5628.4 5639.0 5643.4 5644.5 5644.8 5362.8 5363.2 5364.9 5370.7 5374.1 6258.7 6274.2 6277.3 6279.1 6292.2 4456.0 4498.2 4540.0 4559.6 4572.2 6535.5 6553.8 6558.3 6562.2 6582.0 4671.2 4680.5 4681.8 4684.3 4695.3 4698.0 4720.4 4724.0 4726.4 4728.5 5370.6 5382.4 5384.1 5388.2 5389.9 6092.9 6318.3 6338.1 6345.5 6415.9 1585.1 1592.8 1601.4 1606.7 1608.1 993.5 1061.7 1067.1 1082.3 1099.2 6025.4 6035.3 6041.2 6043.6 6048.5 6343.8 6398.5 6470.6 6472.3 6492.2 6122.9 6145.9 6148.3 6151.1 6156.4 3452.1 3488.7 3490.7 3492.4 3498.0 6674.2 6810.3 6845.9 6934.5 6941.4 6714.7 6725.2 6738.9 6744.1 6761.7 6844.8 6909.7 6911.8 6911.8 6919.0 6525.1 6560.6 6561.1 6568.3 6585.6 6255.6 6457.3 6463.9 6476.3 6481.3 6851.9 6881.8 6900.7 6903.0 6905.6 4527.5 4547.5 4547.5 4548.2 4548.8 6546.5 6570.0 6575.1 6585.4 6587.3 6162.4 6450.6 6481.8 6502.5 6508.0 6427.0 6435.3 6439.5 6441.7 6490.9 6312.8 6315.0 6315.6 6317.1 6321.3 6456.9 6464.6 6467.0 6469.9 6479.5 5982.3 6082.6 6299.8 6312.4 6318.1 17:55:52 INFO - PROCESS | 6879 | 17:55:52 INFO - PROCESS | 6879 | [#5] yui.html Cycles:180 Average:14577.42 Median:45423.93 stddev:16270.40 (35.8%) stddev-sans-first:16283.17 17:55:52 INFO - PROCESS | 6879 | Values: 804.6 804.9 821.8 822.3 900.6 13955.4 14167.1 14169.9 14170.5 14175.1 13832.8 13939.4 13969.6 13981.4 13991.0 768.8 902.2 926.6 928.4 929.3 929.3 932.9 933.5 936.9 937.1 817.2 982.3 984.3 985.2 985.5 955.5 974.0 974.2 975.2 975.2 717.8 718.9 720.0 720.4 720.6 13791.4 13900.2 13919.4 13920.1 13933.8 13794.7 14230.3 14232.9 14504.8 15022.5 11599.6 11763.1 11779.7 11806.2 11972.3 3927.1 3931.3 3962.8 3985.3 3991.5 51632.2 52195.0 52916.7 54049.7 54443.5 11560.0 11629.0 11805.5 12019.9 12046.4 19915.6 20017.8 20035.1 20080.4 20092.9 8045.6 8143.0 8164.2 8318.2 8633.9 4759.1 4859.9 4862.5 4934.2 4987.8 3409.3 3476.4 3479.7 3499.0 3499.3 623.3 626.4 631.2 632.5 655.4 573.0 624.6 698.9 723.5 727.7 9195.4 9342.5 9501.7 9536.2 9668.2 653.9 655.7 735.2 736.7 751.0 4039.9 4364.4 4372.9 4412.3 4441.9 52079.5 57544.7 57839.4 57977.1 58294.4 50755.2 51662.5 52056.5 52172.0 52710.7 46451.0 46525.0 46882.8 47025.5 47685.5 9005.6 9312.7 9447.8 9462.1 9727.8 34970.5 34986.1 35024.6 36975.3 37517.6 45223.5 45624.3 45705.0 46216.9 46704.0 11316.9 11790.6 11834.9 11901.0 11915.8 12827.2 13062.3 13094.2 13187.8 13464.7 12736.2 12843.7 12993.5 13029.3 13215.4 11820.8 11989.0 12306.7 12963.5 13013.0 12434.4 12445.3 12485.8 12497.2 12498.4 10173.6 10177.9 10259.4 10421.2 10734.8 10259.0 10342.2 10355.9 10357.2 10377.6 17:55:52 INFO - PROCESS | 6879 | -------- Summary: end -------- 17:55:52 INFO - PROCESS | 6879 | 17:55:53 INFO - TEST-INFO | 6879: exit 0 17:55:53 INFO - TEST-OK | dromaeo_css | took 1111439ms 17:55:53 INFO - TEST-START | kraken 17:55:53 INFO - operating with platform_type : linux_ 17:55:53 INFO - Initialising browser for kraken test... 17:55:53 INFO - TEST-INFO | started process 7070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpALYXua/profile http://localhost:50027/getInfo.html) 17:55:57 INFO - PROCESS | 7070 | __metrics Screen width/height:1600/1200 17:55:57 INFO - PROCESS | 7070 | colorDepth:24 17:55:57 INFO - PROCESS | 7070 | Browser inner width/height: 1024/697 17:55:57 INFO - PROCESS | 7070 | __metrics 17:55:58 INFO - PROCESS | 7070 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:55:59 INFO - TEST-INFO | 7070: exit 0 17:55:59 INFO - Browser initialized. 17:55:59 INFO - Running cycle 1/1 for kraken test... 17:55:59 INFO - TEST-INFO | started process 7160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpALYXua/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:10 INFO - PROCESS | 7160 | RSS: Main: 141090816 17:56:10 INFO - PROCESS | 7160 | 17:56:13 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50027/tests/kraken/driver.html?testName=audio-beat-detection) 17:56:14 INFO - PROCESS | 7160 | RSS: Main: 176791552 17:56:14 INFO - PROCESS | 7160 | 17:56:16 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50027/tests/kraken/driver.html?testName=audio-dft) 17:56:17 INFO - PROCESS | 7160 | RSS: Main: 175144960 17:56:17 INFO - PROCESS | 7160 | 17:56:20 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50027/tests/kraken/driver.html?testName=audio-fft) 17:56:20 INFO - PROCESS | 7160 | RSS: Main: 173711360 17:56:20 INFO - PROCESS | 7160 | 17:56:22 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50027/tests/kraken/driver.html?testName=audio-oscillator) 17:56:23 INFO - PROCESS | 7160 | RSS: Main: 174493696 17:56:23 INFO - PROCESS | 7160 | 17:56:25 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50027/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:56:26 INFO - PROCESS | 7160 | RSS: Main: 171323392 17:56:26 INFO - PROCESS | 7160 | 17:56:29 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50027/tests/kraken/driver.html?testName=imaging-darkroom) 17:56:29 INFO - PROCESS | 7160 | RSS: Main: 171315200 17:56:29 INFO - PROCESS | 7160 | 17:56:33 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50027/tests/kraken/driver.html?testName=imaging-desaturate) 17:56:33 INFO - PROCESS | 7160 | RSS: Main: 171524096 17:56:33 INFO - PROCESS | 7160 | 17:56:36 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50027/tests/kraken/driver.html?testName=json-parse-financial) 17:56:37 INFO - PROCESS | 7160 | RSS: Main: 171507712 17:56:37 INFO - PROCESS | 7160 | 17:56:38 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50027/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:56:39 INFO - PROCESS | 7160 | RSS: Main: 176447488 17:56:39 INFO - PROCESS | 7160 | 17:56:40 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:56:41 INFO - PROCESS | 7160 | RSS: Main: 174821376 17:56:41 INFO - PROCESS | 7160 | 17:56:43 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:56:44 INFO - PROCESS | 7160 | RSS: Main: 179949568 17:56:44 INFO - PROCESS | 7160 | 17:56:46 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:56:47 INFO - PROCESS | 7160 | RSS: Main: 187547648 17:56:47 INFO - PROCESS | 7160 | 17:56:49 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:56:50 INFO - PROCESS | 7160 | RSS: Main: 186515456 17:56:50 INFO - PROCESS | 7160 | 17:56:51 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:50027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50027/tests/kraken/driver.html?testName=ai-astar) 17:56:52 INFO - PROCESS | 7160 | RSS: Main: 248770560 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | __start_tp_report 17:56:52 INFO - PROCESS | 7160 | _x_x_mozilla_page_load 17:56:52 INFO - PROCESS | 7160 | _x_x_mozilla_page_load_details 17:56:52 INFO - PROCESS | 7160 | |i|pagename|runs| 17:56:52 INFO - PROCESS | 7160 | |0;ai-astar;110;110;106;109;110;112;99;109;108;109 17:56:52 INFO - PROCESS | 7160 | |1;audio-beat-detection;158;134;162;167;129;150;156;134;179;126 17:56:52 INFO - PROCESS | 7160 | |2;audio-dft;170;159;162;160;160;162;159;162;160;160 17:56:52 INFO - PROCESS | 7160 | |3;audio-fft;73;75;76;162;77;76;74;76;170;77 17:56:52 INFO - PROCESS | 7160 | |4;audio-oscillator;92;94;146;92;92;93;151;93;93;142 17:56:52 INFO - PROCESS | 7160 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 17:56:52 INFO - PROCESS | 7160 | |6;imaging-darkroom;146;145;145;145;148;146;147;147;146;146 17:56:52 INFO - PROCESS | 7160 | |7;imaging-desaturate;95;96;96;96;96;96;95;95;95;96 17:56:52 INFO - PROCESS | 7160 | |8;json-parse-financial;53;53;55;54;53;54;54;64;53;52 17:56:52 INFO - PROCESS | 7160 | |9;json-stringify-tinderbox;64;66;67;65;65;66;65;65;64;65 17:56:52 INFO - PROCESS | 7160 | |10;stanford-crypto-aes;78;78;79;77;78;77;78;78;78;79 17:56:52 INFO - PROCESS | 7160 | |11;stanford-crypto-ccm;111;112;112;110;113;110;111;119;111;121 17:56:52 INFO - PROCESS | 7160 | |12;stanford-crypto-pbkdf2;145;145;145;143;149;134;147;141;149;150 17:56:52 INFO - PROCESS | 7160 | |13;stanford-crypto-sha256-iterative;68;67;70;67;66;67;66;69;66;65 17:56:52 INFO - PROCESS | 7160 | __end_tp_report 17:56:52 INFO - PROCESS | 7160 | __start_cc_report 17:56:52 INFO - PROCESS | 7160 | _x_x_mozilla_cycle_collect,1069 17:56:52 INFO - PROCESS | 7160 | __end_cc_report 17:56:52 INFO - PROCESS | 7160 | __startTimestamp1460768212104__endTimestamp 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | ------- Summary: start ------- 17:56:52 INFO - PROCESS | 7160 | Number of tests: 14 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.58 (3.3%) stddev-sans-first:3.74 17:56:52 INFO - PROCESS | 7160 | Values: 110.0 110.0 106.0 109.0 110.0 112.0 99.0 109.0 108.0 109.0 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:157.00 stddev:17.95 (11.4%) stddev-sans-first:18.78 17:56:52 INFO - PROCESS | 7160 | Values: 158.0 134.0 162.0 167.0 129.0 150.0 156.0 134.0 179.0 126.0 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:3.24 (2.0%) stddev-sans-first:1.24 17:56:52 INFO - PROCESS | 7160 | Values: 170.0 159.0 162.0 160.0 160.0 162.0 159.0 162.0 160.0 160.0 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:38.23 (50.3%) stddev-sans-first:39.81 17:56:52 INFO - PROCESS | 7160 | Values: 73.0 75.0 76.0 162.0 77.0 76.0 74.0 76.0 170.0 77.0 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:92.50 stddev:25.99 (28.1%) stddev-sans-first:26.85 17:56:52 INFO - PROCESS | 7160 | Values: 92.0 94.0 146.0 92.0 92.0 93.0 151.0 93.0 93.0 142.0 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:56:52 INFO - PROCESS | 7160 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 17:56:52 INFO - PROCESS | 7160 | Values: 146.0 145.0 145.0 145.0 148.0 146.0 147.0 147.0 146.0 146.0 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:56:52 INFO - PROCESS | 7160 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:3.44 (6.4%) stddev-sans-first:3.61 17:56:52 INFO - PROCESS | 7160 | Values: 53.0 53.0 55.0 54.0 53.0 54.0 54.0 64.0 53.0 52.0 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 17:56:52 INFO - PROCESS | 7160 | Values: 64.0 66.0 67.0 65.0 65.0 66.0 65.0 65.0 64.0 65.0 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:78.00 stddev:0.67 (0.9%) stddev-sans-first:0.71 17:56:52 INFO - PROCESS | 7160 | Values: 78.0 78.0 79.0 77.0 78.0 77.0 78.0 78.0 78.0 79.0 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | [#11] stanford-crypto-ccm Cycles:10 Average:113.00 Median:112.00 stddev:3.83 (3.4%) stddev-sans-first:3.99 17:56:52 INFO - PROCESS | 7160 | Values: 111.0 112.0 112.0 110.0 113.0 110.0 111.0 119.0 111.0 121.0 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.80 Median:146.00 stddev:4.73 (3.2%) stddev-sans-first:5.02 17:56:52 INFO - PROCESS | 7160 | Values: 145.0 145.0 145.0 143.0 149.0 134.0 147.0 141.0 149.0 150.0 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - PROCESS | 7160 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.52 (2.3%) stddev-sans-first:1.58 17:56:52 INFO - PROCESS | 7160 | Values: 68.0 67.0 70.0 67.0 66.0 67.0 66.0 69.0 66.0 65.0 17:56:52 INFO - PROCESS | 7160 | -------- Summary: end -------- 17:56:52 INFO - PROCESS | 7160 | 17:56:52 INFO - TEST-INFO | 7160: exit 0 17:56:53 INFO - TEST-OK | kraken | took 59550ms 17:56:53 INFO - SUITE-END | took 1170s 17:56:53 INFO - Completed test suite (00:19:31) 17:56:53 INFO - javascript benchmark 17:56:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3289.3750187464384, 3338.933221335572, 3355.6308806031334, 3362.61329947056, 3383.171123074847, 5313.362396512419, 5314.973425132874, 5345.786168553258, 5348.117560602496, 5385.649932754368, 5353.0, 5377.462253774621, 5379.139337705968, 5390.460953904608, 5390.973045134779, 4717.245240761479, 4917.0, 4919.729414882189, 4957.702537847741, 4992.850214493553, 4806.182948898696, 4881.267809828536, 4897.8040878365, 4899.8040078396825, 4903.779329930162, 4936.259561065833, 4995.425526064513, 4996.1756310208775, 4996.25056241563, 5004.424491183524, 4823.493533179001, 4927.384076990376, 4973.975130124344, 4979.576735977446, 4993.0263598598285, 4774.618030557547, 4897.0, 4917.901641967141, 4944.9258261126115, 4949.975250123763, 5116.795328186868, 5193.402758682762, 5213.244079608474, 5213.2701421800975, 5242.5281724644965, 5772.220750198753, 5790.739416726257, 5792.913106303409, 5793.275840519935, 5799.18811366409, 5631.915521267184, 5723.627964182315, 5804.2744656917885, 5823.56323275756, 5842.036064049426, 5419.295491586147, 5420.105682562373, 5420.593455490814, 5426.294581704393, 5452.263944367499, 5901.439363260483, 5903.675297858659, 5905.734241959036, 5913.319968203626, 5936.525077993837, 5485.067538518461, 5616.326040875121, 5701.914471282934, 5703.144528320702, 5705.258316418839, 5778.6821724804695, 5786.07422812348, 5787.276590426197, 5794.304683438015, 5797.043487824461, 5751.4536119068625, 5773.480386765212, 5782.306123265235, 5787.884242315215, 5791.739371728282, 5598.748056337475, 5664.6601203927075, 5764.221830052889, 5765.279340082489, 5771.105478650816, 4465.419495465569, 4467.352233926063, 4469.2849144137435, 4469.754163521037, 4491.663125265618, 4007.2586571484367, 4014.7390419623216, 4016.6184212499766, 4055.878323650295, 4062.878113656595, 5412.377576578744, 5514.255575497336, 5560.471755183251, 5609.887802243932, 5619.100943848965, 5829.09649004405, 5881.1178323251, 5891.086881533369, 5891.086881533369, 5892.558058145571, 5395.703236321961, 5574.247476590689, 5599.636023658449, 5622.353429355595, 5624.21261023457, 4984.90030199394, 5043.293938848564, 5063.088644044107, 5076.340075790197, 5088.567471764942, 5970.164177015221, 5971.134185543072, 5971.373005834324, 5972.820815375546, 5975.790847320323, 5627.521660658726, 5701.828945131652, 5705.258316418839, 5709.400512946081, 5713.171590119409, 5994.3705910878725, 6018.277806663228, 6023.969880150571, 6029.0, 6054.122152287981, 5656.434356564475, 5659.801906933402, 5676.659400435987, 5696.0316746154085, 5696.943030569641, 5717.42825717425, 5730.226419433323, 5751.798687045934, 5763.394843541368, 5842.298924129132, 5680.6591604503865, 5682.147677848356, 5683.943160568341, 5686.402927692533, 5688.203651488878, 5659.971700141473, 5668.688222147656, 5668.829935101953, 5671.688057156896, 5673.149027645886, 5369.5167434931045, 5447.618666693294, 5554.1946417770005, 5566.805161819317, 5618.887622247614, 5519.834404967857, 5558.166275058774, 5585.636933599303, 5592.105263157875, 5722.542196624343, 5447.319085114361, 5479.643823151482, 5497.422770609029, 5540.501354877919, 5544.556435485232], "unit": "score", "name": "dojo.html", "value": 5337.474886134052}, {"lowerIsBetter": false, "replicates": [545.6098889294155, 562.9183768353588, 563.6111083352487, 584.3221862639334, 589.8024161905761, 30233.0, 30780.230494237654, 38565.614343856556, 38988.0, 39029.804850975706, 42640.36039459411, 43038.0, 43195.3520697189, 43208.56791432085, 43264.35103473443, 8859.246964008067, 9085.409448385866, 9092.59083341248, 9093.136152065543, 9097.499637519933, 8859.822803543926, 8948.373613847034, 8985.640574377017, 8997.100289970984, 9016.143466370684, 9212.078792120801, 9296.488693121875, 9301.255899528021, 9304.720858374225, 9307.395019323721, 9117.772055698595, 9195.172434480863, 9199.172074513259, 9201.677941272057, 9203.907960920373, 9105.726828195166, 9249.676261330822, 9270.814583708288, 9270.90729092714, 9280.95359523198, 44489.55510444919, 45028.3245751314, 45031.549684503065, 45039.32441013387, 45093.774531127136, 3199.1842080269616, 3378.45944648855, 3488.3023395320783, 3865.6714179294795, 3867.168558759852, 32344.0, 32886.6711332886, 33042.33915321704, 33046.33907321864, 34142.0, 4281.507626622947, 4303.0963497665525, 4327.307630779092, 4339.327404252346, 4340.457442819647, 294225.0, 295566.0, 295642.0, 296505.0, 297469.12654367194, 45003.32495012512, 46132.0, 63152.68423657852, 63271.0, 63604.0, 45212.0, 45326.54673453223, 45424.09151816945, 45511.317330240076, 45561.0, 15325.616859578377, 15460.458883939009, 15463.226838658022, 15493.0, 15510.767338489932, 12140.150189486827, 12149.635510934686, 12190.81713774294, 12196.695082622828, 12203.877961220453, 15782.763258551131, 15881.126538040287, 15891.364345426286, 15907.602309942113, 15928.203589820463, 5860.769238459886, 5917.260342457193, 5927.585069045212, 5963.197297270276, 6152.600080994811, 1052.4737631184407, 1081.1026847716375, 1081.1350919264714, 1108.3903852880883, 1132.592266783957, 29389.559156612668, 29420.0, 30045.69954300473, 30326.0, 30332.54501182484, 1073.6295977887617, 1085.733995171188, 1105.8120119579692, 1196.670915498245, 1197.9278545701548, 14610.415583376545, 14671.92664036673, 14727.852721472862, 15051.698966020618, 15153.62115947088, 342147.0, 347300.0, 347559.0, 347649.0, 349249.0, 58132.0, 59261.40738592645, 59303.70348148232, 59453.40546594565, 59461.702691486265, 1329.0762919770666, 1379.0760190672274, 1446.3419144289323, 1470.4632809024629, 1475.9335829887682, 28937.42125157443, 29429.411411772075, 29465.55801662934, 29628.703712962593, 29959.400811983203, 46058.76970615125, 46423.0, 46466.67666616723, 46479.535204647524, 46536.767316163205, 227855.0, 228545.0, 229335.0, 229504.0, 230035.0, 30171.849140754155, 34626.0, 35057.64942350646, 35288.647113529565, 35666.10834729153, 52270.73864630653, 55006.44993550013, 57161.142582860455, 57816.0, 58418.707906461896, 39385.01537461586, 39582.20835583215, 39664.80167599144, 39799.80100099481, 40011.399829003174, 38653.806730966164, 39491.80254098711, 40259.79870100631, 40312.19375612413, 40475.59524404718, 39579.01052473711, 40313.0, 40453.0, 40532.0, 40885.591144088175, 34035.4894676585, 35005.64994350024, 35263.64736352706, 35501.112472188404, 35523.28953420969, 27210.455790883676, 27295.0, 27601.447971040867, 27616.585751213344, 27675.689654314458], "unit": "score", "name": "ext.html", "value": 18964.089377604374}, {"lowerIsBetter": false, "replicates": [375.25886374410544, 383.566569776153, 395.4740195539932, 396.7084193118059, 396.9364901615742, 17219.569510762223, 19225.807741922577, 19428.0, 19793.208271669133, 19839.10724017419, 18185.454236389924, 18223.17995690194, 18417.53956151097, 18424.723629145574, 18464.261429542803, 5506.779728810853, 5751.4536119068625, 5755.740991655385, 5783.0, 5790.102534107199, 4378.496472905609, 6128.20333356663, 6388.073729309247, 6415.422611964922, 6420.967895160517, 5439.700816455093, 6330.240371155444, 6331.936680633204, 6362.745490180388, 6363.777267795628, 5596.888062238752, 5615.971920140414, 5628.71856407178, 5632.662040277576, 5641.464060914227, 3983.960160398388, 5488.094464413367, 5709.571782116316, 5716.228309178249, 5716.857078573027, 13292.26892520911, 13857.930710346485, 13875.37560809766, 13923.58229253124, 13949.651258718613, 2338.5790557699606, 2370.928872133839, 2406.6750988616486, 2434.0993832281993, 2447.9265622031367, 10347.32742371751, 10394.844077338847, 10732.946335268352, 11905.226160299639, 14352.784708229385, 1866.2908094923978, 1978.6339527187517, 1985.6822908334598, 2011.6580181369056, 2058.87646741196, 63403.68298158526, 66960.33039669639, 68252.31747682509, 69283.30716692819, 69685.0, 10504.684859454228, 10592.576296948037, 10704.518296676668, 10744.838827417596, 10824.783504330027, 15032.924835375972, 15053.548393548212, 15082.924585377223, 15093.849061509463, 15098.54704358871, 7760.18518055596, 7867.252611001945, 7954.363650907913, 7995.720149794729, 8029.3175080118845, 7199.280071992864, 7292.19785823559, 7299.124105107421, 7454.366378857858, 7743.070831500143, 4646.721196728207, 4749.572538471554, 4778.92116929137, 4782.402199725035, 4796.2805579163405, 1636.9017858928503, 1833.8349548540696, 1917.6001518891287, 1949.9220031198877, 1965.7837637859825, 840.684743221292, 919.793046564531, 952.3143336797494, 963.5086106085946, 996.342414006752, 15853.286602102702, 16070.276837542338, 16288.755668664979, 16602.50192494227, 16821.0, 913.8126684029758, 914.1772404835568, 921.3918813583138, 949.7862980829258, 1015.6952914125881, 9401.0, 9713.66002189934, 9723.270754693285, 9726.610935562498, 9913.702588922344, 457110.0, 465281.0, 477375.0, 505253.0, 512729.0, 74729.62635186789, 80026.0, 80602.19397805947, 81004.0, 81692.0, 1097.4183682648209, 1106.0377471599759, 1112.6495154026618, 1121.0191082802548, 1129.711923459529, 14747.631309217355, 14978.1013139212, 15021.474248401253, 15118.274755615515, 15265.160416176772, 32663.18342041468, 33111.668883311824, 33802.0, 34043.489347659306, 34079.82960085184, 50071.99856002932, 51397.22904156515, 52153.7392313036, 52243.0, 53289.0, 8152.225538573826, 8177.9591102044105, 8265.710700125466, 8290.06257872131, 8341.290990265896, 12869.0, 13381.330933453482, 13407.530736424178, 13669.726605467637, 13857.237851918242, 8373.665053397795, 10201.775786905619, 11771.882281177079, 12166.20919640256, 12255.938720306342, 10899.564017439214, 11031.669049928514, 11131.220814542905, 11146.386948717898, 11282.830757538808, 11064.723381915517, 11279.154063445438, 12123.818142728043, 12209.938950305192, 12296.323702196465, 8938.352405942294, 8975.685850995445, 8990.100989900957, 9091.272698183997, 9098.454092754457, 9536.284778641491, 11735.530578776754, 12158.392080396121, 12239.816402753788, 12313.384330783247], "unit": "score", "name": "jquery.html", "value": 8786.939322637047}, {"lowerIsBetter": false, "replicates": [1473.0572433642465, 1601.2314089237166, 1621.9351225950963, 1859.3864024871784, 1951.5901660651261, 8059.234372734588, 8387.538685372301, 8397.91602083979, 8400.621972011259, 8410.28512576431, 8237.258646721793, 8432.789180270496, 8435.367347448935, 8449.535275559841, 8450.619722112504, 2067.328118361531, 2315.907363705454, 2342.625179971205, 2399.8800059997016, 2458.963115553268, 2418.022353228946, 2452.5462789383932, 2454.7422520635346, 2467.568175569268, 2468.0744720729726, 2408.8313818032657, 2446.633005049248, 2446.9143579974702, 2448.6204638281006, 2451.7180524239675, 2018.465106746706, 2331.9533609327805, 2379.702537182852, 2384.213209640823, 2387.045181927243, 2300.907963681451, 2335.8437573401106, 2340.7776261255153, 2340.8829558522007, 2342.6837376954063, 8235.0, 8252.8349433011, 8269.0, 8295.460795048362, 8295.626696798598, 5170.741462926839, 5264.710440925747, 5278.340207474066, 5324.733763311858, 5324.8136315228785, 3187.729043031345, 3191.329820737648, 3226.0644413120167, 3246.0, 3281.278118813857, 1058.4125810175349, 2056.5784014277037, 2071.564971356017, 2097.9895100524554, 2111.0711287033655, 11616.186866919319, 11682.415879206006, 11694.532218711242, 11697.473613687405, 11704.122190835637, 4403.53762854902, 4510.932336014962, 4547.977260113678, 4564.2240819060835, 4594.793234304398, 9573.712788616353, 9604.615815367446, 9625.374350667324, 9631.951840240894, 9646.0, 4543.0, 5174.275601415805, 5176.06830770465, 5210.140326846104, 5223.686578805284, 4497.482789479186, 4553.248713962225, 4596.333531637893, 4599.977000115045, 4613.700109492872, 3676.613955534684, 3705.8517659293866, 3706.629337066272, 3746.0822098586023, 3809.142942837839, 1114.8383484394717, 1114.9386783726973, 1117.1677100560134, 1129.5594718059963, 1132.1678566253797, 1414.3069895751214, 1415.0519152167867, 1436.2603259321459, 1447.254663848119, 1467.9779803302958, 8228.958855205685, 8340.791480212922, 8341.082480927093, 8341.124181960928, 8351.749447516584, 469.3358897160548, 474.64875991766536, 474.6890786534825, 474.87178461815114, 484.4646665434714, 6299.086632438362, 6313.779017734358, 6334.5249106317215, 6357.078223657544, 6408.871822563523, 10052.396856188652, 10305.948470257601, 10314.48427578618, 10397.532111055021, 10421.791564168674, 9966.750831229132, 10226.23303252259, 10230.539625716712, 10275.486225688686, 10305.072543471124, 8142.267195952274, 8156.510609363457, 8191.344692424592, 8201.13888041747, 8228.588570571566, 7617.466777325534, 7669.271419215165, 7826.373890088893, 7882.84234315299, 7885.960570197341, 9252.259819214312, 9354.25165986733, 9398.2951278653, 9464.810703786023, 9573.473458959825, 9363.157315841607, 9738.513074346396, 9811.16605088547, 9841.606335746776, 9957.502124893581, 6802.523823332319, 7245.529040612343, 7436.033315669145, 7698.92301076982, 7873.645685944031, 8190.221928916743, 8192.590370481572, 8211.055728591049, 8230.053543842534, 8234.258916697527, 7141.928580714334, 7464.738734144279, 7473.551586904586, 7592.696292148473, 7595.962020189863, 7154.892676609751, 7160.283971602798, 7205.315495027964, 7226.024486694229, 7258.637068146466, 7645.1972542882195, 7654.808629784077, 7687.692492300245, 7694.192109828387, 7703.037120359955, 6931.792046238621, 7016.6842492089, 7022.578645281299, 7038.753643622448, 7062.71749130029, 7260.818479538054, 7364.889526656997, 7369.705211791683, 7381.0, 7386.0], "unit": "score", "name": "mootools.html", "value": 4798.2788228630125}, {"lowerIsBetter": false, "replicates": [362.3477740067878, 366.6754921894123, 366.72129181821816, 367.3809630772149, 377.3566069850904, 5931.466168044875, 5944.316403613586, 5954.374790646979, 5968.432998865101, 6023.30731965823, 5884.764609415618, 5890.617109887854, 5901.881962360751, 5905.143754155645, 5922.792702255422, 4436.024074703576, 4498.302763071729, 4543.5002149763495, 4582.037772067853, 4627.583517483435, 4582.19811532982, 4594.632429405656, 4616.376789133475, 4627.3521706961055, 4628.606568441686, 4547.954520454803, 4593.311003349491, 4600.125976064537, 4600.332951721998, 4601.723896566216, 4395.05506316142, 4477.999999999984, 4549.863504094882, 4555.339475776027, 4586.449626044896, 4041.6766658667234, 4069.2065047315787, 4070.7761073140964, 4077.4087757275324, 4079.102597428561, 5628.43715628438, 5639.041362968264, 5643.407442218549, 5644.491995720405, 5644.8024319148635, 5362.758675859595, 5363.168708850135, 5364.892702145935, 5370.731463426813, 5374.140137578008, 6258.71835767387, 6274.247090349141, 6277.340879207663, 6279.058141278799, 6292.1820163378925, 4456.041950980555, 4498.190325741365, 4540.046590216059, 4559.566841150086, 4572.245579479382, 6535.509836762214, 6553.803385898431, 6558.311377305362, 6562.179727534059, 6582.045603387482, 4671.205894997858, 4680.485146633868, 4681.836135735233, 4684.297355396649, 4695.319178719066, 4697.989932164601, 4720.362751028636, 4723.976380118077, 4726.361941137971, 4728.456227533878, 5370.624056316098, 5382.381026182039, 5384.057789886754, 5388.191771234347, 5389.946100539023, 6092.908606370908, 6318.336574659686, 6338.080978258126, 6345.460635845912, 6415.903761443582, 1585.0885740698914, 1592.7690484879627, 1601.3594562175224, 1606.7027599894056, 1608.107500337324, 993.4734590666958, 1061.7080302916606, 1067.146282973618, 1082.2748758331936, 1099.197585762398, 6025.367336429699, 6035.30593981689, 6041.184440100618, 6043.607165534227, 6048.516118710492, 6343.841403964845, 6398.488120950313, 6470.611763294218, 6472.288048314682, 6492.156019717407, 6122.877542449126, 6145.907811382833, 6148.323684394713, 6151.108089327023, 6156.353582873823, 3452.102453362144, 3488.686018258318, 3490.703290220309, 3492.371373152806, 3498.003069125287, 6674.16572928384, 6810.318968103249, 6845.931540684529, 6934.549254298455, 6941.409980151642, 6714.731410743613, 6725.159355080615, 6738.932610673831, 6744.089547911068, 6761.729530818712, 6844.760433384808, 6909.723611055602, 6911.7926462205205, 6911.827204319932, 6919.0, 6525.086487891604, 6560.639164845979, 6561.1470508833545, 6568.310327415553, 6585.604863708193, 6255.593386429868, 6457.289698133108, 6463.935360646521, 6476.255230648348, 6481.287058423664, 6851.931480685129, 6881.827954301182, 6900.723971041303, 6903.0, 6905.585664860125, 4527.524609915911, 4547.477040140294, 4547.545245475426, 4548.181327361107, 4548.795304211252, 6546.476281897341, 6570.0, 6575.079488871657, 6585.407313341822, 6587.2753997061245, 6162.352952939877, 6450.580712253689, 6481.837954050998, 6502.544821862424, 6508.023796430573, 6427.0, 6435.324290949383, 6439.549231553746, 6441.67791610427, 6490.935090649033, 6312.810615681537, 6315.021171718391, 6315.5894866833505, 6317.052442133533, 6321.336259692666, 6456.870862582816, 6464.5798023128345, 6467.0, 6469.870602587827, 6479.51403644738, 5982.341942386421, 6082.60463069899, 6299.811005669837, 6312.3687631238345, 6318.115463834974], "unit": "score", "name": "prototype.html", "value": 4822.074466378813}, {"lowerIsBetter": false, "replicates": [804.5655346113099, 804.9315808156307, 821.8027673358392, 822.3133683374382, 900.5677274908041, 13955.372008259626, 14167.079139855929, 14169.929150354259, 14170.504032358856, 14175.149491030545, 13832.792508112387, 13939.442422303122, 13969.58091257264, 13981.370838312276, 13991.0, 768.8385439057805, 902.1745103230536, 926.6200857648365, 928.3640706116298, 929.2658799548349, 929.3401684803797, 932.8693982842408, 933.4585940154694, 936.8782058332407, 937.0863408177041, 817.2113910076774, 982.2780256511459, 984.271638987148, 985.2167526816198, 985.5318723606266, 955.5365647660878, 974.0405700385115, 974.1670871404917, 975.2149519636689, 975.229568640773, 717.7667258141125, 718.8957601147804, 720.0351528951178, 720.4452571519953, 720.6000669628354, 13791.379387927567, 13900.16599004063, 13919.443222271097, 13920.095193812369, 13933.790993135111, 13794.65513362164, 14230.28848557568, 14232.857671423257, 14504.782428263585, 15022.549323520312, 11599.594014209546, 11763.117766167572, 11779.7055073623, 11806.173567850254, 11972.341521216329, 3927.0967677434064, 3931.331673615464, 3962.841486340543, 3985.342418500944, 3991.5409727881374, 51632.22551661728, 52195.0, 52916.735416323056, 54049.729751351384, 54443.45556544424, 11560.0, 11629.0, 11805.527778888749, 12019.939900300618, 12046.397680115959, 19915.60168796616, 20017.799822001885, 20035.09842057111, 20080.39758807238, 20092.89953550252, 8045.637946292431, 8143.0, 8164.224398682116, 8318.168183181755, 8633.91366086331, 4759.143354196209, 4859.927101093486, 4862.5380588844, 4934.1611925972675, 4987.775550100254, 3409.2670075933793, 3476.3568739782713, 3479.6694314040124, 3499.0377646147513, 3499.3176330615283, 623.3392603839853, 626.4236902050034, 631.2204427531994, 632.5129650169343, 655.3610230025687, 573.0315766354847, 624.5628060357768, 698.9405900498515, 723.504399486343, 727.7380143148463, 9195.402298850553, 9342.486163261086, 9501.667441639509, 9536.189423899046, 9668.178204852526, 653.9346065393518, 655.6754406568779, 735.1949615171379, 736.6721808795035, 751.0499218488616, 4039.8788036358956, 4364.388985542027, 4372.868813935587, 4412.33814927757, 4441.933370999438, 52079.47920520822, 57544.71227643835, 57839.42160578424, 57977.13034304489, 58294.4170558289, 50755.23867141996, 51662.48337516652, 52056.47943520516, 52172.0, 52710.736446317525, 46451.0, 46525.0, 46882.765586172536, 47025.5297447028, 47685.52314476811, 9005.639774409212, 9312.674056407994, 9447.763805904908, 9462.148406643435, 9727.805443891224, 34970.47544286888, 34986.12534686653, 35024.64975350214, 36975.26049479049, 37517.624823751416, 45223.54776452325, 45624.31563526616, 45705.0, 46216.909475781344, 46704.0, 11316.94341528287, 11790.587329443428, 11834.881651183377, 11901.0, 11915.761684766083, 12827.166234194747, 13062.281574513492, 13094.214347139203, 13187.802182967454, 13464.730705386033, 12736.172148810298, 12843.743125137631, 12993.545225917047, 13029.283389413295, 13215.405306761026, 11820.76358472843, 11989.0, 12306.692332691755, 12963.546275880677, 13013.0, 12434.440450179945, 12445.25328480294, 12485.75028499443, 12497.18768280059, 12498.43757030954, 10173.643922462677, 10177.92919744813, 10259.384436933808, 10421.218408619232, 10734.785304294026, 10258.980951151929, 10342.224333174892, 10355.94822025885, 10357.17142628603, 10377.636782712569], "unit": "score", "name": "yui.html", "value": 6862.100875980981}], "name": "dromaeo_css", "value": 7216.385672546431}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 106.0, 109.0, 110.0, 112.0, 99.0, 109.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [158.0, 134.0, 162.0, 167.0, 129.0, 150.0, 156.0, 134.0, 179.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 149.5}, {"lowerIsBetter": true, "replicates": [170.0, 159.0, 162.0, 160.0, 160.0, 162.0, 159.0, 162.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 76.0, 162.0, 77.0, 76.0, 74.0, 76.0, 170.0, 77.0], "unit": "score", "name": "audio-fft", "value": 93.6}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 146.0, 92.0, 92.0, 93.0, 151.0, 93.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 148.0, 146.0, 147.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [53.0, 53.0, 55.0, 54.0, 53.0, 54.0, 54.0, 64.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.5}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 67.0, 65.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.2}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 79.0, 77.0, 78.0, 77.0, 78.0, 78.0, 78.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.0}, {"lowerIsBetter": true, "replicates": [111.0, 112.0, 112.0, 110.0, 113.0, 110.0, 111.0, 119.0, 111.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.0}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 143.0, 149.0, 134.0, 147.0, 141.0, 149.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.8}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 70.0, 67.0, 66.0, 67.0, 66.0, 69.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1502.8}]} 17:56:53 INFO - Return code: 0 17:56:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:56:53 INFO - # TBPL SUCCESS # 17:56:53 INFO - Running post-action listener: _resource_record_post_action 17:56:53 INFO - Running post-run listener: _resource_record_post_run 17:56:54 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 278528; Write bytes: 485167104; Read time: 48; Write time: 408188 17:56:54 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 227233792; Read time: 0; Write time: 234024 17:56:54 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 278528; Write bytes: 254947328; Read time: 48; Write time: 173700 17:56:54 INFO - Running post-run listener: _upload_blobber_files 17:56:54 INFO - Blob upload gear active. 17:56:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:56:54 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:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:56:54 INFO - (blobuploader) - INFO - Open directory for files ... 17:56:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:56:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:56:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:55 INFO - (blobuploader) - INFO - Done attempting. 17:56:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:56:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:56:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:56 INFO - (blobuploader) - INFO - Done attempting. 17:56:56 INFO - (blobuploader) - INFO - Iteration through files over. 17:56:56 INFO - Return code: 0 17:56:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:56:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:56:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/324f0277897d0381cea2ecffc21d7ab9746806a3b60a30e0e24d8e260edcd2a08c86d62d1970fccea9e8557b27a4bc955e9c3b6da28497395a072045c615e63a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52626f7e33138510d021ff5706b514c92062a679955fbf713dbaf8a42e4506750a48378057e513412b84739e9187ad895abf12f0df1e0b09b4f50fd7ad273fe0"} 17:56:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:56:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:56:56 INFO - Contents: 17:56:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/324f0277897d0381cea2ecffc21d7ab9746806a3b60a30e0e24d8e260edcd2a08c86d62d1970fccea9e8557b27a4bc955e9c3b6da28497395a072045c615e63a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52626f7e33138510d021ff5706b514c92062a679955fbf713dbaf8a42e4506750a48378057e513412b84739e9187ad895abf12f0df1e0b09b4f50fd7ad273fe0"} 17:56:56 INFO - Running post-run listener: copy_logs_to_upload_dir 17:56:56 INFO - Copying logs to upload dir... 17:56:56 INFO - mkdir: /builds/slave/test/build/upload/logs 17:56:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.697525 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-15 17:56:56.090167) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 17:56:56.093646) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/324f0277897d0381cea2ecffc21d7ab9746806a3b60a30e0e24d8e260edcd2a08c86d62d1970fccea9e8557b27a4bc955e9c3b6da28497395a072045c615e63a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52626f7e33138510d021ff5706b514c92062a679955fbf713dbaf8a42e4506750a48378057e513412b84739e9187ad895abf12f0df1e0b09b4f50fd7ad273fe0"} build_url:https://queue.taskcluster.net/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/MfuMI5_hRIWu0eG5y4yw-w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/324f0277897d0381cea2ecffc21d7ab9746806a3b60a30e0e24d8e260edcd2a08c86d62d1970fccea9e8557b27a4bc955e9c3b6da28497395a072045c615e63a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52626f7e33138510d021ff5706b514c92062a679955fbf713dbaf8a42e4506750a48378057e513412b84739e9187ad895abf12f0df1e0b09b4f50fd7ad273fe0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 17:56:56.121389) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:56:56.121914) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460766888.902648-1453851561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:56:56.205029) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 17:56:56.205606) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 17:56:56.206290) ========= ========= Total master_lag: 0.19 =========