builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1464431827.5 results: success (0) buildid: 20160525183450 builduid: 63f91898e679451db7d589c242ad058b revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:07.502376) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:07.502850) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:07.503130) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:07.518097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:07.518357) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-28 03:37:08-- 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% 223M=0s 2016-05-28 03:37:08 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086202 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:07.617938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:07.618245) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014871 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:07.667427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:37:07.667806) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 33693d8bdec17f07fc460ca7cc908ade88f97b86 --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 33693d8bdec17f07fc460ca7cc908ade88f97b86 --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=e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-28 03:37:08,702 truncating revision to first 12 chars 2016-05-28 03:37:08,702 Setting DEBUG logging. 2016-05-28 03:37:08,702 attempt 1/10 2016-05-28 03:37:08,702 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/33693d8bdec1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 03:37:09,357 unpacking tar archive at: mozilla-aurora-33693d8bdec1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.005107 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:37:08.686061) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:08.686374) ========= script_repo_revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:08.686765) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:08.687025) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:08.695298) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-28 03:37:08.695561) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:37:09 INFO - MultiFileLogger online at 20160528 03:37:09 in /builds/slave/test 03:37:09 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 03:37:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:37:09 INFO - {'append_to_log': False, 03:37:09 INFO - 'base_work_dir': '/builds/slave/test', 03:37:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:37:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:37:09 INFO - 'branch': 'Mozilla-Aurora', 03:37:09 INFO - 'buildbot_json_path': 'buildprops.json', 03:37:09 INFO - 'config_files': ('talos/linux_config.py',), 03:37:09 INFO - 'default_actions': ('clobber', 03:37:09 INFO - 'read-buildbot-config', 03:37:09 INFO - 'download-and-extract', 03:37:09 INFO - 'populate-webroot', 03:37:09 INFO - 'create-virtualenv', 03:37:09 INFO - 'install', 03:37:09 INFO - 'run-tests'), 03:37:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:37:09 INFO - 'download_minidump_stackwalk': True, 03:37:09 INFO - 'download_symbols': 'ondemand', 03:37:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:37:09 INFO - 'tooltool.py': '/tools/tooltool.py', 03:37:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:37:09 INFO - '/tools/misc-python/virtualenv.py')}, 03:37:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:37:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:37:09 INFO - 'installer_path': 'installer.exe', 03:37:09 INFO - 'log_level': 'info', 03:37:09 INFO - 'log_name': 'talos', 03:37:09 INFO - 'log_to_console': True, 03:37:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:37:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:37:09 INFO - 'opt_config_files': (), 03:37:09 INFO - 'pip_index': False, 03:37:09 INFO - 'sps_profile': False, 03:37:09 INFO - 'sps_profile_interval': 0, 03:37:09 INFO - 'suite': 'dromaeojs', 03:37:09 INFO - 'system_bits': '32', 03:37:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:37:09 INFO - 'title': 'talos-linux64-ix-067', 03:37:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:37:09 INFO - 'use_talos_json': True, 03:37:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:37:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:37:09 INFO - 'work_dir': 'build'} 03:37:09 INFO - ##### 03:37:09 INFO - ##### Running clobber step. 03:37:09 INFO - ##### 03:37:09 INFO - Running pre-action listener: _resource_record_pre_action 03:37:09 INFO - Running main action method: clobber 03:37:09 INFO - rmtree: /builds/slave/test/build 03:37:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:37:10 INFO - Running post-action listener: _resource_record_post_action 03:37:10 INFO - ##### 03:37:10 INFO - ##### Running read-buildbot-config step. 03:37:10 INFO - ##### 03:37:10 INFO - Running pre-action listener: _resource_record_pre_action 03:37:10 INFO - Running main action method: read_buildbot_config 03:37:10 INFO - Using buildbot properties: 03:37:10 INFO - { 03:37:10 INFO - "project": "", 03:37:10 INFO - "product": "firefox", 03:37:10 INFO - "script_repo_revision": "production", 03:37:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:37:10 INFO - "repository": "", 03:37:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:37:10 INFO - "buildid": "20160525183450", 03:37:10 INFO - "pgo_build": "True", 03:37:10 INFO - "basedir": "/builds/slave/test", 03:37:10 INFO - "buildnumber": 528, 03:37:10 INFO - "slavename": "talos-linux64-ix-067", 03:37:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:37:10 INFO - "platform": "ubuntu64_hw", 03:37:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:37:10 INFO - "branch": "mozilla-aurora", 03:37:10 INFO - "repo_path": "releases/mozilla-aurora", 03:37:10 INFO - "revision": "33693d8bdec17f07fc460ca7cc908ade88f97b86", 03:37:10 INFO - "stage_platform": "linux64-pgo", 03:37:10 INFO - "builduid": "63f91898e679451db7d589c242ad058b", 03:37:10 INFO - "slavebuilddir": "test" 03:37:10 INFO - } 03:37:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:37:10 INFO - Running post-action listener: _resource_record_post_action 03:37:10 INFO - ##### 03:37:10 INFO - ##### Running download-and-extract step. 03:37:10 INFO - ##### 03:37:10 INFO - Running pre-action listener: _resource_record_pre_action 03:37:10 INFO - Running main action method: download_and_extract 03:37:10 INFO - mkdir: /builds/slave/test/build/tests 03:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:10 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:37:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:37:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:37:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:37:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:37:12 INFO - Downloaded 1361 bytes. 03:37:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:37:12 INFO - Using the following test package requirements: 03:37:12 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:37:12 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:37:12 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:37:12 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:12 INFO - u'jsshell-linux-x86_64.zip'], 03:37:12 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:37:12 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:37:12 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:37:12 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:37:12 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:37:12 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:37:12 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:37: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')]} 03:37:12 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:37:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:37:13 INFO - Downloaded 24140640 bytes. 03:37:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:37:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:37:15 INFO - Return code: 0 03:37:15 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:37:15 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')]} 03:37:15 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:37:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:37:16 INFO - Downloaded 24140640 bytes. 03:37:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:37:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:37:17 INFO - Return code: 0 03:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:17 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:37:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:37:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:37:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:37:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:37:18 INFO - Downloaded 10840145 bytes. 03:37:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:37:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:37:18 INFO - Return code: 0 03:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:18 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:37:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:37:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:37:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:37:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:37:20 INFO - Downloaded 62759817 bytes. 03:37:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:37:20 INFO - mkdir: /builds/slave/test/properties 03:37:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:37:20 INFO - Writing to file /builds/slave/test/properties/build_url 03:37:20 INFO - Contents: 03:37:20 INFO - build_url:https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:37:21 INFO - Running post-action listener: _resource_record_post_action 03:37:21 INFO - Running post-action listener: set_extra_try_arguments 03:37:21 INFO - ##### 03:37:21 INFO - ##### Running populate-webroot step. 03:37:21 INFO - ##### 03:37:21 INFO - Running pre-action listener: _resource_record_pre_action 03:37:21 INFO - Running main action method: populate_webroot 03:37:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:37:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:37:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:37:21 INFO - '--tppagecycles', 03:37:21 INFO - '7'], 03:37:21 INFO - 'tests': ['tsvgm']}}, 03:37:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:37:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:37:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:37:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:37:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:37:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:37:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:21 INFO - 'talos_options': ['--disable-e10s'], 03:37:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:21 INFO - 'talos_options': ['--disable-e10s'], 03:37:21 INFO - 'tests': ['damp', 'tps']}, 03:37:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:21 INFO - 'tests': ['damp', 'tps']}, 03:37:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:37:21 INFO - 'tests': ['dromaeo_dom']}, 03:37:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:37:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:37:21 INFO - 'tests': ['a11yr', 03:37:21 INFO - 'ts_paint', 03:37:21 INFO - 'tpaint', 03:37:21 INFO - 'sessionrestore', 03:37:21 INFO - 'sessionrestore_no_auto_restore', 03:37:21 INFO - 'tabpaint']}, 03:37:21 INFO - 'other-e10s': {'tests': ['a11yr', 03:37:21 INFO - 'ts_paint', 03:37:21 INFO - 'tpaint', 03:37:21 INFO - 'sessionrestore', 03:37:21 INFO - 'sessionrestore_no_auto_restore', 03:37:21 INFO - 'tabpaint']}, 03:37:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:37:21 INFO - 'ts_paint', 03:37:21 INFO - 'tpaint', 03:37:21 INFO - 'sessionrestore', 03:37:21 INFO - 'sessionrestore_no_auto_restore', 03:37:21 INFO - 'tabpaint']}, 03:37:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:37:21 INFO - 'ts_paint', 03:37:21 INFO - 'tpaint', 03:37:21 INFO - 'sessionrestore', 03:37:21 INFO - 'sessionrestore_no_auto_restore', 03:37:21 INFO - 'tabpaint']}, 03:37:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:37:21 INFO - 'tests': ['a11yr', 03:37:21 INFO - 'ts_paint', 03:37:21 INFO - 'tpaint', 03:37:21 INFO - 'sessionrestore', 03:37:21 INFO - 'sessionrestore_no_auto_restore', 03:37:21 INFO - 'tabpaint']}, 03:37:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:37:21 INFO - 'tests': ['a11yr', 03:37:21 INFO - 'ts_paint', 03:37:21 INFO - 'tpaint', 03:37:21 INFO - 'sessionrestore', 03:37:21 INFO - 'sessionrestore_no_auto_restore', 03:37:21 INFO - 'tabpaint']}, 03:37:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:37:21 INFO - 'tests': ['tsvgx', 03:37:21 INFO - 'tsvgr_opacity', 03:37:21 INFO - 'tart', 03:37:21 INFO - 'tscrollx', 03:37:21 INFO - 'cart']}, 03:37:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:37:21 INFO - 'tsvgr_opacity', 03:37:21 INFO - 'tart', 03:37:21 INFO - 'tscrollx', 03:37:21 INFO - 'cart']}, 03:37:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:21 INFO - 'talos_options': ['--disable-e10s'], 03:37:21 INFO - 'tests': ['tp5o']}, 03:37:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:21 INFO - 'tests': ['tp5o']}, 03:37:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:21 INFO - 'talos_options': ['--disable-e10s', 03:37:21 INFO - '--xperf_path', 03:37:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:21 INFO - 'tests': ['tp5n']}, 03:37:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:21 INFO - 'talos_options': ['--xperf_path', 03:37:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:21 INFO - 'tests': ['tp5n']}}, 03:37:21 INFO - 'talos.zip': {'path': '', 03:37:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:37:21 INFO - Running post-action listener: _resource_record_post_action 03:37:21 INFO - ##### 03:37:21 INFO - ##### Running create-virtualenv step. 03:37:21 INFO - ##### 03:37:21 INFO - Running pre-action listener: _resource_record_pre_action 03:37:21 INFO - Running main action method: create_virtualenv 03:37:21 INFO - Creating virtualenv /builds/slave/test/build/venv 03:37:21 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 03:37:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:37:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:37:21 INFO - Using real prefix '/usr' 03:37:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:37:21 INFO - Installing distribute.............................................................................................................................................................................................done. 03:37:23 INFO - Installing pip.................done. 03:37:23 INFO - Return code: 0 03:37:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dddf8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc410>, '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 0x18dd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dd7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', '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 03:37:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:37:23 INFO - Using env: {'DISPLAY': ':0', 03:37:23 INFO - 'HOME': '/home/cltbld', 03:37:23 INFO - 'LANG': 'en_US.UTF-8', 03:37:23 INFO - 'LANGUAGE': 'en_US:en', 03:37:23 INFO - 'LOGNAME': 'cltbld', 03:37:23 INFO - 'MAIL': '/var/mail/cltbld', 03:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:23 INFO - 'MOZ_NO_REMOTE': '1', 03:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:23 INFO - 'NO_EM_RESTART': '1', 03:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:23 INFO - 'PWD': '/builds/slave/test', 03:37:23 INFO - 'SHELL': '/bin/bash', 03:37:23 INFO - 'SHLVL': '1', 03:37:23 INFO - 'TERM': 'linux', 03:37:23 INFO - 'TMOUT': '86400', 03:37:23 INFO - 'USER': 'cltbld', 03:37:23 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', 03:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:23 INFO - '_': '/tools/buildbot/bin/python'} 03:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:23 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 03:37:23 INFO - Cleaning up... 03:37:23 INFO - Return code: 0 03:37:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0dddf8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc410>, '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 0x18dd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dd7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', '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 03:37:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:37:23 INFO - Using env: {'DISPLAY': ':0', 03:37:23 INFO - 'HOME': '/home/cltbld', 03:37:23 INFO - 'LANG': 'en_US.UTF-8', 03:37:23 INFO - 'LANGUAGE': 'en_US:en', 03:37:23 INFO - 'LOGNAME': 'cltbld', 03:37:23 INFO - 'MAIL': '/var/mail/cltbld', 03:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:23 INFO - 'MOZ_NO_REMOTE': '1', 03:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:23 INFO - 'NO_EM_RESTART': '1', 03:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:23 INFO - 'PWD': '/builds/slave/test', 03:37:23 INFO - 'SHELL': '/bin/bash', 03:37:23 INFO - 'SHLVL': '1', 03:37:23 INFO - 'TERM': 'linux', 03:37:23 INFO - 'TMOUT': '86400', 03:37:23 INFO - 'USER': 'cltbld', 03:37:23 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', 03:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:23 INFO - '_': '/tools/buildbot/bin/python'} 03:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:24 INFO - Downloading/unpacking psutil>=0.7.1 03:37:24 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 03:37:24 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 03:37:24 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 03:37:24 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 03:37:24 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 03:37:24 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 03:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:37:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:26 INFO - Installing collected packages: psutil 03:37:26 INFO - Running setup.py install for psutil 03:37:26 INFO - building 'psutil._psutil_linux' extension 03:37:26 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 03:37:26 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 03:37:26 INFO - building 'psutil._psutil_posix' extension 03:37:26 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 03:37:26 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 03:37:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:26 INFO - Successfully installed psutil 03:37:26 INFO - Cleaning up... 03:37:26 INFO - Return code: 0 03:37:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:37:26 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')]} 03:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:26 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')]} 03:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:26 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 0x7f0dddf8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc410>, '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 0x18dd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dd7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', '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 03:37:26 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 03:37:26 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 03:37:26 INFO - Using env: {'DISPLAY': ':0', 03:37:26 INFO - 'HOME': '/home/cltbld', 03:37:26 INFO - 'LANG': 'en_US.UTF-8', 03:37:26 INFO - 'LANGUAGE': 'en_US:en', 03:37:26 INFO - 'LOGNAME': 'cltbld', 03:37:26 INFO - 'MAIL': '/var/mail/cltbld', 03:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:26 INFO - 'MOZ_NO_REMOTE': '1', 03:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:26 INFO - 'NO_EM_RESTART': '1', 03:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:26 INFO - 'PWD': '/builds/slave/test', 03:37:26 INFO - 'SHELL': '/bin/bash', 03:37:26 INFO - 'SHLVL': '1', 03:37:26 INFO - 'TERM': 'linux', 03:37:26 INFO - 'TMOUT': '86400', 03:37:26 INFO - 'USER': 'cltbld', 03:37:26 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', 03:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:26 INFO - '_': '/tools/buildbot/bin/python'} 03:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:37:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:37:28 INFO - Installing collected packages: mozsystemmonitor 03:37:28 INFO - Running setup.py install for mozsystemmonitor 03:37:28 INFO - Successfully installed mozsystemmonitor 03:37:28 INFO - Cleaning up... 03:37:28 INFO - Return code: 0 03:37:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:28 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 0x7f0dddf8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc410>, '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 0x18dd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dd7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', '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 03:37:28 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 03:37:28 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 03:37:28 INFO - Using env: {'DISPLAY': ':0', 03:37:28 INFO - 'HOME': '/home/cltbld', 03:37:28 INFO - 'LANG': 'en_US.UTF-8', 03:37:28 INFO - 'LANGUAGE': 'en_US:en', 03:37:28 INFO - 'LOGNAME': 'cltbld', 03:37:28 INFO - 'MAIL': '/var/mail/cltbld', 03:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:28 INFO - 'MOZ_NO_REMOTE': '1', 03:37:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:28 INFO - 'NO_EM_RESTART': '1', 03:37:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:28 INFO - 'PWD': '/builds/slave/test', 03:37:28 INFO - 'SHELL': '/bin/bash', 03:37:28 INFO - 'SHLVL': '1', 03:37:28 INFO - 'TERM': 'linux', 03:37:28 INFO - 'TMOUT': '86400', 03:37:28 INFO - 'USER': 'cltbld', 03:37:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', 03:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:28 INFO - '_': '/tools/buildbot/bin/python'} 03:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:29 INFO - Downloading/unpacking blobuploader==1.2.4 03:37:29 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 03:37:29 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 03:37:29 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 03:37:29 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 03:37:29 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 03:37:29 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 03:37:30 INFO - Downloading blobuploader-1.2.4.tar.gz 03:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:37:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:37:30 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 03:37:30 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 03:37:30 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 03:37:30 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 03:37:30 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 03:37:30 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 03:37:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:37:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:37:31 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 03:37:31 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 03:37:31 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 03:37:31 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 03:37:31 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 03:37:31 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 03:37:31 INFO - Downloading docopt-0.6.1.tar.gz 03:37:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:37:31 INFO - Installing collected packages: blobuploader, requests, docopt 03:37:31 INFO - Running setup.py install for blobuploader 03:37:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:37:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:37:31 INFO - Running setup.py install for requests 03:37:32 INFO - Running setup.py install for docopt 03:37:32 INFO - Successfully installed blobuploader requests docopt 03:37:32 INFO - Cleaning up... 03:37:32 INFO - Return code: 0 03:37:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:32 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 0x7f0dddf8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc410>, '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 0x18dd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dd7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', '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 03:37:32 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 03:37:32 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 03:37:32 INFO - Using env: {'DISPLAY': ':0', 03:37:32 INFO - 'HOME': '/home/cltbld', 03:37:32 INFO - 'LANG': 'en_US.UTF-8', 03:37:32 INFO - 'LANGUAGE': 'en_US:en', 03:37:32 INFO - 'LOGNAME': 'cltbld', 03:37:32 INFO - 'MAIL': '/var/mail/cltbld', 03:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:32 INFO - 'MOZ_NO_REMOTE': '1', 03:37:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:32 INFO - 'NO_EM_RESTART': '1', 03:37:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:32 INFO - 'PWD': '/builds/slave/test', 03:37:32 INFO - 'SHELL': '/bin/bash', 03:37:32 INFO - 'SHLVL': '1', 03:37:32 INFO - 'TERM': 'linux', 03:37:32 INFO - 'TMOUT': '86400', 03:37:32 INFO - 'USER': 'cltbld', 03:37:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', 03:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:32 INFO - '_': '/tools/buildbot/bin/python'} 03:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:32 INFO - Running setup.py (path:/tmp/pip-ysIEc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:32 INFO - Running setup.py (path:/tmp/pip-oSvrE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:32 INFO - Running setup.py (path:/tmp/pip-syOB7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:32 INFO - Running setup.py (path:/tmp/pip-PeQH7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:32 INFO - Running setup.py (path:/tmp/pip-hqyQbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:32 INFO - Running setup.py (path:/tmp/pip-RUjxrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:32 INFO - Running setup.py (path:/tmp/pip-WrKqKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:33 INFO - Running setup.py (path:/tmp/pip-EQUeKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:33 INFO - Running setup.py (path:/tmp/pip-km16S2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:33 INFO - Running setup.py (path:/tmp/pip-qsVB_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:33 INFO - Running setup.py (path:/tmp/pip-ATM4Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:33 INFO - Running setup.py (path:/tmp/pip-4Pqhl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:33 INFO - Running setup.py (path:/tmp/pip-58exXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:33 INFO - Running setup.py (path:/tmp/pip-l_Lffv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:33 INFO - Running setup.py (path:/tmp/pip-WzXA8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:33 INFO - Running setup.py (path:/tmp/pip-66dc6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:33 INFO - Running setup.py (path:/tmp/pip-j0nToL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:37:33 INFO - Running setup.py install for manifestparser 03:37:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:37:33 INFO - Running setup.py install for mozcrash 03:37:33 INFO - Running setup.py install for mozdebug 03:37:34 INFO - Running setup.py install for mozdevice 03:37:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Running setup.py install for mozfile 03:37:34 INFO - Running setup.py install for mozhttpd 03:37:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Running setup.py install for mozinfo 03:37:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Running setup.py install for mozInstall 03:37:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Running setup.py install for mozleak 03:37:34 INFO - Running setup.py install for mozlog 03:37:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Running setup.py install for moznetwork 03:37:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Running setup.py install for mozprocess 03:37:34 INFO - Running setup.py install for mozprofile 03:37:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:37:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:37:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:37:35 INFO - Running setup.py install for mozrunner 03:37:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:37:35 INFO - Running setup.py install for mozscreenshot 03:37:35 INFO - Running setup.py install for moztest 03:37:35 INFO - Running setup.py install for mozversion 03:37:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:37:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:37:35 INFO - Cleaning up... 03:37:35 INFO - Return code: 0 03:37:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:35 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 0x7f0dddf8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc410>, '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 0x18dd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dd7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', '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 03:37:35 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 03:37:35 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 03:37:35 INFO - Using env: {'DISPLAY': ':0', 03:37:35 INFO - 'HOME': '/home/cltbld', 03:37:35 INFO - 'LANG': 'en_US.UTF-8', 03:37:35 INFO - 'LANGUAGE': 'en_US:en', 03:37:35 INFO - 'LOGNAME': 'cltbld', 03:37:35 INFO - 'MAIL': '/var/mail/cltbld', 03:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:35 INFO - 'MOZ_NO_REMOTE': '1', 03:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:35 INFO - 'NO_EM_RESTART': '1', 03:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:35 INFO - 'PWD': '/builds/slave/test', 03:37:35 INFO - 'SHELL': '/bin/bash', 03:37:35 INFO - 'SHLVL': '1', 03:37:35 INFO - 'TERM': 'linux', 03:37:35 INFO - 'TMOUT': '86400', 03:37:35 INFO - 'USER': 'cltbld', 03:37:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', 03:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:35 INFO - '_': '/tools/buildbot/bin/python'} 03:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:35 INFO - Running setup.py (path:/tmp/pip-IuM8tW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:35 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)) 03:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:35 INFO - Running setup.py (path:/tmp/pip-y21U0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:35 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)) 03:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:35 INFO - Running setup.py (path:/tmp/pip-pAGgtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:35 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)) 03:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:35 INFO - Running setup.py (path:/tmp/pip-NQDk_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:36 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)) 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:36 INFO - Running setup.py (path:/tmp/pip-M40NQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:36 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)) 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:36 INFO - Running setup.py (path:/tmp/pip-qAgGd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:36 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)) 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:36 INFO - Running setup.py (path:/tmp/pip-vo79i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:36 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)) 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:36 INFO - Running setup.py (path:/tmp/pip-UgZM6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:36 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)) 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:36 INFO - Running setup.py (path:/tmp/pip-ruQEs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:36 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)) 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:36 INFO - Running setup.py (path:/tmp/pip-i8ylLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:36 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)) 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:36 INFO - Running setup.py (path:/tmp/pip-5CWAs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:36 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)) 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:36 INFO - Running setup.py (path:/tmp/pip-srTyZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:36 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)) 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:36 INFO - Running setup.py (path:/tmp/pip-dbMYRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:36 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)) 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:36 INFO - Running setup.py (path:/tmp/pip-SEDFUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:36 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)) 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:36 INFO - Running setup.py (path:/tmp/pip-ngCOig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:36 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)) 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:36 INFO - Running setup.py (path:/tmp/pip-s1kJod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:36 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)) 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:36 INFO - Running setup.py (path:/tmp/pip-d4gboF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:36 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)) 03:37:36 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)) 03:37:36 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)) 03:37:36 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)) 03:37:36 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)) 03:37:36 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)) 03:37:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:37:36 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 03:37:36 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 03:37:36 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 03:37:36 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 03:37:36 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 03:37:36 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 03:37:38 INFO - Downloading blessings-1.6.tar.gz 03:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:37:38 INFO - Installing collected packages: blessings 03:37:38 INFO - Running setup.py install for blessings 03:37:38 INFO - Successfully installed blessings 03:37:38 INFO - Cleaning up... 03:37:39 INFO - Return code: 0 03:37:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:39 INFO - Reading from file tmpfile_stdout 03:37:39 INFO - Current package versions: 03:37:39 INFO - argparse == 1.2.1 03:37:39 INFO - blessings == 1.6 03:37:39 INFO - blobuploader == 1.2.4 03:37:39 INFO - docopt == 0.6.1 03:37:39 INFO - manifestparser == 1.1 03:37:39 INFO - mozInstall == 1.12 03:37:39 INFO - mozcrash == 0.17 03:37:39 INFO - mozdebug == 0.1 03:37:39 INFO - mozdevice == 0.48 03:37:39 INFO - mozfile == 1.2 03:37:39 INFO - mozhttpd == 0.7 03:37:39 INFO - mozinfo == 0.9 03:37:39 INFO - mozleak == 0.1 03:37:39 INFO - mozlog == 3.1 03:37:39 INFO - moznetwork == 0.27 03:37:39 INFO - mozprocess == 0.22 03:37:39 INFO - mozprofile == 0.28 03:37:39 INFO - mozrunner == 6.11 03:37:39 INFO - mozscreenshot == 0.1 03:37:39 INFO - mozsystemmonitor == 0.0 03:37:39 INFO - moztest == 0.7 03:37:39 INFO - mozversion == 1.4 03:37:39 INFO - psutil == 3.1.1 03:37:39 INFO - requests == 1.2.3 03:37:39 INFO - wsgiref == 0.1.2 03:37:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:39 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 0x7f0dddf8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc410>, '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 0x18dd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dd7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', '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 03:37:39 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 03:37:39 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 03:37:39 INFO - Using env: {'DISPLAY': ':0', 03:37:39 INFO - 'HOME': '/home/cltbld', 03:37:39 INFO - 'LANG': 'en_US.UTF-8', 03:37:39 INFO - 'LANGUAGE': 'en_US:en', 03:37:39 INFO - 'LOGNAME': 'cltbld', 03:37:39 INFO - 'MAIL': '/var/mail/cltbld', 03:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:39 INFO - 'MOZ_NO_REMOTE': '1', 03:37:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:39 INFO - 'NO_EM_RESTART': '1', 03:37:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:39 INFO - 'PWD': '/builds/slave/test', 03:37:39 INFO - 'SHELL': '/bin/bash', 03:37:39 INFO - 'SHLVL': '1', 03:37:39 INFO - 'TERM': 'linux', 03:37:39 INFO - 'TMOUT': '86400', 03:37:39 INFO - 'USER': 'cltbld', 03:37:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', 03:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:39 INFO - '_': '/tools/buildbot/bin/python'} 03:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:39 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)) 03:37:39 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)) 03:37:39 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)) 03:37:39 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)) 03:37:39 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)) 03:37:39 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)) 03:37:39 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)) 03:37:39 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)) 03:37:39 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)) 03:37:39 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)) 03:37:39 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)) 03:37:39 INFO - Cleaning up... 03:37:39 INFO - Return code: 0 03:37:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dddf8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc410>, '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 0x18dd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dd7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', '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 03:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:37:39 INFO - Using env: {'DISPLAY': ':0', 03:37:39 INFO - 'HOME': '/home/cltbld', 03:37:39 INFO - 'LANG': 'en_US.UTF-8', 03:37:39 INFO - 'LANGUAGE': 'en_US:en', 03:37:39 INFO - 'LOGNAME': 'cltbld', 03:37:39 INFO - 'MAIL': '/var/mail/cltbld', 03:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:39 INFO - 'MOZ_NO_REMOTE': '1', 03:37:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:39 INFO - 'NO_EM_RESTART': '1', 03:37:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:39 INFO - 'PWD': '/builds/slave/test', 03:37:39 INFO - 'SHELL': '/bin/bash', 03:37:39 INFO - 'SHLVL': '1', 03:37:39 INFO - 'TERM': 'linux', 03:37:39 INFO - 'TMOUT': '86400', 03:37:39 INFO - 'USER': 'cltbld', 03:37:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', 03:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:39 INFO - '_': '/tools/buildbot/bin/python'} 03:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:39 INFO - Downloading/unpacking jsonschema 03:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:37:41 INFO - Downloading/unpacking functools32 (from jsonschema) 03:37:41 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 03:37:41 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 03:37:41 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 03:37:41 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 03:37:41 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 03:37:41 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 03:37:41 INFO - Downloading functools32-3.2.3-2.tar.gz 03:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:37:41 INFO - warning: no files found matching '*.txt' 03:37:41 INFO - no previously-included directories found matching 'build' 03:37:41 INFO - no previously-included directories found matching 'dist' 03:37:41 INFO - no previously-included directories found matching '.git*' 03:37:41 INFO - Installing collected packages: jsonschema, functools32 03:37:41 INFO - Running setup.py install for functools32 03:37:41 INFO - warning: no files found matching '*.txt' 03:37:41 INFO - no previously-included directories found matching 'build' 03:37:41 INFO - no previously-included directories found matching 'dist' 03:37:41 INFO - no previously-included directories found matching '.git*' 03:37:41 INFO - Successfully installed jsonschema functools32 03:37:41 INFO - Cleaning up... 03:37:42 INFO - Return code: 0 03:37:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dddf8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dc410>, '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 0x18dd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dd7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', '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 03:37:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:37:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:37:42 INFO - Using env: {'DISPLAY': ':0', 03:37:42 INFO - 'HOME': '/home/cltbld', 03:37:42 INFO - 'LANG': 'en_US.UTF-8', 03:37:42 INFO - 'LANGUAGE': 'en_US:en', 03:37:42 INFO - 'LOGNAME': 'cltbld', 03:37:42 INFO - 'MAIL': '/var/mail/cltbld', 03:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:42 INFO - 'MOZ_NO_REMOTE': '1', 03:37:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:42 INFO - 'NO_EM_RESTART': '1', 03:37:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:42 INFO - 'PWD': '/builds/slave/test', 03:37:42 INFO - 'SHELL': '/bin/bash', 03:37:42 INFO - 'SHLVL': '1', 03:37:42 INFO - 'TERM': 'linux', 03:37:42 INFO - 'TMOUT': '86400', 03:37:42 INFO - 'USER': 'cltbld', 03:37:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', 03:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:42 INFO - '_': '/tools/buildbot/bin/python'} 03:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:42 INFO - Downloading/unpacking flake8 03:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:37:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:37:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:37:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:37:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:37:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:37:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:37:44 INFO - no previously-included directories found matching 'docs/_build' 03:37:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:37:44 INFO - Running setup.py install for pep8 03:37:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:37:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:37:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:37:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:37:44 INFO - no previously-included directories found matching 'docs/_build' 03:37:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:37:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:37:45 INFO - Cleaning up... 03:37:45 INFO - Return code: 0 03:37:45 INFO - Running post-action listener: _resource_record_post_action 03:37:45 INFO - Running post-action listener: _start_resource_monitoring 03:37:45 INFO - Starting resource monitoring. 03:37:45 INFO - ##### 03:37:45 INFO - ##### Running install step. 03:37:45 INFO - ##### 03:37:45 INFO - Running pre-action listener: _resource_record_pre_action 03:37:45 INFO - Running main action method: install 03:37:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:45 INFO - Reading from file tmpfile_stdout 03:37:45 INFO - Detecting whether we're running mozinstall >=1.0... 03:37:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:37:45 INFO - Reading from file tmpfile_stdout 03:37:45 INFO - Output received: 03:37:45 INFO - Usage: mozinstall [options] installer 03:37:45 INFO - Options: 03:37:45 INFO - -h, --help show this help message and exit 03:37:45 INFO - -d DEST, --destination=DEST 03:37:45 INFO - Directory to install application into. [default: 03:37:45 INFO - "/builds/slave/test"] 03:37:45 INFO - --app=APP Application being installed. [default: firefox] 03:37:45 INFO - mkdir: /builds/slave/test/build/application 03:37:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:38:00 INFO - Reading from file tmpfile_stdout 03:38:00 INFO - Output received: 03:38:00 INFO - /builds/slave/test/build/application/firefox/firefox 03:38:00 INFO - Running post-action listener: _resource_record_post_action 03:38:00 INFO - ##### 03:38:00 INFO - ##### Running run-tests step. 03:38:00 INFO - ##### 03:38:00 INFO - Running pre-action listener: _resource_record_pre_action 03:38:00 INFO - Running main action method: run_tests 03:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:38:01 INFO - Python 2.7.3 03:38:01 INFO - Return code: 0 03:38:01 INFO - grabbing minidump binary from tooltool 03:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:01 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 0x18dc410>, '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 0x18dd310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dd7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:38:01 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 03:38:01 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 03:38:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:38:01 INFO - Return code: 0 03:38:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:38:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:38:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:38:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:38:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:38:01 INFO - Return code: 0 03:38:01 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/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 03:38:01 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/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 03:38:01 INFO - Using env: {'DISPLAY': ':0', 03:38:01 INFO - 'HOME': '/home/cltbld', 03:38:01 INFO - 'LANG': 'en_US.UTF-8', 03:38:01 INFO - 'LANGUAGE': 'en_US:en', 03:38:01 INFO - 'LOGNAME': 'cltbld', 03:38:01 INFO - 'MAIL': '/var/mail/cltbld', 03:38:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:38:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:01 INFO - 'MOZ_NO_REMOTE': '1', 03:38:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:01 INFO - 'NO_EM_RESTART': '1', 03:38:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:01 INFO - 'PWD': '/builds/slave/test', 03:38:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:38:01 INFO - 'SHELL': '/bin/bash', 03:38:01 INFO - 'SHLVL': '1', 03:38:01 INFO - 'TERM': 'linux', 03:38:01 INFO - 'TMOUT': '86400', 03:38:01 INFO - 'USER': 'cltbld', 03:38:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472', 03:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:01 INFO - '_': '/tools/buildbot/bin/python'} 03:38:01 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/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 03:38:02 INFO - mozversion application_buildid: 20160525183450 03:38:02 INFO - mozversion application_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 03:38:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:38:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:38:02 INFO - mozversion application_name: Firefox 03:38:02 INFO - mozversion application_remotingname: firefox-dev 03:38:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:38:02 INFO - mozversion application_vendor: Mozilla 03:38:02 INFO - mozversion application_version: 48.0a2 03:38:02 INFO - mozversion platform_buildid: 20160525183450 03:38:02 INFO - mozversion platform_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 03:38:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:38:02 INFO - mozversion platform_version: 48.0a2 03:38:02 INFO - using testdate: 1464431882 03:38:02 INFO - actual date: 1464431882 03:38:02 INFO - starting webserver on 'localhost:49646' 03:38:02 INFO - SUITE-START | Running 2 tests 03:38:02 INFO - TEST-START | dromaeo_css 03:38:02 INFO - operating with platform_type : linux_ 03:38:02 INFO - Initialising browser for dromaeo_css test... 03:38:02 INFO - TEST-INFO | started process 30289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRa7r6v/profile http://localhost:49646/getInfo.html) 03:38:05 INFO - PROCESS | 30289 | __metrics Screen width/height:1600/1200 03:38:05 INFO - PROCESS | 30289 | colorDepth:24 03:38:05 INFO - PROCESS | 30289 | Browser inner width/height: 1024/697 03:38:05 INFO - PROCESS | 30289 | __metrics 03:38:06 ERROR - PROCESS | 30289 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:38:07 INFO - TEST-INFO | 30289: exit 0 03:38:07 INFO - Browser initialized. 03:38:07 INFO - Running cycle 1/1 for dromaeo_css test... 03:38:07 INFO - TEST-INFO | started process 30380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRa7r6v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:19 INFO - PROCESS | 30380 | RSS: Main: 141729792 03:38:19 INFO - PROCESS | 30380 | 03:39:10 INFO - PROCESS | 30380 | 1464431950410 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] 03:41:17 INFO - PROCESS | 30380 | Cycle 1(1): loaded http://localhost:49646/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49646/tests/dromaeo/cssquery-ext.html) 03:41:18 INFO - PROCESS | 30380 | RSS: Main: 257187840 03:41:18 INFO - PROCESS | 30380 | 03:44:20 INFO - PROCESS | 30380 | Cycle 1(1): loaded http://localhost:49646/tests/dromaeo/cssquery-ext.html (next: http://localhost:49646/tests/dromaeo/cssquery-jquery.html) 03:44:21 INFO - PROCESS | 30380 | RSS: Main: 221515776 03:44:21 INFO - PROCESS | 30380 | 03:47:23 INFO - PROCESS | 30380 | Cycle 1(1): loaded http://localhost:49646/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49646/tests/dromaeo/cssquery-mootools.html) 03:47:23 INFO - PROCESS | 30380 | RSS: Main: 220229632 03:47:23 INFO - PROCESS | 30380 | 03:50:25 INFO - PROCESS | 30380 | Cycle 1(1): loaded http://localhost:49646/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49646/tests/dromaeo/cssquery-prototype.html) 03:50:26 INFO - PROCESS | 30380 | RSS: Main: 221569024 03:50:26 INFO - PROCESS | 30380 | 03:53:28 INFO - PROCESS | 30380 | Cycle 1(1): loaded http://localhost:49646/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49646/tests/dromaeo/cssquery-yui.html) 03:53:29 INFO - PROCESS | 30380 | RSS: Main: 214773760 03:53:29 INFO - PROCESS | 30380 | 03:56:31 INFO - PROCESS | 30380 | Cycle 1(1): loaded http://localhost:49646/tests/dromaeo/cssquery-yui.html (next: http://localhost:49646/tests/dromaeo/cssquery-dojo.html) 03:56:31 INFO - PROCESS | 30380 | RSS: Main: 257060864 03:56:31 INFO - PROCESS | 30380 | 03:56:31 INFO - PROCESS | 30380 | __start_tp_report 03:56:31 INFO - PROCESS | 30380 | _x_x_mozilla_page_load 03:56:31 INFO - PROCESS | 30380 | _x_x_mozilla_page_load_details 03:56:31 INFO - PROCESS | 30380 | |i|pagename|runs| 03:56:31 INFO - PROCESS | 30380 | |0;dojo.html;3345.7992520448774;3383.221858972436;3387.3056023515173;3429.8628054877804;3441.5698037745283;5596.132599447093;5623.831285061449;5648.9549433354805;5660.462256085676;5674.233978412913;5602.38373778884;5610.775568977236;5634.9718251408685;5660.830175094754;5668.546516278698;5007.7496125193775;5102.081625307453;5194.37667479901;5244.8688782780355;5264.236685680574;5216.76524556394;5274.235235890794;5284.471552844723;5284.524392804647;5289.391719952197;5114.948850511503;5178.352705911761;5202.609804264676;5221.686698798066;5247.160454327309;5243.895122097556;5289.259503669489;5292.2326262691695;5292.920606190891;5325.520703136697;5038.470960549126;5095.184770436749;5165.74171291434;5173.146430838907;5190.922136167923;5541.362743284533;5551.361593416768;5583.190437386596;5591.440855914376;5601.80393686219;6149.2620885494025;6168.75324987;6169;6171.290301615327;6172.47533959614;6112.938870611281;6177.227846519185;6183.81448556544;6201.286852011986;6202.844928876769;5707.1153971134545;5749.137629355589;5752.02215623345;5756.510696590837;5759.625624334447;6131.14164017038;6248.593841400295;6254.249490061222;6254.8123556293385;6270.6864656766975;6020.909686354708;6110.572259941761;6116.021436570128;6117.005394430456;6118.1128736332985;6113.777244551107;6125.111858780541;6125.908111378333;6134.877302453926;6136;5983.042713165873;6021.6989150542295;6086.543509236825;6094.475852123928;6095.3904609538695;6096.451319381277;6110.923300256584;6113.52842193302;6114.66235542843;6124.983169013088;4583.831123063597;4614.538546145359;4617.8383756568355;4632.888106854398;4649.070185962821;4065.288574499451;4079.530853951774;4117.094239267356;4128.2156390285745;4156.792160392029;5708.80019199326;5767.596268261182;5775.5668324875805;5777.277840269966;5797.797077102281;6095.299040610298;6138.7237574309265;6140.355262697352;6141.263048434127;6143.139960405547;5683.090705487102;5687.857803554862;5690.089585666274;5722.77108915647;5757.337906140848;5220.973895130576;5236;5238.1618940969265;5238.60710446718;5244.318238628954;6343.5876668016435;6352.904706429407;6357.205349331333;6358.300586935434;6358.427741503287;5940.584159108821;6137.662428566472;6175.722092505758;6188.381161883955;6205.751769929152;6347.492200623847;6350;6353.650549219652;6356.491480681442;6365.936340636535;5869.501092407022;6015.1278064681255;6015.518758499222;6015.699215039143;6020.698965051817;6065.272167339947;6114.084479019511;6119.441623354662;6120.386183820548;6140.969295153495;5981.401859813984;5995.400459953969;6010.368911264254;6015.458608725061;6020.157177995172;5873.794417195378;5932.436418540232;5948.702564871825;5974.074018527135;5987.550933679904;5814.76740930358;5858.560607954506;5881.9705901470215;5886.558508111823;5929.318128415288;5993.910091348721;6004.699765011645;6016.578839481194;6023.397660233942;6024.819255422344;5743.913841292468;5826;5833.066709326487;5900;5915.852103697442 03:56:31 INFO - PROCESS | 30380 | |1;ext.html;609.481940350702;659.6602749583964;663.3996233408767;663.8307231655928;671.9496037797163;32611.184720382003;33005.50491742623;40559.18881622366;41517.58482415175;41544.169116617646;44550;44986.325205121946;45133.323000155026;45158.54841451585;45182.54817451825;8761.342899282563;8939.77650558738;8944.284457243404;8950.686725964593;8959.417637853552;8751.3874028818;8867.379283450162;8867.822643547157;8871.891013623297;8873.68942087027;8810.38327317088;9130.680426185085;9134;9134.08659134088;9135;9005.414648047921;9012.143846334588;9051.23064539515;9054.049324820931;9069.727908162733;8962.910370896272;9080.77298067547;9081.228095611881;9084.77288067797;9092.181703646638;44873.551264487265;45185.77407112943;45296.3205551917;45309.77345113286;45414;3965.20695860829;3978.244133614604;4066.857659981916;4137.027798467358;4290.206311832289;34234.14414639629;34443;34550.654493455244;34834.65165348339;36089;4536.77316134192;4628.699134556243;4629.421322334708;4634.119517291738;4641.907161856744;330174.09477715706;330823;331605.7357705689;332290;332945;39314.21371572553;40091;61910.69044654748;62807.37192628106;62869.685651571446;37415.4387684185;37525;37527;37554.624453755656;37575.62424375776;15950.680986380208;15981.36074557028;16061.839381606269;16079.598010049842;16105.597360066093;13633.454661813417;13703.520376786764;13739.519116830863;13754.93122534381;13759.312034398241;9179.403338783091;9336.206422454032;9349.906500934903;9399.718008459757;9406.95296523513;3518.5074089627474;3559.483874838186;3586.28274345132;3609.9097522562147;3641.2353405785084;1211.1582450197204;1273.3505911984769;1283.4545318239711;1305.7453796509778;1318.3276528970102;34440;34622.307553849285;34948.825255873555;35184;35366.115847103516;1252.536561472243;1274.4137696659454;1277.399622177575;1293.502001729341;1293.6442478318538;18155.909220453814;18228.817711822976;18608.906955465136;18616.906915465337;18618;494278;495336;496089;496339;500361;63714.36285637177;64529.80556263828;64612.353876460635;64613.676931615984;64648.67675661686;1422.7510185717458;1463.6560408303826;1487.2861026707026;1508.2911031815029;1515.9848401516065;30511.542326865558;33747;33784.66215337815;34015.489767654;34173.65826341705;49932.750336248086;49942.25086623631;50324.24513632225;50356.49643503518;50374.24438633497;330270;332446;332943;334872;335160;27343.316417089733;30035;30399;30698.846505767327;30704.232394190323;49742;49843.25235121549;50132.248016280515;50479.24281135859;51255;40966.79516602398;41338.1732365345;41962.37056444217;42589.787051064544;42627.7868610655;41740.58259417367;42044.78977605092;43080.35379469248;43242.783786080865;44023;43971.78014109909;44632.33051504295;44958;45214;45287.320690189015;34936.475952861234;37300;37570.8121459391;37789.43315850209;38540.80729596334;29754;29850.701492984794;30057.451166508294;30100.397992040474;30190.69809301879 03:56:31 INFO - PROCESS | 30380 | |2;jquery.html;408.98568550100714;414.6040531292615;421.91772604342145;422.67242886762756;429.2980976104069;18375.72436413455;18865.622687546256;19420.126094325755;19474.610507789836;20325.49186270344;19290.421287361365;19788.802111978875;19789.802101978978;20561.69157462639;20580.073896674647;5638.154276858473;5738.081906894898;5752.482276595106;5797.739101740411;5890.764369425239;5762.222100016507;5844.620099693528;5852.531797456215;5856.414358564152;5899.557533185007;5706;5760;5771.134329850514;5830.32951210612;5842.036064049426;5611.6352437091455;5711;5734.655920644754;5748.5975981681295;5788.768449262025;5143.742812859379;5181.1969144782615;5193.428722840485;5262.789488420459;5268.078086334876;23714;24049.639255411184;24403.26790196297;24688.13591524306;24699.382515437257;2630.7237740037212;2632.315597944529;3002.384511175204;3104.8602812873473;3259.6740325967453;14816;14939.17834519101;15251.161186134757;15492.845071549253;15501.302441390164;2039.8062184092487;2091.9477013074793;2120.342693764938;2146.152269853415;2200.460887082675;81324.59337703332;86840;87503.56248218782;87565.56217218873;89693;11527.48126334317;11595.884041159648;11667.824982625267;11680;12005.399730013465;16501.33994640201;16591.917040414963;16754.497365079067;16898.91550542264;16913.238904249338;8784.824303513893;8820.294376449869;8908.688195913111;8959.5968181432;9033;8645.43804652708;8807.383483156118;8850.291976641853;8898.199162075314;8917.152870477294;4882.170031094723;5003.274525193827;5043.823466178666;5055.469175736568;5063.746812659352;1981.383974247005;1995.6407846587754;2017.0519855667812;2019.7273368095414;2030.8273796727149;1007.0483393193508;1069.1446842525947;1084.3927400655657;1095.1020163466042;1141.7374003979132;18910.243590256512;19454.8054519453;19802.50493737668;20062.398128056182;20560.485987850425;1123.8707548631849;1143.9084873210122;1152.9596464123883;1153.7577108807077;1179.7994340962057;10545.261831671864;11054.392008439612;11070.335779853234;11386.316820990767;11617.186796924134;498206;555908;570034.4494832581;595636;601566;55418.16872746831;57717;68506.65746671334;101804;104020;1090.2586241355796;1096.1395304685943;1120.232640641147;1121.9495122719334;1123.4775829239443;17462.563435914202;17949.192286346886;18122.72815907736;18173.54566135857;18734.34429795005;36052;38966.80516597399;39758.2048359037;40684.79657601693;40865;48899;49094;49210.75394623004;49245.50754492409;49618.2633607822;8329.583520824055;8516.616752246287;8571.485710857369;8875.334349923653;8885.333599979898;12383.938080309541;13427.798583021067;13544.932275338955;13618.659533511742;13666.86333136656;11498.54005839757;11602.825957610812;11683.707907302385;11865.644030679094;12134.514619415124;11390.715232119263;11475.655730328104;11559.479823408135;11668.766624667629;11764.176507644725;6296.5277604178955;10654.360738355723;11873.881261187278;12317.199382040139;12768.361581921052;8451.577421129043;8461.61922713467;8592.699255526277;8999.415038022507;9158.175764181256;11156.274842135235;11981.221220620631;12152.574659887216;12546.247225166519;12654.114212005072 03:56:31 INFO - PROCESS | 30380 | |3;mootools.html;1402.5301523989476;1534.5319677498358;1545.4590893187385;1735.3839387017608;1862.9347972820945;8100.756977290684;8265.628046737897;8283.461574997636;8293.958530207348;8297.668093276261;8090;8201.91798082019;8246.628901699423;8271.421000529965;8283.047449543305;2063.9793602063937;2331.4171457135717;2385.1413491143176;2430.501747141832;2464.950700985988;2380.27401642499;2385.677933478984;2390.880455977203;2395.832291739579;2396.1733202045266;2279.407354087941;2355.764423557639;2362.314928670692;2371.336025912747;2373.8575685458927;2054.5171884607107;2327.837051406402;2400.2799160251857;2401.267613377919;2401.6757737705534;2337.801286890616;2382.4996750682376;2388.2118900762707;2394.9521009579885;2404.074431343945;8136.674533018672;8164.877526837102;8175.877361839577;8176.509409435453;8181.8363632727605;5158.9484105158845;5223.947760522422;5252;5255.737213139328;5259;3371.2246183377715;3455;3478.5303983962094;3498.2303893143467;3501.4047611906035;1169.8303745956873;1176.8293597428326;1210.2012671636764;1213.993930030353;1257.6478585995935;11647.767044659144;11702.531898724126;11811.763764724743;11844.940775296154;11857.229280096766;4674.649401294916;4707.340972263886;4768.856934291976;4803.831865884677;4818.518148185223;10174.4912754362;10182.490875456198;10185.541650625739;10214.131798797185;10227.43749093807;4622.514635963243;5413.188021796762;5428.321459817523;5440.619156659075;5444.50999410055;4522.615577675934;4616.884577885513;4644.210484217691;4651.930221046687;4660.13787449323;4077.510698716173;4111.424400583921;4167.187398457272;4173.436586060843;4175.68682348825;1328.7076843094503;1331.2744554217975;1338.9799153012518;1352.9932350338186;1362.4822567424314;1024.626011505795;1102.9558817647205;1119.652907598647;1125.178619607691;1126;6198.442140207313;6231.688415579203;6307.148534947815;6307.842303942438;6393.488520918316;436.7314101827417;445.39426380123007;448.78458339996985;454.2164765779005;456.05141306083266;4362.454693163355;4391.165678521134;4393.560643935581;4397.1865204937185;4410.206162890647;10009.349392289478;10328.431936243429;10417.531211095367;10460.790784184273;10465.267431279737;10065.295429320024;10130.797384052277;10137;10302;10350.585976560853;7552.207018263113;7713.9971803666285;7742.341900938371;7748.302652761278;7807.141214466517;5848.6783226921225;5972.372900845522;6045.063015232646;6070.453659170696;6237.438630523275;9075.092490750872;9099.226565741721;9277.721668349961;9294.302927280345;9365.57854896545;9353.438793672402;9363.953180234055;9546.618135274512;9658.082482164184;9679.564419600994;6912.377885990285;7077.964610176916;7297.124345078624;7740.187280335484;7835.764927052198;7737.961310193413;7747.612619369122;7760.92239077602;7776.144624091458;7805.570693611906;7095;7243.058402407864;7260.96369518149;7348.154962179417;7432.033835601337;7103.751368702071;7148.499605027599;7187.496875218684;7191.7842464726145;7271.527350722397;6850.794476165723;6911.930880691129;6912.861742765217;6913.516053876381;6915.170179578483;5231.084560202025;5277.4194838566955;5317.946820531745;5356.223347614652;5467.6719396836315;5380.973095134499;5433.646812957145;5464.153056276284;5475.589330800126;5522.337319521523 03:56:31 INFO - PROCESS | 30380 | |4;prototype.html;349.5054497885493;349.59097855509054;351.7889266440136;353.47156001777347;356.31409536641956;6219.067139929013;6226.688665566715;6227.564070515065;6269.090981807635;6279.466245369149;6133.938660613392;6235.8752824943585;6253.781117660883;6267.527131124193;6312.621242725429;4526.615237704799;4644.767761611923;4775.785089670956;4781.235002399617;4798.208295631217;4728.219843725781;4760.690555113906;4778.904421911559;4785.497522760113;4788.28175773635;4536.591706746392;4732.432108147027;4736.64475164364;4740.07568524138;4746.810127594909;4595.379623750784;4669.392978912737;4673.369095172159;4677.158111539921;4762.261849413347;4150.875473735793;4158.771267580282;4161.91676166478;4171.019810344566;4175.373693945902;5994.820155395345;6004.939950600482;6006.699665016732;6008.459238668497;6012.398760123952;5518.834434966958;5531.225628411985;5535.086710692731;5538.861528461781;5538.864532770773;6444.806655800334;6590.275069742324;6603.80188594343;6609.801705948829;6613.041109039163;4614.723116613014;4622.838200662961;4628.074385122955;4634.675572709912;4639.350490931272;6847.144106986627;6856.211535673411;6871.99999999995;6874.621895795729;6888.276730943229;4697.624190064855;4699.060187962421;4704.647151463654;4705.388299521041;4723.45680246776;4795.304680821331;4797.56821886032;4802.399700037496;4802.471728109905;4804.735739534359;5472.781088756485;5505.229267902497;5512;5517.751701173376;5522.0336441122645;6529.706163222666;6645.102911107036;6646.53474256807;6650.767223147167;6672.132622759011;1667.749837524381;1679.5717092141426;1682.8401301876547;1687.392538686072;1693.7120689482817;1053.5417093564324;1085.592902661502;1107.983380249297;1115.776844631077;1122.7529943412599;6231.345708700612;6399.9360006400275;6413.102165696806;6431.5819471734185;6434.646094464756;6876.553024053421;6888.793336199922;6898.655067246617;6907.654617269116;6913.792586222421;6398.5521013528605;6412.198475190601;6414.102025716404;6419.967900160469;6428.067930150102;3664.303782281358;3704.129529560551;3707;3712.9603710960973;3713.925721485555;6955.200151982485;7159.749408770668;7179.1026121734785;7186.317299856505;7194.604296763729;7007.684654190573;7023.367896889305;7032.12098487689;7043.964780176067;7048.612326321999;7156.105486814148;7166.570005799668;7171.964140179266;7184.353408193392;7188.353048225685;6838.350356716104;6865.382115609619;6895.965520172367;6903;6910.516263861481;6525.967370163119;6729.259781423942;6823.147106611674;6828.248892621708;6840.042394064735;7096.042034325506;7122.928770712434;7123;7130.358267755927;7140.178879428932;4664.766761661971;4690.413698287714;4692.601128904082;4700.670953033255;4702.012577358793;6787.457003439812;6854.554453960476;6858.417034552119;6860.588364698134;6861.382475577222;6509.1863517060365;6682.264950855305;6699.832504187434;6725.428338591275;6728;6629.4696424284975;6668.699908504226;6671.432928200963;6672.499562532732;6674.799756007327;6547.312532184052;6561.311062338385;6562.50781191403;6565.901511477236;6567.44176744982;6730.730770769114;6733.528652994243;6749.358810912955;6749.595024298558;6752.426043786333;6414.134091897534;6551.312112228147;6561.1470508833545;6567.638779867153;6567.704453299518 03:56:31 INFO - PROCESS | 30380 | |5;yui.html;873.0004145253685;888.6978427334709;889.8531742262527;898.8651702244663;906.6871929184429;15502.534923952271;15777.684446311066;15778.447754328587;16574.337026518955;17275.82724172758;15488.225588720547;15690.529284121494;15757.212139393014;15793.763093553605;15813.288402021908;744.731896517256;891.7369376034053;895.9193672569451;908.3868388837541;911.5943405184695;888.942218755782;901.8557030875062;902.9322800789967;903.5346796399859;904.7014485219895;940.8682784410188;941.016637613692;941.5715849288557;941.7268991992314;942.7218970403713;768.9461737678365;775.244136966456;926.4024704065907;936.6862101196108;939.4785893828922;688.2463702246033;690.3200347657553;690.3890057299276;690.4234963805178;690.9067275917787;15170.544883653509;15186.164760938143;15259.313330900137;15279.236038198156;15282.465113720966;13924.651883702887;14340.282985850667;14450.421983120663;14497.927510362486;14537.127772333693;12232.388380580935;12328.137030407875;12331.5067397304;12468.251904885736;12630.873691263061;3930.390789427643;3932.7836968966694;3979.7214195006363;3984.7011474139267;4031.5363733170766;60070;60217;60241.69879150576;60445.39554604442;60682.696586517224;11140.777184456265;11216.66350009501;11248.887511124947;11808.88191118095;11828.34944078084;21049.579008419747;21569.245076422565;21613.351599452042;21614.243501477686;21638.675419868716;8584.656613735506;8946.584422205968;8956.731298061068;9001.54992250385;9030.548472576345;4487.842925497657;4651.186042442559;4696.342512048316;4729.6452766042685;4740.762961851962;3543.574771027442;3582.0507565495163;3582.6775590196485;3593.0298819318637;3594.676479116892;671.6272468779777;684.555039224508;684.6816230452863;688.896665500179;701.992980070203;708.922018577956;756.9129550101699;785.285390294829;824.2828738996991;836.9916300837035;9415.340926135243;9637.71086867395;9817.460039697742;9862.309638325392;9893.35693179941;646.5603389695052;771.2441807029143;774.4772278711847;778.1518145221736;780.3367137932712;4605.125026245003;4763.166445871959;4803.855884323476;4827;4850.223964165716;64981.35018649847;65765;66083;66093.669531653;66136.33863661397;53877.73061134669;53988.19017714737;54482.45517544853;55227.44772552304;55387.72306138444;51882.74058629683;52247.73876130595;52587.73706131368;52928.20607690888;53602.731986339815;9945.751356216153;9990;10100.242481813746;10148.391096534231;10188.796224075626;38501.42247866228;38901.2219755609;39249;40599.59400405958;40601;46168.30747538722;47931.520684792704;49171.75414122907;49608.255876161165;50899.236511451614;12307.326779721365;12373.072019598387;12505.874941250471;12694.428750706056;12732.936335318263;13624.386902589209;14040.1575905446;14308.713825723635;14418.279086045866;14937.626559336104;13550.903872749039;13704.451821927012;13727.656808579866;13867.653308667364;14167.008309418241;13532.661683457993;13552.661183470493;13607.863921361055;13770.724585508033;13787.51743688966;13072;13298.401571929093;13391.263480508665;13396.397162127923;13500.257485838372;10355.84466232992;10431.634892778717;10441.216908731723;10540.947295263475;10545.789084218119;10950.671479855617;10957.780844383227;11160.832587511031;11166.609168679057;11311.7737645245 03:56:31 INFO - PROCESS | 30380 | __end_tp_report 03:56:31 INFO - PROCESS | 30380 | __start_cc_report 03:56:31 INFO - PROCESS | 30380 | _x_x_mozilla_cycle_collect,928 03:56:31 INFO - PROCESS | 30380 | __end_cc_report 03:56:31 INFO - PROCESS | 30380 | __startTimestamp1464432991985__endTimestamp 03:56:31 INFO - PROCESS | 30380 | 03:56:31 INFO - PROCESS | 30380 | ------- Summary: start ------- 03:56:31 INFO - PROCESS | 30380 | Number of tests: 6 03:56:32 INFO - PROCESS | 30380 | 03:56:32 INFO - PROCESS | 30380 | [#0] dojo.html Cycles:165 Average:5672.47 Median:5881.97 stddev:644.76 (11.0%) stddev-sans-first:620.37 03:56:32 INFO - PROCESS | 30380 | Values: 3345.8 3383.2 3387.3 3429.9 3441.6 5596.1 5623.8 5649.0 5660.5 5674.2 5602.4 5610.8 5635.0 5660.8 5668.5 5007.7 5102.1 5194.4 5244.9 5264.2 5216.8 5274.2 5284.5 5284.5 5289.4 5114.9 5178.4 5202.6 5221.7 5247.2 5243.9 5289.3 5292.2 5292.9 5325.5 5038.5 5095.2 5165.7 5173.1 5190.9 5541.4 5551.4 5583.2 5591.4 5601.8 6149.3 6168.8 6169.0 6171.3 6172.5 6112.9 6177.2 6183.8 6201.3 6202.8 5707.1 5749.1 5752.0 5756.5 5759.6 6131.1 6248.6 6254.2 6254.8 6270.7 6020.9 6110.6 6116.0 6117.0 6118.1 6113.8 6125.1 6125.9 6134.9 6136.0 5983.0 6021.7 6086.5 6094.5 6095.4 6096.5 6110.9 6113.5 6114.7 6125.0 4583.8 4614.5 4617.8 4632.9 4649.1 4065.3 4079.5 4117.1 4128.2 4156.8 5708.8 5767.6 5775.6 5777.3 5797.8 6095.3 6138.7 6140.4 6141.3 6143.1 5683.1 5687.9 5690.1 5722.8 5757.3 5221.0 5236.0 5238.2 5238.6 5244.3 6343.6 6352.9 6357.2 6358.3 6358.4 5940.6 6137.7 6175.7 6188.4 6205.8 6347.5 6350.0 6353.7 6356.5 6365.9 5869.5 6015.1 6015.5 6015.7 6020.7 6065.3 6114.1 6119.4 6120.4 6141.0 5981.4 5995.4 6010.4 6015.5 6020.2 5873.8 5932.4 5948.7 5974.1 5987.6 5814.8 5858.6 5882.0 5886.6 5929.3 5993.9 6004.7 6016.6 6023.4 6024.8 5743.9 5826.0 5833.1 5900.0 5915.9 03:56:32 INFO - PROCESS | 30380 | 03:56:32 INFO - PROCESS | 30380 | [#1] ext.html Cycles:180 Average:55391.21 Median:22827.31 stddev:104335.85 (457.1%) stddev-sans-first:104547.47 03:56:32 INFO - PROCESS | 30380 | Values: 609.5 659.7 663.4 663.8 671.9 32611.2 33005.5 40559.2 41517.6 41544.2 44550.0 44986.3 45133.3 45158.5 45182.5 8761.3 8939.8 8944.3 8950.7 8959.4 8751.4 8867.4 8867.8 8871.9 8873.7 8810.4 9130.7 9134.0 9134.1 9135.0 9005.4 9012.1 9051.2 9054.0 9069.7 8962.9 9080.8 9081.2 9084.8 9092.2 44873.6 45185.8 45296.3 45309.8 45414.0 3965.2 3978.2 4066.9 4137.0 4290.2 34234.1 34443.0 34550.7 34834.7 36089.0 4536.8 4628.7 4629.4 4634.1 4641.9 330174.1 330823.0 331605.7 332290.0 332945.0 39314.2 40091.0 61910.7 62807.4 62869.7 37415.4 37525.0 37527.0 37554.6 37575.6 15950.7 15981.4 16061.8 16079.6 16105.6 13633.5 13703.5 13739.5 13754.9 13759.3 9179.4 9336.2 9349.9 9399.7 9407.0 3518.5 3559.5 3586.3 3609.9 3641.2 1211.2 1273.4 1283.5 1305.7 1318.3 34440.0 34622.3 34948.8 35184.0 35366.1 1252.5 1274.4 1277.4 1293.5 1293.6 18155.9 18228.8 18608.9 18616.9 18618.0 494278.0 495336.0 496089.0 496339.0 500361.0 63714.4 64529.8 64612.4 64613.7 64648.7 1422.8 1463.7 1487.3 1508.3 1516.0 30511.5 33747.0 33784.7 34015.5 34173.7 49932.8 49942.3 50324.2 50356.5 50374.2 330270.0 332446.0 332943.0 334872.0 335160.0 27343.3 30035.0 30399.0 30698.8 30704.2 49742.0 49843.3 50132.2 50479.2 51255.0 40966.8 41338.2 41962.4 42589.8 42627.8 41740.6 42044.8 43080.4 43242.8 44023.0 43971.8 44632.3 44958.0 45214.0 45287.3 34936.5 37300.0 37570.8 37789.4 38540.8 29754.0 29850.7 30057.5 30100.4 30190.7 03:56:32 INFO - PROCESS | 30380 | 03:56:32 INFO - PROCESS | 30380 | [#2] jquery.html Cycles:180 Average:30883.72 Median:12957.23 stddev:92671.03 (715.2%) stddev-sans-first:92902.74 03:56:32 INFO - PROCESS | 30380 | Values: 409.0 414.6 421.9 422.7 429.3 18375.7 18865.6 19420.1 19474.6 20325.5 19290.4 19788.8 19789.8 20561.7 20580.1 5638.2 5738.1 5752.5 5797.7 5890.8 5762.2 5844.6 5852.5 5856.4 5899.6 5706.0 5760.0 5771.1 5830.3 5842.0 5611.6 5711.0 5734.7 5748.6 5788.8 5143.7 5181.2 5193.4 5262.8 5268.1 23714.0 24049.6 24403.3 24688.1 24699.4 2630.7 2632.3 3002.4 3104.9 3259.7 14816.0 14939.2 15251.2 15492.8 15501.3 2039.8 2091.9 2120.3 2146.2 2200.5 81324.6 86840.0 87503.6 87565.6 89693.0 11527.5 11595.9 11667.8 11680.0 12005.4 16501.3 16591.9 16754.5 16898.9 16913.2 8784.8 8820.3 8908.7 8959.6 9033.0 8645.4 8807.4 8850.3 8898.2 8917.2 4882.2 5003.3 5043.8 5055.5 5063.7 1981.4 1995.6 2017.1 2019.7 2030.8 1007.0 1069.1 1084.4 1095.1 1141.7 18910.2 19454.8 19802.5 20062.4 20560.5 1123.9 1143.9 1153.0 1153.8 1179.8 10545.3 11054.4 11070.3 11386.3 11617.2 498206.0 555908.0 570034.4 595636.0 601566.0 55418.2 57717.0 68506.7 101804.0 104020.0 1090.3 1096.1 1120.2 1121.9 1123.5 17462.6 17949.2 18122.7 18173.5 18734.3 36052.0 38966.8 39758.2 40684.8 40865.0 48899.0 49094.0 49210.8 49245.5 49618.3 8329.6 8516.6 8571.5 8875.3 8885.3 12383.9 13427.8 13544.9 13618.7 13666.9 11498.5 11602.8 11683.7 11865.6 12134.5 11390.7 11475.7 11559.5 11668.8 11764.2 6296.5 10654.4 11873.9 12317.2 12768.4 8451.6 8461.6 8592.7 8999.4 9158.2 11156.3 11981.2 12152.6 12546.2 12654.1 03:56:32 INFO - PROCESS | 30380 | 03:56:32 INFO - PROCESS | 30380 | [#3] mootools.html Cycles:180 Average:5626.32 Median:4667.39 stddev:3059.46 (65.5%) stddev-sans-first:3051.57 03:56:32 INFO - PROCESS | 30380 | Values: 1402.5 1534.5 1545.5 1735.4 1862.9 8100.8 8265.6 8283.5 8294.0 8297.7 8090.0 8201.9 8246.6 8271.4 8283.0 2064.0 2331.4 2385.1 2430.5 2465.0 2380.3 2385.7 2390.9 2395.8 2396.2 2279.4 2355.8 2362.3 2371.3 2373.9 2054.5 2327.8 2400.3 2401.3 2401.7 2337.8 2382.5 2388.2 2395.0 2404.1 8136.7 8164.9 8175.9 8176.5 8181.8 5158.9 5223.9 5252.0 5255.7 5259.0 3371.2 3455.0 3478.5 3498.2 3501.4 1169.8 1176.8 1210.2 1214.0 1257.6 11647.8 11702.5 11811.8 11844.9 11857.2 4674.6 4707.3 4768.9 4803.8 4818.5 10174.5 10182.5 10185.5 10214.1 10227.4 4622.5 5413.2 5428.3 5440.6 5444.5 4522.6 4616.9 4644.2 4651.9 4660.1 4077.5 4111.4 4167.2 4173.4 4175.7 1328.7 1331.3 1339.0 1353.0 1362.5 1024.6 1103.0 1119.7 1125.2 1126.0 6198.4 6231.7 6307.1 6307.8 6393.5 436.7 445.4 448.8 454.2 456.1 4362.5 4391.2 4393.6 4397.2 4410.2 10009.3 10328.4 10417.5 10460.8 10465.3 10065.3 10130.8 10137.0 10302.0 10350.6 7552.2 7714.0 7742.3 7748.3 7807.1 5848.7 5972.4 6045.1 6070.5 6237.4 9075.1 9099.2 9277.7 9294.3 9365.6 9353.4 9364.0 9546.6 9658.1 9679.6 6912.4 7078.0 7297.1 7740.2 7835.8 7738.0 7747.6 7760.9 7776.1 7805.6 7095.0 7243.1 7261.0 7348.2 7432.0 7103.8 7148.5 7187.5 7191.8 7271.5 6850.8 6911.9 6912.9 6913.5 6915.2 5231.1 5277.4 5317.9 5356.2 5467.7 5381.0 5433.6 5464.2 5475.6 5522.3 03:56:32 INFO - PROCESS | 30380 | 03:56:32 INFO - PROCESS | 30380 | [#4] prototype.html Cycles:180 Average:5557.41 Median:6355.59 stddev:1686.91 (26.5%) stddev-sans-first:1645.73 03:56:32 INFO - PROCESS | 30380 | Values: 349.5 349.6 351.8 353.5 356.3 6219.1 6226.7 6227.6 6269.1 6279.5 6133.9 6235.9 6253.8 6267.5 6312.6 4526.6 4644.8 4775.8 4781.2 4798.2 4728.2 4760.7 4778.9 4785.5 4788.3 4536.6 4732.4 4736.6 4740.1 4746.8 4595.4 4669.4 4673.4 4677.2 4762.3 4150.9 4158.8 4161.9 4171.0 4175.4 5994.8 6004.9 6006.7 6008.5 6012.4 5518.8 5531.2 5535.1 5538.9 5538.9 6444.8 6590.3 6603.8 6609.8 6613.0 4614.7 4622.8 4628.1 4634.7 4639.4 6847.1 6856.2 6872.0 6874.6 6888.3 4697.6 4699.1 4704.6 4705.4 4723.5 4795.3 4797.6 4802.4 4802.5 4804.7 5472.8 5505.2 5512.0 5517.8 5522.0 6529.7 6645.1 6646.5 6650.8 6672.1 1667.7 1679.6 1682.8 1687.4 1693.7 1053.5 1085.6 1108.0 1115.8 1122.8 6231.3 6399.9 6413.1 6431.6 6434.6 6876.6 6888.8 6898.7 6907.7 6913.8 6398.6 6412.2 6414.1 6420.0 6428.1 3664.3 3704.1 3707.0 3713.0 3713.9 6955.2 7159.7 7179.1 7186.3 7194.6 7007.7 7023.4 7032.1 7044.0 7048.6 7156.1 7166.6 7172.0 7184.4 7188.4 6838.4 6865.4 6896.0 6903.0 6910.5 6526.0 6729.3 6823.1 6828.2 6840.0 7096.0 7122.9 7123.0 7130.4 7140.2 4664.8 4690.4 4692.6 4700.7 4702.0 6787.5 6854.6 6858.4 6860.6 6861.4 6509.2 6682.3 6699.8 6725.4 6728.0 6629.5 6668.7 6671.4 6672.5 6674.8 6547.3 6561.3 6562.5 6565.9 6567.4 6730.7 6733.5 6749.4 6749.6 6752.4 6414.1 6551.3 6561.1 6567.6 6567.7 03:56:32 INFO - PROCESS | 30380 | 03:56:32 INFO - PROCESS | 30380 | [#5] yui.html Cycles:180 Average:15854.08 Median:25409.75 stddev:18169.79 (71.5%) stddev-sans-first:18185.93 03:56:32 INFO - PROCESS | 30380 | Values: 873.0 888.7 889.9 898.9 906.7 15502.5 15777.7 15778.4 16574.3 17275.8 15488.2 15690.5 15757.2 15793.8 15813.3 744.7 891.7 895.9 908.4 911.6 888.9 901.9 902.9 903.5 904.7 940.9 941.0 941.6 941.7 942.7 768.9 775.2 926.4 936.7 939.5 688.2 690.3 690.4 690.4 690.9 15170.5 15186.2 15259.3 15279.2 15282.5 13924.7 14340.3 14450.4 14497.9 14537.1 12232.4 12328.1 12331.5 12468.3 12630.9 3930.4 3932.8 3979.7 3984.7 4031.5 60070.0 60217.0 60241.7 60445.4 60682.7 11140.8 11216.7 11248.9 11808.9 11828.3 21049.6 21569.2 21613.4 21614.2 21638.7 8584.7 8946.6 8956.7 9001.5 9030.5 4487.8 4651.2 4696.3 4729.6 4740.8 3543.6 3582.1 3582.7 3593.0 3594.7 671.6 684.6 684.7 688.9 702.0 708.9 756.9 785.3 824.3 837.0 9415.3 9637.7 9817.5 9862.3 9893.4 646.6 771.2 774.5 778.2 780.3 4605.1 4763.2 4803.9 4827.0 4850.2 64981.4 65765.0 66083.0 66093.7 66136.3 53877.7 53988.2 54482.5 55227.4 55387.7 51882.7 52247.7 52587.7 52928.2 53602.7 9945.8 9990.0 10100.2 10148.4 10188.8 38501.4 38901.2 39249.0 40599.6 40601.0 46168.3 47931.5 49171.8 49608.3 50899.2 12307.3 12373.1 12505.9 12694.4 12732.9 13624.4 14040.2 14308.7 14418.3 14937.6 13550.9 13704.5 13727.7 13867.7 14167.0 13532.7 13552.7 13607.9 13770.7 13787.5 13072.0 13298.4 13391.3 13396.4 13500.3 10355.8 10431.6 10441.2 10540.9 10545.8 10950.7 10957.8 11160.8 11166.6 11311.8 03:56:32 INFO - PROCESS | 30380 | -------- Summary: end -------- 03:56:32 INFO - PROCESS | 30380 | 03:56:32 INFO - TEST-INFO | 30380: exit 0 03:56:32 INFO - TEST-OK | dromaeo_css | took 1110510ms 03:56:32 INFO - TEST-START | kraken 03:56:32 INFO - operating with platform_type : linux_ 03:56:32 INFO - Initialising browser for kraken test... 03:56:32 INFO - TEST-INFO | started process 30567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIBcQ1f/profile http://localhost:49646/getInfo.html) 03:56:36 INFO - PROCESS | 30567 | __metrics Screen width/height:1600/1200 03:56:36 INFO - PROCESS | 30567 | colorDepth:24 03:56:36 INFO - PROCESS | 30567 | Browser inner width/height: 1024/697 03:56:36 INFO - PROCESS | 30567 | __metrics 03:56:37 ERROR - PROCESS | 30567 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:56:37 INFO - TEST-INFO | 30567: exit 0 03:56:37 INFO - Browser initialized. 03:56:37 INFO - Running cycle 1/1 for kraken test... 03:56:37 INFO - TEST-INFO | started process 30656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIBcQ1f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:49 INFO - PROCESS | 30656 | RSS: Main: 142258176 03:56:49 INFO - PROCESS | 30656 | 03:56:52 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49646/tests/kraken/driver.html?testName=audio-beat-detection) 03:56:52 INFO - PROCESS | 30656 | RSS: Main: 197218304 03:56:52 INFO - PROCESS | 30656 | 03:56:55 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49646/tests/kraken/driver.html?testName=audio-dft) 03:56:56 INFO - PROCESS | 30656 | RSS: Main: 181657600 03:56:56 INFO - PROCESS | 30656 | 03:56:58 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49646/tests/kraken/driver.html?testName=audio-fft) 03:56:59 INFO - PROCESS | 30656 | RSS: Main: 272138240 03:56:59 INFO - PROCESS | 30656 | 03:57:01 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49646/tests/kraken/driver.html?testName=audio-oscillator) 03:57:02 INFO - PROCESS | 30656 | RSS: Main: 178008064 03:57:02 INFO - PROCESS | 30656 | 03:57:04 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49646/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:57:05 INFO - PROCESS | 30656 | RSS: Main: 177041408 03:57:05 INFO - PROCESS | 30656 | 03:57:07 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49646/tests/kraken/driver.html?testName=imaging-darkroom) 03:57:08 INFO - PROCESS | 30656 | RSS: Main: 211116032 03:57:08 INFO - PROCESS | 30656 | 03:57:11 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49646/tests/kraken/driver.html?testName=imaging-desaturate) 03:57:12 INFO - PROCESS | 30656 | RSS: Main: 211013632 03:57:12 INFO - PROCESS | 30656 | 03:57:15 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49646/tests/kraken/driver.html?testName=json-parse-financial) 03:57:15 INFO - PROCESS | 30656 | RSS: Main: 211230720 03:57:15 INFO - PROCESS | 30656 | 03:57:17 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49646/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:57:17 INFO - PROCESS | 30656 | RSS: Main: 189296640 03:57:17 INFO - PROCESS | 30656 | 03:57:19 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:57:20 INFO - PROCESS | 30656 | RSS: Main: 195096576 03:57:20 INFO - PROCESS | 30656 | 03:57:22 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:57:22 INFO - PROCESS | 30656 | RSS: Main: 208539648 03:57:22 INFO - PROCESS | 30656 | 03:57:25 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:57:25 INFO - PROCESS | 30656 | RSS: Main: 215117824 03:57:25 INFO - PROCESS | 30656 | 03:57:28 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:29 INFO - PROCESS | 30656 | RSS: Main: 213594112 03:57:29 INFO - PROCESS | 30656 | 03:57:30 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49646/tests/kraken/driver.html?testName=ai-astar) 03:57:31 INFO - PROCESS | 30656 | RSS: Main: 276889600 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | __start_tp_report 03:57:31 INFO - PROCESS | 30656 | _x_x_mozilla_page_load 03:57:31 INFO - PROCESS | 30656 | _x_x_mozilla_page_load_details 03:57:31 INFO - PROCESS | 30656 | |i|pagename|runs| 03:57:31 INFO - PROCESS | 30656 | |0;ai-astar;111;110;108;109;110;111;105;110;109;110 03:57:31 INFO - PROCESS | 30656 | |1;audio-beat-detection;150;125;156;175;127;155;167;129;189;126 03:57:31 INFO - PROCESS | 30656 | |2;audio-dft;162;161;160;161;161;161;161;162;160;163 03:57:31 INFO - PROCESS | 30656 | |3;audio-fft;76;77;75;170;76;77;82;76;176;76 03:57:31 INFO - PROCESS | 30656 | |4;audio-oscillator;91;92;151;93;93;93;144;92;93;148 03:57:31 INFO - PROCESS | 30656 | |5;imaging-gaussian-blur;118;117;117;117;116;117;117;117;117;117 03:57:31 INFO - PROCESS | 30656 | |6;imaging-darkroom;146;145;146;145;146;146;146;145;145;145 03:57:31 INFO - PROCESS | 30656 | |7;imaging-desaturate;95;94;95;95;94;94;94;94;94;95 03:57:31 INFO - PROCESS | 30656 | |8;json-parse-financial;57;53;56;53;53;55;53;76;53;52 03:57:31 INFO - PROCESS | 30656 | |9;json-stringify-tinderbox;57;58;58;58;59;58;58;57;58;57 03:57:31 INFO - PROCESS | 30656 | |10;stanford-crypto-aes;72;81;73;72;73;73;73;74;74;73 03:57:31 INFO - PROCESS | 30656 | |11;stanford-crypto-ccm;112;115;117;114;113;110;113;125;146;129 03:57:31 INFO - PROCESS | 30656 | |12;stanford-crypto-pbkdf2;160;166;164;160;160;156;154;162;158;159 03:57:31 INFO - PROCESS | 30656 | |13;stanford-crypto-sha256-iterative;67;66;66;66;68;67;63;65;66;64 03:57:31 INFO - PROCESS | 30656 | __end_tp_report 03:57:31 INFO - PROCESS | 30656 | __start_cc_report 03:57:31 INFO - PROCESS | 30656 | _x_x_mozilla_cycle_collect,1598 03:57:31 INFO - PROCESS | 30656 | __end_cc_report 03:57:31 INFO - PROCESS | 30656 | __startTimestamp1464433051055__endTimestamp 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | ------- Summary: start ------- 03:57:31 INFO - PROCESS | 30656 | Number of tests: 14 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:1.77 (1.6%) stddev-sans-first:1.76 03:57:31 INFO - PROCESS | 30656 | Values: 111.0 110.0 108.0 109.0 110.0 111.0 105.0 110.0 109.0 110.0 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:155.50 stddev:22.77 (14.6%) stddev-sans-first:24.15 03:57:31 INFO - PROCESS | 30656 | Values: 150.0 125.0 156.0 175.0 127.0 155.0 167.0 129.0 189.0 126.0 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 03:57:31 INFO - PROCESS | 30656 | Values: 162.0 161.0 160.0 161.0 161.0 161.0 161.0 162.0 160.0 163.0 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | [#3] audio-fft Cycles:10 Average:96.10 Median:76.00 stddev:40.60 (53.4%) stddev-sans-first:42.41 03:57:31 INFO - PROCESS | 30656 | Values: 76.0 77.0 75.0 170.0 76.0 77.0 82.0 76.0 176.0 76.0 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:92.50 stddev:26.74 (28.9%) stddev-sans-first:27.56 03:57:31 INFO - PROCESS | 30656 | Values: 91.0 92.0 151.0 93.0 93.0 93.0 144.0 92.0 93.0 148.0 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 03:57:31 INFO - PROCESS | 30656 | Values: 118.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 03:57:31 INFO - PROCESS | 30656 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 03:57:31 INFO - PROCESS | 30656 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:54.00 stddev:7.17 (13.3%) stddev-sans-first:7.60 03:57:31 INFO - PROCESS | 30656 | Values: 57.0 53.0 56.0 53.0 53.0 55.0 53.0 76.0 53.0 52.0 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 03:57:31 INFO - PROCESS | 30656 | Values: 57.0 58.0 58.0 58.0 59.0 58.0 58.0 57.0 58.0 57.0 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:73.00 stddev:2.62 (3.6%) stddev-sans-first:2.69 03:57:31 INFO - PROCESS | 30656 | Values: 72.0 81.0 73.0 72.0 73.0 73.0 73.0 74.0 74.0 73.0 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:116.00 stddev:11.11 (9.6%) stddev-sans-first:11.45 03:57:31 INFO - PROCESS | 30656 | Values: 112.0 115.0 117.0 114.0 113.0 110.0 113.0 125.0 146.0 129.0 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:160.00 stddev:3.54 (2.2%) stddev-sans-first:3.76 03:57:31 INFO - PROCESS | 30656 | Values: 160.0 166.0 164.0 160.0 160.0 156.0 154.0 162.0 158.0 159.0 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - PROCESS | 30656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.48 (2.2%) stddev-sans-first:1.50 03:57:31 INFO - PROCESS | 30656 | Values: 67.0 66.0 66.0 66.0 68.0 67.0 63.0 65.0 66.0 64.0 03:57:31 INFO - PROCESS | 30656 | -------- Summary: end -------- 03:57:31 INFO - PROCESS | 30656 | 03:57:31 INFO - TEST-INFO | 30656: exit 0 03:57:31 INFO - TEST-OK | kraken | took 59298ms 03:57:31 INFO - SUITE-END | took 1169s 03:57:32 INFO - Completed test suite (00:19:30) 03:57:32 INFO - javascript benchmark 03:57:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3345.7992520448774, 3383.221858972436, 3387.3056023515173, 3429.8628054877804, 3441.5698037745283, 5596.132599447093, 5623.831285061449, 5648.9549433354805, 5660.462256085676, 5674.233978412913, 5602.38373778884, 5610.775568977236, 5634.9718251408685, 5660.830175094754, 5668.546516278698, 5007.7496125193775, 5102.081625307453, 5194.37667479901, 5244.8688782780355, 5264.236685680574, 5216.76524556394, 5274.235235890794, 5284.471552844723, 5284.524392804647, 5289.391719952197, 5114.948850511503, 5178.352705911761, 5202.609804264676, 5221.686698798066, 5247.160454327309, 5243.895122097556, 5289.259503669489, 5292.2326262691695, 5292.920606190891, 5325.520703136697, 5038.470960549126, 5095.184770436749, 5165.74171291434, 5173.146430838907, 5190.922136167923, 5541.362743284533, 5551.361593416768, 5583.190437386596, 5591.440855914376, 5601.80393686219, 6149.2620885494025, 6168.75324987, 6169.0, 6171.290301615327, 6172.47533959614, 6112.938870611281, 6177.227846519185, 6183.81448556544, 6201.286852011986, 6202.844928876769, 5707.1153971134545, 5749.137629355589, 5752.02215623345, 5756.510696590837, 5759.625624334447, 6131.14164017038, 6248.593841400295, 6254.249490061222, 6254.8123556293385, 6270.6864656766975, 6020.909686354708, 6110.572259941761, 6116.021436570128, 6117.005394430456, 6118.1128736332985, 6113.777244551107, 6125.111858780541, 6125.908111378333, 6134.877302453926, 6136.0, 5983.042713165873, 6021.6989150542295, 6086.543509236825, 6094.475852123928, 6095.3904609538695, 6096.451319381277, 6110.923300256584, 6113.52842193302, 6114.66235542843, 6124.983169013088, 4583.831123063597, 4614.538546145359, 4617.8383756568355, 4632.888106854398, 4649.070185962821, 4065.288574499451, 4079.530853951774, 4117.094239267356, 4128.2156390285745, 4156.792160392029, 5708.80019199326, 5767.596268261182, 5775.5668324875805, 5777.277840269966, 5797.797077102281, 6095.299040610298, 6138.7237574309265, 6140.355262697352, 6141.263048434127, 6143.139960405547, 5683.090705487102, 5687.857803554862, 5690.089585666274, 5722.77108915647, 5757.337906140848, 5220.973895130576, 5236.0, 5238.1618940969265, 5238.60710446718, 5244.318238628954, 6343.5876668016435, 6352.904706429407, 6357.205349331333, 6358.300586935434, 6358.427741503287, 5940.584159108821, 6137.662428566472, 6175.722092505758, 6188.381161883955, 6205.751769929152, 6347.492200623847, 6350.0, 6353.650549219652, 6356.491480681442, 6365.936340636535, 5869.501092407022, 6015.1278064681255, 6015.518758499222, 6015.699215039143, 6020.698965051817, 6065.272167339947, 6114.084479019511, 6119.441623354662, 6120.386183820548, 6140.969295153495, 5981.401859813984, 5995.400459953969, 6010.368911264254, 6015.458608725061, 6020.157177995172, 5873.794417195378, 5932.436418540232, 5948.702564871825, 5974.074018527135, 5987.550933679904, 5814.76740930358, 5858.560607954506, 5881.9705901470215, 5886.558508111823, 5929.318128415288, 5993.910091348721, 6004.699765011645, 6016.578839481194, 6023.397660233942, 6024.819255422344, 5743.913841292468, 5826.0, 5833.066709326487, 5900.0, 5915.852103697442], "value": 5629.387912146936, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.481940350702, 659.6602749583964, 663.3996233408767, 663.8307231655928, 671.9496037797163, 32611.184720382003, 33005.50491742623, 40559.18881622366, 41517.58482415175, 41544.169116617646, 44550.0, 44986.325205121946, 45133.323000155026, 45158.54841451585, 45182.54817451825, 8761.342899282563, 8939.77650558738, 8944.284457243404, 8950.686725964593, 8959.417637853552, 8751.3874028818, 8867.379283450162, 8867.822643547157, 8871.891013623297, 8873.68942087027, 8810.38327317088, 9130.680426185085, 9134.0, 9134.08659134088, 9135.0, 9005.414648047921, 9012.143846334588, 9051.23064539515, 9054.049324820931, 9069.727908162733, 8962.910370896272, 9080.77298067547, 9081.228095611881, 9084.77288067797, 9092.181703646638, 44873.551264487265, 45185.77407112943, 45296.3205551917, 45309.77345113286, 45414.0, 3965.20695860829, 3978.244133614604, 4066.857659981916, 4137.027798467358, 4290.206311832289, 34234.14414639629, 34443.0, 34550.654493455244, 34834.65165348339, 36089.0, 4536.77316134192, 4628.699134556243, 4629.421322334708, 4634.119517291738, 4641.907161856744, 330174.09477715706, 330823.0, 331605.7357705689, 332290.0, 332945.0, 39314.21371572553, 40091.0, 61910.69044654748, 62807.37192628106, 62869.685651571446, 37415.4387684185, 37525.0, 37527.0, 37554.624453755656, 37575.62424375776, 15950.680986380208, 15981.36074557028, 16061.839381606269, 16079.598010049842, 16105.597360066093, 13633.454661813417, 13703.520376786764, 13739.519116830863, 13754.93122534381, 13759.312034398241, 9179.403338783091, 9336.206422454032, 9349.906500934903, 9399.718008459757, 9406.95296523513, 3518.5074089627474, 3559.483874838186, 3586.28274345132, 3609.9097522562147, 3641.2353405785084, 1211.1582450197204, 1273.3505911984769, 1283.4545318239711, 1305.7453796509778, 1318.3276528970102, 34440.0, 34622.307553849285, 34948.825255873555, 35184.0, 35366.115847103516, 1252.536561472243, 1274.4137696659454, 1277.399622177575, 1293.502001729341, 1293.6442478318538, 18155.909220453814, 18228.817711822976, 18608.906955465136, 18616.906915465337, 18618.0, 494278.0, 495336.0, 496089.0, 496339.0, 500361.0, 63714.36285637177, 64529.80556263828, 64612.353876460635, 64613.676931615984, 64648.67675661686, 1422.7510185717458, 1463.6560408303826, 1487.2861026707026, 1508.2911031815029, 1515.9848401516065, 30511.542326865558, 33747.0, 33784.66215337815, 34015.489767654, 34173.65826341705, 49932.750336248086, 49942.25086623631, 50324.24513632225, 50356.49643503518, 50374.24438633497, 330270.0, 332446.0, 332943.0, 334872.0, 335160.0, 27343.316417089733, 30035.0, 30399.0, 30698.846505767327, 30704.232394190323, 49742.0, 49843.25235121549, 50132.248016280515, 50479.24281135859, 51255.0, 40966.79516602398, 41338.1732365345, 41962.37056444217, 42589.787051064544, 42627.7868610655, 41740.58259417367, 42044.78977605092, 43080.35379469248, 43242.783786080865, 44023.0, 43971.78014109909, 44632.33051504295, 44958.0, 45214.0, 45287.320690189015, 34936.475952861234, 37300.0, 37570.8121459391, 37789.43315850209, 38540.80729596334, 29754.0, 29850.701492984794, 30057.451166508294, 30100.397992040474, 30190.69809301879], "value": 19635.260900976045, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.98568550100714, 414.6040531292615, 421.91772604342145, 422.67242886762756, 429.2980976104069, 18375.72436413455, 18865.622687546256, 19420.126094325755, 19474.610507789836, 20325.49186270344, 19290.421287361365, 19788.802111978875, 19789.802101978978, 20561.69157462639, 20580.073896674647, 5638.154276858473, 5738.081906894898, 5752.482276595106, 5797.739101740411, 5890.764369425239, 5762.222100016507, 5844.620099693528, 5852.531797456215, 5856.414358564152, 5899.557533185007, 5706.0, 5760.0, 5771.134329850514, 5830.32951210612, 5842.036064049426, 5611.6352437091455, 5711.0, 5734.655920644754, 5748.5975981681295, 5788.768449262025, 5143.742812859379, 5181.1969144782615, 5193.428722840485, 5262.789488420459, 5268.078086334876, 23714.0, 24049.639255411184, 24403.26790196297, 24688.13591524306, 24699.382515437257, 2630.7237740037212, 2632.315597944529, 3002.384511175204, 3104.8602812873473, 3259.6740325967453, 14816.0, 14939.17834519101, 15251.161186134757, 15492.845071549253, 15501.302441390164, 2039.8062184092487, 2091.9477013074793, 2120.342693764938, 2146.152269853415, 2200.460887082675, 81324.59337703332, 86840.0, 87503.56248218782, 87565.56217218873, 89693.0, 11527.48126334317, 11595.884041159648, 11667.824982625267, 11680.0, 12005.399730013465, 16501.33994640201, 16591.917040414963, 16754.497365079067, 16898.91550542264, 16913.238904249338, 8784.824303513893, 8820.294376449869, 8908.688195913111, 8959.5968181432, 9033.0, 8645.43804652708, 8807.383483156118, 8850.291976641853, 8898.199162075314, 8917.152870477294, 4882.170031094723, 5003.274525193827, 5043.823466178666, 5055.469175736568, 5063.746812659352, 1981.383974247005, 1995.6407846587754, 2017.0519855667812, 2019.7273368095414, 2030.8273796727149, 1007.0483393193508, 1069.1446842525947, 1084.3927400655657, 1095.1020163466042, 1141.7374003979132, 18910.243590256512, 19454.8054519453, 19802.50493737668, 20062.398128056182, 20560.485987850425, 1123.8707548631849, 1143.9084873210122, 1152.9596464123883, 1153.7577108807077, 1179.7994340962057, 10545.261831671864, 11054.392008439612, 11070.335779853234, 11386.316820990767, 11617.186796924134, 498206.0, 555908.0, 570034.4494832581, 595636.0, 601566.0, 55418.16872746831, 57717.0, 68506.65746671334, 101804.0, 104020.0, 1090.2586241355796, 1096.1395304685943, 1120.232640641147, 1121.9495122719334, 1123.4775829239443, 17462.563435914202, 17949.192286346886, 18122.72815907736, 18173.54566135857, 18734.34429795005, 36052.0, 38966.80516597399, 39758.2048359037, 40684.79657601693, 40865.0, 48899.0, 49094.0, 49210.75394623004, 49245.50754492409, 49618.2633607822, 8329.583520824055, 8516.616752246287, 8571.485710857369, 8875.334349923653, 8885.333599979898, 12383.938080309541, 13427.798583021067, 13544.932275338955, 13618.659533511742, 13666.86333136656, 11498.54005839757, 11602.825957610812, 11683.707907302385, 11865.644030679094, 12134.514619415124, 11390.715232119263, 11475.655730328104, 11559.479823408135, 11668.766624667629, 11764.176507644725, 6296.5277604178955, 10654.360738355723, 11873.881261187278, 12317.199382040139, 12768.361581921052, 8451.577421129043, 8461.61922713467, 8592.699255526277, 8999.415038022507, 9158.175764181256, 11156.274842135235, 11981.221220620631, 12152.574659887216, 12546.247225166519, 12654.114212005072], "value": 9611.086243393891, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1402.5301523989476, 1534.5319677498358, 1545.4590893187385, 1735.3839387017608, 1862.9347972820945, 8100.756977290684, 8265.628046737897, 8283.461574997636, 8293.958530207348, 8297.668093276261, 8090.0, 8201.91798082019, 8246.628901699423, 8271.421000529965, 8283.047449543305, 2063.9793602063937, 2331.4171457135717, 2385.1413491143176, 2430.501747141832, 2464.950700985988, 2380.27401642499, 2385.677933478984, 2390.880455977203, 2395.832291739579, 2396.1733202045266, 2279.407354087941, 2355.764423557639, 2362.314928670692, 2371.336025912747, 2373.8575685458927, 2054.5171884607107, 2327.837051406402, 2400.2799160251857, 2401.267613377919, 2401.6757737705534, 2337.801286890616, 2382.4996750682376, 2388.2118900762707, 2394.9521009579885, 2404.074431343945, 8136.674533018672, 8164.877526837102, 8175.877361839577, 8176.509409435453, 8181.8363632727605, 5158.9484105158845, 5223.947760522422, 5252.0, 5255.737213139328, 5259.0, 3371.2246183377715, 3455.0, 3478.5303983962094, 3498.2303893143467, 3501.4047611906035, 1169.8303745956873, 1176.8293597428326, 1210.2012671636764, 1213.993930030353, 1257.6478585995935, 11647.767044659144, 11702.531898724126, 11811.763764724743, 11844.940775296154, 11857.229280096766, 4674.649401294916, 4707.340972263886, 4768.856934291976, 4803.831865884677, 4818.518148185223, 10174.4912754362, 10182.490875456198, 10185.541650625739, 10214.131798797185, 10227.43749093807, 4622.514635963243, 5413.188021796762, 5428.321459817523, 5440.619156659075, 5444.50999410055, 4522.615577675934, 4616.884577885513, 4644.210484217691, 4651.930221046687, 4660.13787449323, 4077.510698716173, 4111.424400583921, 4167.187398457272, 4173.436586060843, 4175.68682348825, 1328.7076843094503, 1331.2744554217975, 1338.9799153012518, 1352.9932350338186, 1362.4822567424314, 1024.626011505795, 1102.9558817647205, 1119.652907598647, 1125.178619607691, 1126.0, 6198.442140207313, 6231.688415579203, 6307.148534947815, 6307.842303942438, 6393.488520918316, 436.7314101827417, 445.39426380123007, 448.78458339996985, 454.2164765779005, 456.05141306083266, 4362.454693163355, 4391.165678521134, 4393.560643935581, 4397.1865204937185, 4410.206162890647, 10009.349392289478, 10328.431936243429, 10417.531211095367, 10460.790784184273, 10465.267431279737, 10065.295429320024, 10130.797384052277, 10137.0, 10302.0, 10350.585976560853, 7552.207018263113, 7713.9971803666285, 7742.341900938371, 7748.302652761278, 7807.141214466517, 5848.6783226921225, 5972.372900845522, 6045.063015232646, 6070.453659170696, 6237.438630523275, 9075.092490750872, 9099.226565741721, 9277.721668349961, 9294.302927280345, 9365.57854896545, 9353.438793672402, 9363.953180234055, 9546.618135274512, 9658.082482164184, 9679.564419600994, 6912.377885990285, 7077.964610176916, 7297.124345078624, 7740.187280335484, 7835.764927052198, 7737.961310193413, 7747.612619369122, 7760.92239077602, 7776.144624091458, 7805.570693611906, 7095.0, 7243.058402407864, 7260.96369518149, 7348.154962179417, 7432.033835601337, 7103.751368702071, 7148.499605027599, 7187.496875218684, 7191.7842464726145, 7271.527350722397, 6850.794476165723, 6911.930880691129, 6912.861742765217, 6913.516053876381, 6915.170179578483, 5231.084560202025, 5277.4194838566955, 5317.946820531745, 5356.223347614652, 5467.6719396836315, 5380.973095134499, 5433.646812957145, 5464.153056276284, 5475.589330800126, 5522.337319521523], "value": 4520.224483605063, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.5054497885493, 349.59097855509054, 351.7889266440136, 353.47156001777347, 356.31409536641956, 6219.067139929013, 6226.688665566715, 6227.564070515065, 6269.090981807635, 6279.466245369149, 6133.938660613392, 6235.8752824943585, 6253.781117660883, 6267.527131124193, 6312.621242725429, 4526.615237704799, 4644.767761611923, 4775.785089670956, 4781.235002399617, 4798.208295631217, 4728.219843725781, 4760.690555113906, 4778.904421911559, 4785.497522760113, 4788.28175773635, 4536.591706746392, 4732.432108147027, 4736.64475164364, 4740.07568524138, 4746.810127594909, 4595.379623750784, 4669.392978912737, 4673.369095172159, 4677.158111539921, 4762.261849413347, 4150.875473735793, 4158.771267580282, 4161.91676166478, 4171.019810344566, 4175.373693945902, 5994.820155395345, 6004.939950600482, 6006.699665016732, 6008.459238668497, 6012.398760123952, 5518.834434966958, 5531.225628411985, 5535.086710692731, 5538.861528461781, 5538.864532770773, 6444.806655800334, 6590.275069742324, 6603.80188594343, 6609.801705948829, 6613.041109039163, 4614.723116613014, 4622.838200662961, 4628.074385122955, 4634.675572709912, 4639.350490931272, 6847.144106986627, 6856.211535673411, 6871.99999999995, 6874.621895795729, 6888.276730943229, 4697.624190064855, 4699.060187962421, 4704.647151463654, 4705.388299521041, 4723.45680246776, 4795.304680821331, 4797.56821886032, 4802.399700037496, 4802.471728109905, 4804.735739534359, 5472.781088756485, 5505.229267902497, 5512.0, 5517.751701173376, 5522.0336441122645, 6529.706163222666, 6645.102911107036, 6646.53474256807, 6650.767223147167, 6672.132622759011, 1667.749837524381, 1679.5717092141426, 1682.8401301876547, 1687.392538686072, 1693.7120689482817, 1053.5417093564324, 1085.592902661502, 1107.983380249297, 1115.776844631077, 1122.7529943412599, 6231.345708700612, 6399.9360006400275, 6413.102165696806, 6431.5819471734185, 6434.646094464756, 6876.553024053421, 6888.793336199922, 6898.655067246617, 6907.654617269116, 6913.792586222421, 6398.5521013528605, 6412.198475190601, 6414.102025716404, 6419.967900160469, 6428.067930150102, 3664.303782281358, 3704.129529560551, 3707.0, 3712.9603710960973, 3713.925721485555, 6955.200151982485, 7159.749408770668, 7179.1026121734785, 7186.317299856505, 7194.604296763729, 7007.684654190573, 7023.367896889305, 7032.12098487689, 7043.964780176067, 7048.612326321999, 7156.105486814148, 7166.570005799668, 7171.964140179266, 7184.353408193392, 7188.353048225685, 6838.350356716104, 6865.382115609619, 6895.965520172367, 6903.0, 6910.516263861481, 6525.967370163119, 6729.259781423942, 6823.147106611674, 6828.248892621708, 6840.042394064735, 7096.042034325506, 7122.928770712434, 7123.0, 7130.358267755927, 7140.178879428932, 4664.766761661971, 4690.413698287714, 4692.601128904082, 4700.670953033255, 4702.012577358793, 6787.457003439812, 6854.554453960476, 6858.417034552119, 6860.588364698134, 6861.382475577222, 6509.1863517060365, 6682.264950855305, 6699.832504187434, 6725.428338591275, 6728.0, 6629.4696424284975, 6668.699908504226, 6671.432928200963, 6672.499562532732, 6674.799756007327, 6547.312532184052, 6561.311062338385, 6562.50781191403, 6565.901511477236, 6567.44176744982, 6730.730770769114, 6733.528652994243, 6749.358810912955, 6749.595024298558, 6752.426043786333, 6414.134091897534, 6551.312112228147, 6561.1470508833545, 6567.638779867153, 6567.704453299518], "value": 5006.959701466253, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.0004145253685, 888.6978427334709, 889.8531742262527, 898.8651702244663, 906.6871929184429, 15502.534923952271, 15777.684446311066, 15778.447754328587, 16574.337026518955, 17275.82724172758, 15488.225588720547, 15690.529284121494, 15757.212139393014, 15793.763093553605, 15813.288402021908, 744.731896517256, 891.7369376034053, 895.9193672569451, 908.3868388837541, 911.5943405184695, 888.942218755782, 901.8557030875062, 902.9322800789967, 903.5346796399859, 904.7014485219895, 940.8682784410188, 941.016637613692, 941.5715849288557, 941.7268991992314, 942.7218970403713, 768.9461737678365, 775.244136966456, 926.4024704065907, 936.6862101196108, 939.4785893828922, 688.2463702246033, 690.3200347657553, 690.3890057299276, 690.4234963805178, 690.9067275917787, 15170.544883653509, 15186.164760938143, 15259.313330900137, 15279.236038198156, 15282.465113720966, 13924.651883702887, 14340.282985850667, 14450.421983120663, 14497.927510362486, 14537.127772333693, 12232.388380580935, 12328.137030407875, 12331.5067397304, 12468.251904885736, 12630.873691263061, 3930.390789427643, 3932.7836968966694, 3979.7214195006363, 3984.7011474139267, 4031.5363733170766, 60070.0, 60217.0, 60241.69879150576, 60445.39554604442, 60682.696586517224, 11140.777184456265, 11216.66350009501, 11248.887511124947, 11808.88191118095, 11828.34944078084, 21049.579008419747, 21569.245076422565, 21613.351599452042, 21614.243501477686, 21638.675419868716, 8584.656613735506, 8946.584422205968, 8956.731298061068, 9001.54992250385, 9030.548472576345, 4487.842925497657, 4651.186042442559, 4696.342512048316, 4729.6452766042685, 4740.762961851962, 3543.574771027442, 3582.0507565495163, 3582.6775590196485, 3593.0298819318637, 3594.676479116892, 671.6272468779777, 684.555039224508, 684.6816230452863, 688.896665500179, 701.992980070203, 708.922018577956, 756.9129550101699, 785.285390294829, 824.2828738996991, 836.9916300837035, 9415.340926135243, 9637.71086867395, 9817.460039697742, 9862.309638325392, 9893.35693179941, 646.5603389695052, 771.2441807029143, 774.4772278711847, 778.1518145221736, 780.3367137932712, 4605.125026245003, 4763.166445871959, 4803.855884323476, 4827.0, 4850.223964165716, 64981.35018649847, 65765.0, 66083.0, 66093.669531653, 66136.33863661397, 53877.73061134669, 53988.19017714737, 54482.45517544853, 55227.44772552304, 55387.72306138444, 51882.74058629683, 52247.73876130595, 52587.73706131368, 52928.20607690888, 53602.731986339815, 9945.751356216153, 9990.0, 10100.242481813746, 10148.391096534231, 10188.796224075626, 38501.42247866228, 38901.2219755609, 39249.0, 40599.59400405958, 40601.0, 46168.30747538722, 47931.520684792704, 49171.75414122907, 49608.255876161165, 50899.236511451614, 12307.326779721365, 12373.072019598387, 12505.874941250471, 12694.428750706056, 12732.936335318263, 13624.386902589209, 14040.1575905446, 14308.713825723635, 14418.279086045866, 14937.626559336104, 13550.903872749039, 13704.451821927012, 13727.656808579866, 13867.653308667364, 14167.008309418241, 13532.661683457993, 13552.661183470493, 13607.863921361055, 13770.724585508033, 13787.51743688966, 13072.0, 13298.401571929093, 13391.263480508665, 13396.397162127923, 13500.257485838372, 10355.84466232992, 10431.634892778717, 10441.216908731723, 10540.947295263475, 10545.789084218119, 10950.671479855617, 10957.780844383227, 11160.832587511031, 11166.609168679057, 11311.7737645245], "value": 7232.829232540765, "unit": "score"}], "name": "dromaeo_css", "value": 7471.225786056384, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 108.0, 109.0, 110.0, 111.0, 105.0, 110.0, 109.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 156.0, 175.0, 127.0, 155.0, 167.0, 129.0, 189.0, 126.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 162.0, 160.0, 163.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 170.0, 76.0, 77.0, 82.0, 76.0, 176.0, 76.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 151.0, 93.0, 93.0, 93.0, 144.0, 92.0, 93.0, 148.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 56.0, 53.0, 53.0, 55.0, 53.0, 76.0, 53.0, 52.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 59.0, 58.0, 58.0, 57.0, 58.0, 57.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 81.0, 73.0, 72.0, 73.0, 73.0, 73.0, 74.0, 74.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 117.0, 114.0, 113.0, 110.0, 113.0, 125.0, 146.0, 129.0], "value": 119.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 166.0, 164.0, 160.0, 160.0, 156.0, 154.0, 162.0, 158.0, 159.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 68.0, 67.0, 63.0, 65.0, 66.0, 64.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1515.2, "alertThreshold": 2.0}]} 03:57:32 INFO - Return code: 0 03:57:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:57:32 ERROR - # TBPL SUCCESS # 03:57:32 INFO - Running post-action listener: _resource_record_post_action 03:57:32 INFO - Running post-run listener: _resource_record_post_run 03:57:33 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 266240; Write bytes: 502513664; Read time: 28; Write time: 413644 03:57:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249118720; Read time: 0; Write time: 254124 03:57:33 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253394944; Read time: 28; Write time: 159520 03:57:33 INFO - Running post-run listener: _upload_blobber_files 03:57:33 INFO - Blob upload gear active. 03:57:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:57:33 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 03:57:33 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'] 03:57:33 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 03:57:33 INFO - (blobuploader) - INFO - Open directory for files ... 03:57:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:57:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:57:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:34 INFO - (blobuploader) - INFO - Done attempting. 03:57:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:57:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:57:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:35 INFO - (blobuploader) - INFO - Done attempting. 03:57:35 INFO - (blobuploader) - INFO - Iteration through files over. 03:57:35 INFO - Return code: 0 03:57:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:57:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:57:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5096623dace6b61cf315b648a8e32b4cab0cdf63fa8290c2b8871a43349cc16f468c76b03f6e5b8de93d764ae670a0e7bbd63dc21550b05628eab68d3fdeb641", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d42e8f25a674d0b192446e16569f83d04b1810c5ac5873119614a9e73d90045c66d90b4f25024a4e1c0867b1ab5a9ce4e0c184fd8236dd7ad195ac1d059a224"} 03:57:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:57:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:57:35 INFO - Contents: 03:57:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5096623dace6b61cf315b648a8e32b4cab0cdf63fa8290c2b8871a43349cc16f468c76b03f6e5b8de93d764ae670a0e7bbd63dc21550b05628eab68d3fdeb641", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d42e8f25a674d0b192446e16569f83d04b1810c5ac5873119614a9e73d90045c66d90b4f25024a4e1c0867b1ab5a9ce4e0c184fd8236dd7ad195ac1d059a224"} 03:57:35 INFO - Running post-run listener: copy_logs_to_upload_dir 03:57:35 INFO - Copying logs to upload dir... 03:57:35 INFO - mkdir: /builds/slave/test/build/upload/logs 03:57:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.633699 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-28 03:57:34.331958) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:57:34.335109) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472 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/5096623dace6b61cf315b648a8e32b4cab0cdf63fa8290c2b8871a43349cc16f468c76b03f6e5b8de93d764ae670a0e7bbd63dc21550b05628eab68d3fdeb641", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d42e8f25a674d0b192446e16569f83d04b1810c5ac5873119614a9e73d90045c66d90b4f25024a4e1c0867b1ab5a9ce4e0c184fd8236dd7ad195ac1d059a224"} build_url:https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011590 build_url: 'https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5096623dace6b61cf315b648a8e32b4cab0cdf63fa8290c2b8871a43349cc16f468c76b03f6e5b8de93d764ae670a0e7bbd63dc21550b05628eab68d3fdeb641", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d42e8f25a674d0b192446e16569f83d04b1810c5ac5873119614a9e73d90045c66d90b4f25024a4e1c0867b1ab5a9ce4e0c184fd8236dd7ad195ac1d059a224"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:57:34.364971) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:57:34.365302) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464431827.862293-1949586472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:57:34.448915) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:57:34.449755) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:57:34.450500) ========= ========= Total master_lag: 0.16 =========