builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1464205518.51 results: success (0) buildid: 20160525100739 builduid: 974d5cae826941f5848d40439eb54c5d revision: 349688fd0b53507dad2b2e7d358c8d2e9744b557 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 12:45:18.511904) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 12:45:18.512439) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 12:45:18.512830) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 12:45:18.528294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 12:45:18.528728) ========= 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=14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 12:45:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-05-25 12:45:18 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148940 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 12:45:18.694340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 12:45:18.694987) ========= 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=14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018664 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 12:45:18.746920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 12:45:18.747523) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 349688fd0b53507dad2b2e7d358c8d2e9744b557 --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 349688fd0b53507dad2b2e7d358c8d2e9744b557 --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=14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 12:45:18,870 truncating revision to first 12 chars 2016-05-25 12:45:18,870 Setting DEBUG logging. 2016-05-25 12:45:18,870 attempt 1/10 2016-05-25 12:45:18,870 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/349688fd0b53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 12:45:19,884 unpacking tar archive at: mozilla-aurora-349688fd0b53/testing/mozharness/ program finished with exit code 0 elapsedTime=1.334095 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 12:45:20.095789) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 12:45:20.096081) ========= script_repo_revision: 349688fd0b53507dad2b2e7d358c8d2e9744b557 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 12:45:20.096551) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 12:45:20.096833) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 12:45:20.104908) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-25 12:45:20.105239) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:45:20 INFO - MultiFileLogger online at 20160525 12:45:20 in /builds/slave/test 12:45:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:45:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:45:20 INFO - {'append_to_log': False, 12:45:20 INFO - 'base_work_dir': '/builds/slave/test', 12:45:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:45:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:45:20 INFO - 'branch': 'Mozilla-Aurora', 12:45:20 INFO - 'buildbot_json_path': 'buildprops.json', 12:45:20 INFO - 'config_files': ('talos/linux_config.py',), 12:45:20 INFO - 'default_actions': ('clobber', 12:45:20 INFO - 'read-buildbot-config', 12:45:20 INFO - 'download-and-extract', 12:45:20 INFO - 'populate-webroot', 12:45:20 INFO - 'create-virtualenv', 12:45:20 INFO - 'install', 12:45:20 INFO - 'run-tests'), 12:45:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:45:20 INFO - 'download_minidump_stackwalk': True, 12:45:20 INFO - 'download_symbols': 'ondemand', 12:45:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:45:20 INFO - 'tooltool.py': '/tools/tooltool.py', 12:45:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:45:20 INFO - '/tools/misc-python/virtualenv.py')}, 12:45:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:45:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:45:20 INFO - 'installer_path': 'installer.exe', 12:45:20 INFO - 'log_level': 'info', 12:45:20 INFO - 'log_name': 'talos', 12:45:20 INFO - 'log_to_console': True, 12:45:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:45:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:45:20 INFO - 'opt_config_files': (), 12:45:20 INFO - 'pip_index': False, 12:45:20 INFO - 'sps_profile': False, 12:45:20 INFO - 'sps_profile_interval': 0, 12:45:20 INFO - 'suite': 'dromaeojs-e10s', 12:45:20 INFO - 'system_bits': '32', 12:45:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:45:20 INFO - 'title': 'talos-linux64-ix-036', 12:45:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:45:20 INFO - 'use_talos_json': True, 12:45:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:45:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:45:20 INFO - 'work_dir': 'build'} 12:45:20 INFO - ##### 12:45:20 INFO - ##### Running clobber step. 12:45:20 INFO - ##### 12:45:20 INFO - Running pre-action listener: _resource_record_pre_action 12:45:20 INFO - Running main action method: clobber 12:45:20 INFO - rmtree: /builds/slave/test/build 12:45:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:45:20 INFO - Running post-action listener: _resource_record_post_action 12:45:20 INFO - ##### 12:45:20 INFO - ##### Running read-buildbot-config step. 12:45:20 INFO - ##### 12:45:20 INFO - Running pre-action listener: _resource_record_pre_action 12:45:20 INFO - Running main action method: read_buildbot_config 12:45:20 INFO - Using buildbot properties: 12:45:20 INFO - { 12:45:20 INFO - "project": "", 12:45:20 INFO - "product": "firefox", 12:45:20 INFO - "script_repo_revision": "production", 12:45:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 12:45:20 INFO - "repository": "", 12:45:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 12:45:20 INFO - "buildid": "20160525100739", 12:45:20 INFO - "pgo_build": "True", 12:45:20 INFO - "basedir": "/builds/slave/test", 12:45:20 INFO - "buildnumber": 289, 12:45:20 INFO - "slavename": "talos-linux64-ix-036", 12:45:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:45:20 INFO - "platform": "ubuntu64_hw", 12:45:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:45:20 INFO - "branch": "mozilla-aurora", 12:45:20 INFO - "repo_path": "releases/mozilla-aurora", 12:45:20 INFO - "revision": "349688fd0b53507dad2b2e7d358c8d2e9744b557", 12:45:20 INFO - "stage_platform": "linux64-pgo", 12:45:20 INFO - "builduid": "974d5cae826941f5848d40439eb54c5d", 12:45:20 INFO - "slavebuilddir": "test" 12:45:20 INFO - } 12:45:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 12:45:20 INFO - Running post-action listener: _resource_record_post_action 12:45:20 INFO - ##### 12:45:20 INFO - ##### Running download-and-extract step. 12:45:20 INFO - ##### 12:45:20 INFO - Running pre-action listener: _resource_record_pre_action 12:45:20 INFO - Running main action method: download_and_extract 12:45:20 INFO - mkdir: /builds/slave/test/build/tests 12:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:20 INFO - https://queue.taskcluster.net/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:45:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 12:45:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 12:45:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/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 12:45:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/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 12:45:23 INFO - Downloaded 1361 bytes. 12:45:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 12:45:23 INFO - Using the following test package requirements: 12:45:23 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 12:45:23 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:45:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:45:23 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:45:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:45:23 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:45:23 INFO - u'jsshell-linux-x86_64.zip'], 12:45:23 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:45:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:45:23 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 12:45:23 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:45:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:45:23 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:45:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:45:23 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:45:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:45:23 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:45:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:45:23 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:45: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')]} 12:45:24 INFO - https://queue.taskcluster.net/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:45:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:45:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:45:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/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 12:45:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/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 12:45:26 INFO - Downloaded 24136372 bytes. 12:45:26 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'] 12:45:26 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 12:45:27 INFO - Return code: 0 12:45:27 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 12:45:27 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')]} 12:45:27 INFO - https://queue.taskcluster.net/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:45:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:45:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:45:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/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 12:45:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/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 12:45:29 INFO - Downloaded 24136372 bytes. 12:45:29 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'] 12:45:29 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 12:45:30 INFO - Return code: 0 12:45:30 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')]} 12:45:30 INFO - https://queue.taskcluster.net/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:45:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 12:45:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 12:45:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/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 12:45:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/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 12:45:31 INFO - Downloaded 10840145 bytes. 12:45:31 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'] 12:45:31 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 12:45:31 INFO - Return code: 0 12:45:31 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')]} 12:45:31 INFO - https://queue.taskcluster.net/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:45:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:45:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:45:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/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 12:45:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QRtL2RDFT-6uaGdg5Oqlog/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 12:45:33 INFO - Downloaded 62754641 bytes. 12:45:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:45:33 INFO - mkdir: /builds/slave/test/properties 12:45:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:45:33 INFO - Writing to file /builds/slave/test/properties/build_url 12:45:33 INFO - Contents: 12:45:33 INFO - build_url:https://queue.taskcluster.net/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:45:33 INFO - Running post-action listener: _resource_record_post_action 12:45:33 INFO - Running post-action listener: set_extra_try_arguments 12:45:33 INFO - ##### 12:45:33 INFO - ##### Running populate-webroot step. 12:45:33 INFO - ##### 12:45:33 INFO - Running pre-action listener: _resource_record_pre_action 12:45:33 INFO - Running main action method: populate_webroot 12:45:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:45:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:45:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:45:33 INFO - '--tppagecycles', 12:45:33 INFO - '7'], 12:45:33 INFO - 'tests': ['tsvgm']}}, 12:45:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:45:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:45:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:45:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:45:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:45:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:45:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:33 INFO - 'talos_options': ['--disable-e10s'], 12:45:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:45:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:45:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:33 INFO - 'talos_options': ['--disable-e10s'], 12:45:33 INFO - 'tests': ['damp', 'tps']}, 12:45:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:33 INFO - 'tests': ['damp', 'tps']}, 12:45:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:45:33 INFO - 'tests': ['dromaeo_dom']}, 12:45:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:45:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:45:33 INFO - 'tests': ['a11yr', 12:45:33 INFO - 'ts_paint', 12:45:33 INFO - 'tpaint', 12:45:33 INFO - 'sessionrestore', 12:45:33 INFO - 'sessionrestore_no_auto_restore', 12:45:33 INFO - 'tabpaint']}, 12:45:33 INFO - 'other-e10s': {'tests': ['a11yr', 12:45:33 INFO - 'ts_paint', 12:45:33 INFO - 'tpaint', 12:45:33 INFO - 'sessionrestore', 12:45:33 INFO - 'sessionrestore_no_auto_restore', 12:45:33 INFO - 'tabpaint']}, 12:45:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:45:33 INFO - 'ts_paint', 12:45:33 INFO - 'tpaint', 12:45:33 INFO - 'sessionrestore', 12:45:33 INFO - 'sessionrestore_no_auto_restore', 12:45:33 INFO - 'tabpaint']}, 12:45:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:45:33 INFO - 'ts_paint', 12:45:33 INFO - 'tpaint', 12:45:33 INFO - 'sessionrestore', 12:45:33 INFO - 'sessionrestore_no_auto_restore', 12:45:33 INFO - 'tabpaint']}, 12:45:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:45:33 INFO - 'tests': ['a11yr', 12:45:33 INFO - 'ts_paint', 12:45:33 INFO - 'tpaint', 12:45:33 INFO - 'sessionrestore', 12:45:33 INFO - 'sessionrestore_no_auto_restore', 12:45:33 INFO - 'tabpaint']}, 12:45:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:45:33 INFO - 'tests': ['a11yr', 12:45:33 INFO - 'ts_paint', 12:45:33 INFO - 'tpaint', 12:45:33 INFO - 'sessionrestore', 12:45:33 INFO - 'sessionrestore_no_auto_restore', 12:45:33 INFO - 'tabpaint']}, 12:45:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:45:33 INFO - 'tests': ['tsvgx', 12:45:33 INFO - 'tsvgr_opacity', 12:45:33 INFO - 'tart', 12:45:33 INFO - 'tscrollx', 12:45:33 INFO - 'cart']}, 12:45:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:45:33 INFO - 'tsvgr_opacity', 12:45:33 INFO - 'tart', 12:45:33 INFO - 'tscrollx', 12:45:33 INFO - 'cart']}, 12:45:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:33 INFO - 'talos_options': ['--disable-e10s'], 12:45:33 INFO - 'tests': ['tp5o']}, 12:45:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:33 INFO - 'tests': ['tp5o']}, 12:45:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:33 INFO - 'talos_options': ['--disable-e10s', 12:45:33 INFO - '--xperf_path', 12:45:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:45:33 INFO - 'tests': ['tp5n']}, 12:45:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:33 INFO - 'talos_options': ['--xperf_path', 12:45:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:45:33 INFO - 'tests': ['tp5n']}}, 12:45:33 INFO - 'talos.zip': {'path': '', 12:45:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:45:33 INFO - Running post-action listener: _resource_record_post_action 12:45:33 INFO - ##### 12:45:33 INFO - ##### Running create-virtualenv step. 12:45:33 INFO - ##### 12:45:33 INFO - Running pre-action listener: _resource_record_pre_action 12:45:33 INFO - Running main action method: create_virtualenv 12:45:33 INFO - Creating virtualenv /builds/slave/test/build/venv 12:45:33 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 12:45:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:45:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:45:34 INFO - Using real prefix '/usr' 12:45:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:45:34 INFO - Installing distribute.............................................................................................................................................................................................done. 12:45:36 INFO - Installing pip.................done. 12:45:36 INFO - Return code: 0 12:45:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:36 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 0x7fe3ca223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd9410>, '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 0xfda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfda7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', '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 12:45:36 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 12:45:36 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 12:45:36 INFO - Using env: {'DISPLAY': ':0', 12:45:36 INFO - 'HOME': '/home/cltbld', 12:45:36 INFO - 'LANG': 'en_US.UTF-8', 12:45:36 INFO - 'LANGUAGE': 'en_US:en', 12:45:36 INFO - 'LOGNAME': 'cltbld', 12:45:36 INFO - 'MAIL': '/var/mail/cltbld', 12:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:36 INFO - 'MOZ_NO_REMOTE': '1', 12:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:36 INFO - 'NO_EM_RESTART': '1', 12:45:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:36 INFO - 'PWD': '/builds/slave/test', 12:45:36 INFO - 'SHELL': '/bin/bash', 12:45:36 INFO - 'SHLVL': '1', 12:45:36 INFO - 'TERM': 'linux', 12:45:36 INFO - 'TMOUT': '86400', 12:45:36 INFO - 'USER': 'cltbld', 12:45:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', 12:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:36 INFO - '_': '/tools/buildbot/bin/python'} 12:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:36 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 12:45:36 INFO - Cleaning up... 12:45:36 INFO - Return code: 0 12:45:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:36 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 0x7fe3ca223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd9410>, '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 0xfda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfda7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', '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 12:45:36 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 12:45:36 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 12:45:36 INFO - Using env: {'DISPLAY': ':0', 12:45:36 INFO - 'HOME': '/home/cltbld', 12:45:36 INFO - 'LANG': 'en_US.UTF-8', 12:45:36 INFO - 'LANGUAGE': 'en_US:en', 12:45:36 INFO - 'LOGNAME': 'cltbld', 12:45:36 INFO - 'MAIL': '/var/mail/cltbld', 12:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:36 INFO - 'MOZ_NO_REMOTE': '1', 12:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:36 INFO - 'NO_EM_RESTART': '1', 12:45:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:36 INFO - 'PWD': '/builds/slave/test', 12:45:36 INFO - 'SHELL': '/bin/bash', 12:45:36 INFO - 'SHLVL': '1', 12:45:36 INFO - 'TERM': 'linux', 12:45:36 INFO - 'TMOUT': '86400', 12:45:36 INFO - 'USER': 'cltbld', 12:45:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', 12:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:36 INFO - '_': '/tools/buildbot/bin/python'} 12:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:36 INFO - Downloading/unpacking psutil>=0.7.1 12:45: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 12:45: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 12:45: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 12:45: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 12:45: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 12:45: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 12:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:45:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:45:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:45:39 INFO - Installing collected packages: psutil 12:45:39 INFO - Running setup.py install for psutil 12:45:39 INFO - building 'psutil._psutil_linux' extension 12:45:39 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 12:45:39 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 12:45:39 INFO - building 'psutil._psutil_posix' extension 12:45:39 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 12:45:39 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 12:45:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:45:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:45:39 INFO - Successfully installed psutil 12:45:39 INFO - Cleaning up... 12:45:40 INFO - Return code: 0 12:45:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:40 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 0x7fe3ca223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd9410>, '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 0xfda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfda7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', '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 12:45:40 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 12:45:40 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 12:45:40 INFO - Using env: {'DISPLAY': ':0', 12:45:40 INFO - 'HOME': '/home/cltbld', 12:45:40 INFO - 'LANG': 'en_US.UTF-8', 12:45:40 INFO - 'LANGUAGE': 'en_US:en', 12:45:40 INFO - 'LOGNAME': 'cltbld', 12:45:40 INFO - 'MAIL': '/var/mail/cltbld', 12:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:40 INFO - 'MOZ_NO_REMOTE': '1', 12:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:40 INFO - 'NO_EM_RESTART': '1', 12:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:40 INFO - 'PWD': '/builds/slave/test', 12:45:40 INFO - 'SHELL': '/bin/bash', 12:45:40 INFO - 'SHLVL': '1', 12:45:40 INFO - 'TERM': 'linux', 12:45:40 INFO - 'TMOUT': '86400', 12:45:40 INFO - 'USER': 'cltbld', 12:45:40 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', 12:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:40 INFO - '_': '/tools/buildbot/bin/python'} 12:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:45: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 12:45: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 12:45: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 12:45: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 12:45: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 12:45: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 12:45:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:45:43 INFO - Installing collected packages: mozsystemmonitor 12:45:43 INFO - Running setup.py install for mozsystemmonitor 12:45:43 INFO - Successfully installed mozsystemmonitor 12:45:43 INFO - Cleaning up... 12:45:43 INFO - Return code: 0 12:45:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe3ca223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd9410>, '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 0xfda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfda7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', '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 12:45:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:45:43 INFO - Using env: {'DISPLAY': ':0', 12:45:43 INFO - 'HOME': '/home/cltbld', 12:45:43 INFO - 'LANG': 'en_US.UTF-8', 12:45:43 INFO - 'LANGUAGE': 'en_US:en', 12:45:43 INFO - 'LOGNAME': 'cltbld', 12:45:43 INFO - 'MAIL': '/var/mail/cltbld', 12:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:43 INFO - 'MOZ_NO_REMOTE': '1', 12:45:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:43 INFO - 'NO_EM_RESTART': '1', 12:45:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:43 INFO - 'PWD': '/builds/slave/test', 12:45:43 INFO - 'SHELL': '/bin/bash', 12:45:43 INFO - 'SHLVL': '1', 12:45:43 INFO - 'TERM': 'linux', 12:45:43 INFO - 'TMOUT': '86400', 12:45:43 INFO - 'USER': 'cltbld', 12:45:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', 12:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:43 INFO - '_': '/tools/buildbot/bin/python'} 12:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:43 INFO - Downloading/unpacking blobuploader==1.2.4 12:45:43 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 12:45:43 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 12:45:43 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 12:45:43 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 12:45:43 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 12:45:43 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 12:45:45 INFO - Downloading blobuploader-1.2.4.tar.gz 12:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:45:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:45:45 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 12:45:45 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 12:45:45 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 12:45:45 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 12:45:45 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 12:45:45 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 12:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:45:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:46 INFO - Downloading docopt-0.6.1.tar.gz 12:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:45:46 INFO - Installing collected packages: blobuploader, requests, docopt 12:45:46 INFO - Running setup.py install for blobuploader 12:45:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:45:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:45:46 INFO - Running setup.py install for requests 12:45:46 INFO - Running setup.py install for docopt 12:45:46 INFO - Successfully installed blobuploader requests docopt 12:45:46 INFO - Cleaning up... 12:45:46 INFO - Return code: 0 12:45:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:46 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 0x7fe3ca223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd9410>, '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 0xfda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfda7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', '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 12:45:46 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 12:45:46 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 12:45:46 INFO - Using env: {'DISPLAY': ':0', 12:45:46 INFO - 'HOME': '/home/cltbld', 12:45:46 INFO - 'LANG': 'en_US.UTF-8', 12:45:46 INFO - 'LANGUAGE': 'en_US:en', 12:45:46 INFO - 'LOGNAME': 'cltbld', 12:45:46 INFO - 'MAIL': '/var/mail/cltbld', 12:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:46 INFO - 'MOZ_NO_REMOTE': '1', 12:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:46 INFO - 'NO_EM_RESTART': '1', 12:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:46 INFO - 'PWD': '/builds/slave/test', 12:45:46 INFO - 'SHELL': '/bin/bash', 12:45:46 INFO - 'SHLVL': '1', 12:45:46 INFO - 'TERM': 'linux', 12:45:46 INFO - 'TMOUT': '86400', 12:45:46 INFO - 'USER': 'cltbld', 12:45:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', 12:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:46 INFO - '_': '/tools/buildbot/bin/python'} 12:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:45:47 INFO - Running setup.py (path:/tmp/pip-qXe6Lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:45:47 INFO - Running setup.py (path:/tmp/pip-K6ZQ4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:45:47 INFO - Running setup.py (path:/tmp/pip-8wJH5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:45:47 INFO - Running setup.py (path:/tmp/pip-wnHJC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:45:47 INFO - Running setup.py (path:/tmp/pip-AW4Lo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:45:47 INFO - Running setup.py (path:/tmp/pip-kGau0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:45:47 INFO - Running setup.py (path:/tmp/pip-Kk01xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:45:47 INFO - Running setup.py (path:/tmp/pip-8pe0so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:45:47 INFO - Running setup.py (path:/tmp/pip-gGBIWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:45:47 INFO - Running setup.py (path:/tmp/pip-gu4WZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:45:47 INFO - Running setup.py (path:/tmp/pip-BSG3jN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:45:47 INFO - Running setup.py (path:/tmp/pip-RYq_xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:45:48 INFO - Running setup.py (path:/tmp/pip-fl9mkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:45:48 INFO - Running setup.py (path:/tmp/pip-OAGBe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:48 INFO - Running setup.py (path:/tmp/pip-KFM5Ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:45:48 INFO - Running setup.py (path:/tmp/pip-qYydmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:45:48 INFO - Running setup.py (path:/tmp/pip-RALHmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:45:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:45:48 INFO - Running setup.py install for manifestparser 12:45:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:45:48 INFO - Running setup.py install for mozcrash 12:45:48 INFO - Running setup.py install for mozdebug 12:45:48 INFO - Running setup.py install for mozdevice 12:45:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:45:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:45:48 INFO - Running setup.py install for mozfile 12:45:48 INFO - Running setup.py install for mozhttpd 12:45:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:45:48 INFO - Running setup.py install for mozinfo 12:45:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:45:49 INFO - Running setup.py install for mozInstall 12:45:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:45:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:45:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:45:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:45:49 INFO - Running setup.py install for mozleak 12:45:49 INFO - Running setup.py install for mozlog 12:45:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:45:49 INFO - Running setup.py install for moznetwork 12:45:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:45:49 INFO - Running setup.py install for mozprocess 12:45:49 INFO - Running setup.py install for mozprofile 12:45:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:45:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:45:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:45:49 INFO - Running setup.py install for mozrunner 12:45:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:45:49 INFO - Running setup.py install for mozscreenshot 12:45:49 INFO - Running setup.py install for moztest 12:45:50 INFO - Running setup.py install for mozversion 12:45:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:45:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:45:50 INFO - Cleaning up... 12:45:50 INFO - Return code: 0 12:45:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:50 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 0x7fe3ca223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd9410>, '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 0xfda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfda7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', '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 12:45:50 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 12:45:50 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 12:45:50 INFO - Using env: {'DISPLAY': ':0', 12:45:50 INFO - 'HOME': '/home/cltbld', 12:45:50 INFO - 'LANG': 'en_US.UTF-8', 12:45:50 INFO - 'LANGUAGE': 'en_US:en', 12:45:50 INFO - 'LOGNAME': 'cltbld', 12:45:50 INFO - 'MAIL': '/var/mail/cltbld', 12:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:50 INFO - 'MOZ_NO_REMOTE': '1', 12:45:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:50 INFO - 'NO_EM_RESTART': '1', 12:45:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:50 INFO - 'PWD': '/builds/slave/test', 12:45:50 INFO - 'SHELL': '/bin/bash', 12:45:50 INFO - 'SHLVL': '1', 12:45:50 INFO - 'TERM': 'linux', 12:45:50 INFO - 'TMOUT': '86400', 12:45:50 INFO - 'USER': 'cltbld', 12:45:50 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', 12:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:50 INFO - '_': '/tools/buildbot/bin/python'} 12:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:45:50 INFO - Running setup.py (path:/tmp/pip-skg4rZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:45:50 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)) 12:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:45:50 INFO - Running setup.py (path:/tmp/pip-bPYzW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:45:50 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)) 12:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:45:50 INFO - Running setup.py (path:/tmp/pip-glIgKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:45:50 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)) 12:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:45:50 INFO - Running setup.py (path:/tmp/pip-hhrAnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:45:50 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)) 12:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:45:50 INFO - Running setup.py (path:/tmp/pip-H8smZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:45:50 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)) 12:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:45:50 INFO - Running setup.py (path:/tmp/pip-TSvyso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:45:50 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)) 12:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:45:50 INFO - Running setup.py (path:/tmp/pip-olGTkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:45:50 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)) 12:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:45:50 INFO - Running setup.py (path:/tmp/pip-JMYc9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:45:50 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)) 12:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:45:50 INFO - Running setup.py (path:/tmp/pip-sbU3ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:45:51 INFO - Running setup.py (path:/tmp/pip-q7A5Aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:45:51 INFO - Running setup.py (path:/tmp/pip-KjfZRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:45:51 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)) 12:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:45:51 INFO - Running setup.py (path:/tmp/pip-ly1yCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:45:51 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)) 12:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:45:51 INFO - Running setup.py (path:/tmp/pip-IlyBil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:45:51 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)) 12:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:45:51 INFO - Running setup.py (path:/tmp/pip-gFMmK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:45:51 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)) 12:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:51 INFO - Running setup.py (path:/tmp/pip-rxiCHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:51 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)) 12:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:45:51 INFO - Running setup.py (path:/tmp/pip-mdw0b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:45:51 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)) 12:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:45:51 INFO - Running setup.py (path:/tmp/pip-RUiEJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:45:51 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)) 12:45:51 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)) 12:45:51 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)) 12:45:51 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)) 12:45:51 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)) 12:45:51 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)) 12:45:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:53 INFO - Downloading blessings-1.6.tar.gz 12:45:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:45:53 INFO - Installing collected packages: blessings 12:45:53 INFO - Running setup.py install for blessings 12:45:53 INFO - Successfully installed blessings 12:45:53 INFO - Cleaning up... 12:45:53 INFO - Return code: 0 12:45:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:45:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:45:53 INFO - Reading from file tmpfile_stdout 12:45:53 INFO - Current package versions: 12:45:53 INFO - argparse == 1.2.1 12:45:53 INFO - blessings == 1.6 12:45:53 INFO - blobuploader == 1.2.4 12:45:53 INFO - docopt == 0.6.1 12:45:53 INFO - manifestparser == 1.1 12:45:53 INFO - mozInstall == 1.12 12:45:53 INFO - mozcrash == 0.17 12:45:53 INFO - mozdebug == 0.1 12:45:53 INFO - mozdevice == 0.48 12:45:53 INFO - mozfile == 1.2 12:45:53 INFO - mozhttpd == 0.7 12:45:53 INFO - mozinfo == 0.9 12:45:53 INFO - mozleak == 0.1 12:45:53 INFO - mozlog == 3.1 12:45:53 INFO - moznetwork == 0.27 12:45:53 INFO - mozprocess == 0.22 12:45:53 INFO - mozprofile == 0.28 12:45:53 INFO - mozrunner == 6.11 12:45:53 INFO - mozscreenshot == 0.1 12:45:53 INFO - mozsystemmonitor == 0.0 12:45:53 INFO - moztest == 0.7 12:45:53 INFO - mozversion == 1.4 12:45:53 INFO - psutil == 3.1.1 12:45:53 INFO - requests == 1.2.3 12:45:53 INFO - wsgiref == 0.1.2 12:45:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:45:53 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')]} 12:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:53 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')]} 12:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:53 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 0x7fe3ca223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd9410>, '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 0xfda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfda7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', '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 12:45:53 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 12:45:53 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 12:45:53 INFO - Using env: {'DISPLAY': ':0', 12:45:53 INFO - 'HOME': '/home/cltbld', 12:45:53 INFO - 'LANG': 'en_US.UTF-8', 12:45:53 INFO - 'LANGUAGE': 'en_US:en', 12:45:53 INFO - 'LOGNAME': 'cltbld', 12:45:53 INFO - 'MAIL': '/var/mail/cltbld', 12:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:53 INFO - 'MOZ_NO_REMOTE': '1', 12:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:53 INFO - 'NO_EM_RESTART': '1', 12:45:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:53 INFO - 'PWD': '/builds/slave/test', 12:45:53 INFO - 'SHELL': '/bin/bash', 12:45:53 INFO - 'SHLVL': '1', 12:45:53 INFO - 'TERM': 'linux', 12:45:53 INFO - 'TMOUT': '86400', 12:45:53 INFO - 'USER': 'cltbld', 12:45:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', 12:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:53 INFO - '_': '/tools/buildbot/bin/python'} 12:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:54 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)) 12:45:54 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)) 12:45:54 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)) 12:45:54 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)) 12:45:54 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)) 12:45:54 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)) 12:45:54 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)) 12:45:54 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)) 12:45:54 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)) 12:45:54 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)) 12:45:54 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)) 12:45:54 INFO - Cleaning up... 12:45:54 INFO - Return code: 0 12:45:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:54 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 0x7fe3ca223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd9410>, '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 0xfda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfda7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', '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 12:45:54 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 12:45:54 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 12:45:54 INFO - Using env: {'DISPLAY': ':0', 12:45:54 INFO - 'HOME': '/home/cltbld', 12:45:54 INFO - 'LANG': 'en_US.UTF-8', 12:45:54 INFO - 'LANGUAGE': 'en_US:en', 12:45:54 INFO - 'LOGNAME': 'cltbld', 12:45:54 INFO - 'MAIL': '/var/mail/cltbld', 12:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:54 INFO - 'MOZ_NO_REMOTE': '1', 12:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:54 INFO - 'NO_EM_RESTART': '1', 12:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:54 INFO - 'PWD': '/builds/slave/test', 12:45:54 INFO - 'SHELL': '/bin/bash', 12:45:54 INFO - 'SHLVL': '1', 12:45:54 INFO - 'TERM': 'linux', 12:45:54 INFO - 'TMOUT': '86400', 12:45:54 INFO - 'USER': 'cltbld', 12:45:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', 12:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:54 INFO - '_': '/tools/buildbot/bin/python'} 12:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:54 INFO - Downloading/unpacking jsonschema 12:45:54 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 12:45:54 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 12:45:54 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 12:45:54 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 12:45:54 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 12:45:54 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 12:45:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:45:56 INFO - Downloading/unpacking functools32 (from jsonschema) 12:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:56 INFO - Downloading functools32-3.2.3-2.tar.gz 12:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:45:56 INFO - warning: no files found matching '*.txt' 12:45:56 INFO - no previously-included directories found matching 'build' 12:45:56 INFO - no previously-included directories found matching 'dist' 12:45:56 INFO - no previously-included directories found matching '.git*' 12:45:56 INFO - Installing collected packages: jsonschema, functools32 12:45:56 INFO - Running setup.py install for functools32 12:45:56 INFO - warning: no files found matching '*.txt' 12:45:56 INFO - no previously-included directories found matching 'build' 12:45:56 INFO - no previously-included directories found matching 'dist' 12:45:56 INFO - no previously-included directories found matching '.git*' 12:45:56 INFO - Successfully installed jsonschema functools32 12:45:56 INFO - Cleaning up... 12:45:56 INFO - Return code: 0 12:45:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:45:56 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')]} 12:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:56 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')]} 12:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:56 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 0x7fe3ca223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd9410>, '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 0xfda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfda7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', '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 12:45:56 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 12:45:56 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 12:45:56 INFO - Using env: {'DISPLAY': ':0', 12:45:56 INFO - 'HOME': '/home/cltbld', 12:45:56 INFO - 'LANG': 'en_US.UTF-8', 12:45:56 INFO - 'LANGUAGE': 'en_US:en', 12:45:56 INFO - 'LOGNAME': 'cltbld', 12:45:56 INFO - 'MAIL': '/var/mail/cltbld', 12:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:56 INFO - 'MOZ_NO_REMOTE': '1', 12:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:56 INFO - 'NO_EM_RESTART': '1', 12:45:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:56 INFO - 'PWD': '/builds/slave/test', 12:45:56 INFO - 'SHELL': '/bin/bash', 12:45:56 INFO - 'SHLVL': '1', 12:45:56 INFO - 'TERM': 'linux', 12:45:56 INFO - 'TMOUT': '86400', 12:45:56 INFO - 'USER': 'cltbld', 12:45:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', 12:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:56 INFO - '_': '/tools/buildbot/bin/python'} 12:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:57 INFO - Downloading/unpacking flake8 12:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:45:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:45:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:45:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:45:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:45:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:45:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:45:59 INFO - no previously-included directories found matching 'docs/_build' 12:45:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:45:59 INFO - Running setup.py install for pep8 12:45:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:45:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:45:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:45:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:45:59 INFO - no previously-included directories found matching 'docs/_build' 12:45:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:45:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:45:59 INFO - Cleaning up... 12:45:59 INFO - Return code: 0 12:45:59 INFO - Running post-action listener: _resource_record_post_action 12:45:59 INFO - Running post-action listener: _start_resource_monitoring 12:45:59 INFO - Starting resource monitoring. 12:45:59 INFO - ##### 12:45:59 INFO - ##### Running install step. 12:45:59 INFO - ##### 12:45:59 INFO - Running pre-action listener: _resource_record_pre_action 12:45:59 INFO - Running main action method: install 12:45:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:46:00 INFO - Reading from file tmpfile_stdout 12:46:00 INFO - Detecting whether we're running mozinstall >=1.0... 12:46:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:46:00 INFO - Reading from file tmpfile_stdout 12:46:00 INFO - Output received: 12:46:00 INFO - Usage: mozinstall [options] installer 12:46:00 INFO - Options: 12:46:00 INFO - -h, --help show this help message and exit 12:46:00 INFO - -d DEST, --destination=DEST 12:46:00 INFO - Directory to install application into. [default: 12:46:00 INFO - "/builds/slave/test"] 12:46:00 INFO - --app=APP Application being installed. [default: firefox] 12:46:00 INFO - mkdir: /builds/slave/test/build/application 12:46:00 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'] 12:46:00 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 12:46:15 INFO - Reading from file tmpfile_stdout 12:46:15 INFO - Output received: 12:46:15 INFO - /builds/slave/test/build/application/firefox/firefox 12:46:15 INFO - Running post-action listener: _resource_record_post_action 12:46:15 INFO - ##### 12:46:15 INFO - ##### Running run-tests step. 12:46:15 INFO - ##### 12:46:15 INFO - Running pre-action listener: _resource_record_pre_action 12:46:15 INFO - Running main action method: run_tests 12:46:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:46:15 INFO - Python 2.7.3 12:46:15 INFO - Return code: 0 12:46:15 INFO - grabbing minidump binary from tooltool 12:46: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')]} 12:46:15 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 0xfd9410>, '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 0xfda310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfda7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:46:15 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 12:46:15 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 12:46:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:46:15 INFO - Return code: 0 12:46:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:46:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:46:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:46:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:46:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:46:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:46:16 INFO - Return code: 0 12:46:16 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:46:16 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:46:16 INFO - Using env: {'DISPLAY': ':0', 12:46:16 INFO - 'HOME': '/home/cltbld', 12:46:16 INFO - 'LANG': 'en_US.UTF-8', 12:46:16 INFO - 'LANGUAGE': 'en_US:en', 12:46:16 INFO - 'LOGNAME': 'cltbld', 12:46:16 INFO - 'MAIL': '/var/mail/cltbld', 12:46:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:46:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:16 INFO - 'MOZ_NO_REMOTE': '1', 12:46:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:46:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:16 INFO - 'NO_EM_RESTART': '1', 12:46:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:16 INFO - 'PWD': '/builds/slave/test', 12:46:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:46:16 INFO - 'SHELL': '/bin/bash', 12:46:16 INFO - 'SHLVL': '1', 12:46:16 INFO - 'TERM': 'linux', 12:46:16 INFO - 'TMOUT': '86400', 12:46:16 INFO - 'USER': 'cltbld', 12:46:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737', 12:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:16 INFO - '_': '/tools/buildbot/bin/python'} 12:46:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:46:17 INFO - mozversion application_buildid: 20160525100739 12:46:17 INFO - mozversion application_changeset: 349688fd0b53507dad2b2e7d358c8d2e9744b557 12:46:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:46:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:46:17 INFO - mozversion application_name: Firefox 12:46:17 INFO - mozversion application_remotingname: firefox-dev 12:46:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:46:17 INFO - mozversion application_vendor: Mozilla 12:46:17 INFO - mozversion application_version: 48.0a2 12:46:17 INFO - mozversion platform_buildid: 20160525100739 12:46:17 INFO - mozversion platform_changeset: 349688fd0b53507dad2b2e7d358c8d2e9744b557 12:46:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:46:17 INFO - mozversion platform_version: 48.0a2 12:46:17 INFO - using testdate: 1464205577 12:46:17 INFO - actual date: 1464205577 12:46:17 INFO - starting webserver on 'localhost:50776' 12:46:17 INFO - SUITE-START | Running 2 tests 12:46:17 INFO - TEST-START | dromaeo_css 12:46:17 INFO - operating with platform_type : linux_ 12:46:17 INFO - Initialising browser for dromaeo_css test... 12:46:17 INFO - TEST-INFO | started process 4371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnPvRcw/profile http://localhost:50776/getInfo.html) 12:46:20 INFO - PROCESS | 4371 | 12:46:20 INFO - PROCESS | 4371 | (process:4453): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:46:21 INFO - PROCESS | 4371 | __metrics Screen width/height:1600/1200 12:46:21 INFO - PROCESS | 4371 | colorDepth:24 12:46:21 INFO - PROCESS | 4371 | Browser inner width/height: 1024/697 12:46:21 INFO - PROCESS | 4371 | __metrics 12:46:22 ERROR - PROCESS | 4371 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 12:46:23 INFO - TEST-INFO | 4371: exit 0 12:46:23 INFO - Browser initialized. 12:46:23 INFO - Running cycle 1/1 for dromaeo_css test... 12:46:23 INFO - TEST-INFO | started process 4504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnPvRcw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:46:24 INFO - PROCESS | 4504 | 12:46:24 INFO - PROCESS | 4504 | (process:4574): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:46:34 INFO - PROCESS | 4504 | RSS: Main: 152162304 12:46:34 INFO - PROCESS | 4504 | 12:47:24 INFO - PROCESS | 4504 | 1464205644530 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] 12:49:31 INFO - PROCESS | 4504 | Cycle 1(1): loaded http://localhost:50776/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50776/tests/dromaeo/cssquery-ext.html) 12:49:32 INFO - PROCESS | 4504 | RSS: Main: 156463104 12:49:32 INFO - PROCESS | 4504 | 12:52:34 INFO - PROCESS | 4504 | Cycle 1(1): loaded http://localhost:50776/tests/dromaeo/cssquery-ext.html (next: http://localhost:50776/tests/dromaeo/cssquery-jquery.html) 12:52:35 INFO - PROCESS | 4504 | RSS: Main: 154091520 12:52:35 INFO - PROCESS | 4504 | 12:55:37 INFO - PROCESS | 4504 | Cycle 1(1): loaded http://localhost:50776/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50776/tests/dromaeo/cssquery-mootools.html) 12:55:37 INFO - PROCESS | 4504 | RSS: Main: 153681920 12:55:37 INFO - PROCESS | 4504 | 12:58:39 INFO - PROCESS | 4504 | Cycle 1(1): loaded http://localhost:50776/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50776/tests/dromaeo/cssquery-prototype.html) 12:58:39 INFO - PROCESS | 4504 | RSS: Main: 153096192 12:58:39 INFO - PROCESS | 4504 | 13:01:42 INFO - PROCESS | 4504 | Cycle 1(1): loaded http://localhost:50776/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50776/tests/dromaeo/cssquery-yui.html) 13:01:42 INFO - PROCESS | 4504 | RSS: Main: 155095040 13:01:42 INFO - PROCESS | 4504 | 13:04:45 INFO - PROCESS | 4504 | Cycle 1(1): loaded http://localhost:50776/tests/dromaeo/cssquery-yui.html (next: http://localhost:50776/tests/dromaeo/cssquery-dojo.html) 13:04:45 INFO - PROCESS | 4504 | RSS: Main: 156553216 13:04:45 INFO - PROCESS | 4504 | 13:04:45 INFO - PROCESS | 4504 | __start_tp_report 13:04:45 INFO - PROCESS | 4504 | _x_x_mozilla_page_load 13:04:45 INFO - PROCESS | 4504 | _x_x_mozilla_page_load_details 13:04:45 INFO - PROCESS | 4504 | |i|pagename|runs| 13:04:45 INFO - PROCESS | 4504 | |0;dojo.html;3329.966700332997;3395.8981230563086;3407.5059116428133;3431.107911942894;3442.173878269216;5553.666779993203;5572.665640061599;5614.214010038588;5618.803341883035;5630.746616402262;5551.056320425528;5561.360443548993;5584.91622625661;5599.300087489064;5627.887442251163;5038.571721403676;5067.391912970449;5103.872403189913;5124.359455068116;5139.974300128494;4914.75426228689;5002.874928126789;5130.743462826862;5192.92210616841;5209.244659524366;5114.820981265657;5132.409772876111;5152.1498952672955;5156.252343410203;5175.223716442545;5098.082345177866;5140.742962851861;5148.716820574867;5157.277981082651;5186.636935414523;4887.291342755316;4934.531219534175;5045.142325804622;5072.644914855961;5111.7699703513435;5360.222767698662;5383.892322153574;5404.972975135139;5412.91880621791;5435.809746658848;5845.210896528956;5855.121731740273;5871.6183448075735;5901.262342207224;5904.261967254093;5861;5882.852928676817;5933.22868027158;5950.494207992326;6038.154658347835;5633.126865335879;5671.319441667027;5686.118651609007;5692.459216374438;5700.828975130711;6106.267247930188;6156.846078848064;6158.907616385758;6162.168107305546;6185.041318595625;5650.830475085754;5791.623544469596;5841.386654401312;5908.497777688945;5921.111833224964;6024.849378765566;6042;6052.092186172109;6053.697315134225;6059.394060593905;5966.671833049224;5970.552208584373;6005.6997150142315;6011.909821352683;6023.518118550505;5769.913451298234;5841.824745257649;5892.5285977122585;5944.405559444021;5951.137085122719;4508.526604706459;4519.593236608721;4533.433320834895;4540.228161212536;4568.520305367889;4037.9394309085387;4072.6741860651077;4100.036491424513;4103.4460347853255;4121.423000779893;5572.3034620672415;5684.971575142098;5687.857803554862;5692.9146062809095;5730.36965933747;5893.44012318829;5900.940990590039;5954.702264886739;5957.285125784933;5985;5567.164925261243;5664.376918538957;5676.8864622707315;5698.116791897262;5718.428157184248;4936.358273424432;4943.604511639132;4945.23348880924;4971.875703107451;5014.022265658162;6103.6948152592195;6104.725287362079;6113.32753397126;6141;6147.415995480422;5859.414058594107;5895.351511333664;5907.49786268172;5918.319393269829;5969.104634304716;6204.162438070803;6207.286162091236;6217.533684973736;6220.284667263141;6222.191115155001;5898.144769008555;5906.26171728534;5909.940900590939;5931.7627294907725;5943.970280148572;5619.409961954099;5923.437273459014;6004.759809607567;6007.849803754766;6036.577439579188;5900;5935.2877654681715;5939.07944268639;5966.642001479925;5972.8805423892145;5843.181954526454;5845.269341332333;5895.616784908967;5896.321922978912;5900.822975310747;5490.972545137409;5637.887242255214;5711.400302968129;5717.714114294352;5750.913736294043;5810.941890581209;5827.9417205829095;5836.299644042572;5858.209141765807;5884.911726324023;5628.043232650377;5747.396523365153;5748.856278593069;5751.568632352507;5751.884962300647 13:04:45 INFO - PROCESS | 4504 | |1;ext.html;678.7047634279089;684.1072400517323;691.9065926099977;729.6278897762143;751.936085432738;33562.83218583907;39142.60857391429;40326.39510407346;40526;40527.59472405275;42997.140057198834;43143.78428107863;43670;43775;44035.11929761403;8755.824883502342;8990.505522196276;8992.64029438825;9004.324675649352;9011.95494022529;8812.1187881212;8868.689595864145;8873.911260887406;8945.463272203657;9035.638574457047;9074.682386116454;9154.359194856363;9156.084391560824;9166.312526560534;9201.677941272057;9015.45907245564;9030.638774449015;9069.909300906973;9084.50035248061;9126.224270936946;8984.056674049196;8994.32542559304;9053.547322633907;9080.954595227047;9086.68196613122;41451.58548414507;42693.78653106745;42821.78589107034;43179.56820431818;43230.56769432297;3834.405667121601;3927.469791578129;3943.1719338938856;3974.0660944678266;3976.7812770297624;33091.33817323664;33481.6651833481;33608;33796.662033379595;33817.32365352704;4622.653301002439;4654.86035418938;4673.299005149221;4704.741239231841;4732.455767586703;310286;310505;310566;311097.44451277825;311163;60931.69534152301;61483.69258153681;61548.38451615426;61650.69174654098;61908.69045654833;75270.62364688142;76834;77142;77321.61339193268;77505;18392.816071839377;18498.075096245135;18531.536711582317;18544;18546.629067418846;15383.307751151226;15386;15427.768583471257;15436.536903892902;15440.382384704486;20717.58564828725;21173.364799056053;21280.574388512145;21458.892705536684;21472;7547.924520754832;7684;7762.8059298516855;7822.295993360511;7832.099308579586;1088.9509972051276;1101.24014430043;1155.7804017236867;1161.9825702614467;1202.7053371923935;32470;32955;33054;33218.66781332204;34241.143971400415;1228.9324087175112;1248.831407759959;1311.272243904623;1317.7957416600443;1323.0738483061896;17246.310147594206;17260.568485787706;17331.826681733022;17395.826041739674;17400.73898891518;477823;492259;499514;523497;528349;54518.45481545134;55421.44578554243;55434.44565554293;55459;55527;1513.7275290447606;1517.9089254644757;1537.1468834796794;1565.9217039147998;1670.2066518403904;33029.50455743118;34271.31457370789;34329.828350858086;34533;34807.82596087003;54442;59607.70196148992;61067.38932610617;61263.38736612577;61581.692091539255;435494;442841;445220;445348;446014;41805.372919406844;42120.36819447772;42394;42567;46217;51104.74447627738;51462.22806657978;51523.742381287855;52285.7385713069;52356.73821630867;40989.59010409858;43425.782871085445;43594.56405436032;44143.77928110339;44733.32900006568;42407.575924240366;43128.35307470328;43382.56617433912;43470.565294347914;43715.78142109269;39056.39043439739;39170.80414597909;39337.40993885151;39492.80253598714;39507.209855802146;37238.8138059308;37338.8133059333;37513.812430938764;37611;38285.6171438282;29387.85306073456;29760.255993600334;30024.249393764458;30084.84957575198;30427.391452171276 13:04:45 INFO - PROCESS | 4504 | |2;jquery.html;413.5533623686418;424.5012110769845;438.17622869006266;438.95829896159853;444.61762883919823;18414.44756657299;19155.42533723989;19179.232830686775;20779.584408311825;21792.89103554484;13189.472421103144;13402.396892139852;17567.385141520048;20378;20398;5290.761915713783;5468.343798744137;5516.475934786189;5528.917066244009;6614.107095542088;6421.036844473343;6520.18497687789;6527.314631963647;6539.542232043759;6575.901361479581;6256.655883926383;6424.646644434578;6428.389303016206;6449.54853160279;6515.967420162892;6391.296957334689;6398.29618741938;6404.199475065593;6407.231132264134;6408.166938297992;5809.448102430305;5882.323532793698;5947.910781338283;6003.189569408118;6010.789622363196;14671.77992330116;15042.699146017017;15634.45279415215;23692.881535592212;24276.514469710684;2491.476789874129;2519.6472493850874;2733.3986522964915;2810.437912417525;2835.1636267301196;8476.83046339076;10750.193735469793;10759.193060520414;11023.669289921316;14177.05081782994;2002.389271272276;2054.414491869825;2069.048237810609;2117.9788202117934;2153.310940499041;77465.22534774637;80061;81507.18492815056;82765.9999999994;82901;11538.88461115395;11664;11923.880761192277;11938.462769175409;12023.098267629963;16568.917155414147;16660.916695416687;16676;16734.916325418297;16761.664766704598;8680.392372533863;8780.824383512421;8798.648054077894;8857.158569935846;8945.955270223738;8286.46138001028;8404.285635721033;8454.577271136419;8483.363747718946;8484.278836298983;5143.742812859342;5156.071907056691;5162.638615296968;5174.223866420067;5197.532222100029;2036.1549956768072;2093.2568938027084;2129.787021297858;2152.160657343637;2175.0973346061205;1043.9321444106108;1063.5745701719375;1126.2566705974182;1139.8119310313705;1159.913006524514;19121.713174302397;19534.90232548828;19846.007699614962;19970.129934783865;20018;1041.4220107840222;1156.7397335599424;1157.1032449851264;1195.3246415775059;1214.860291066521;11158.832617510743;11307.321560706385;11332.093432525378;11340.94329528347;11353.148513861328;545854;546398;559365;564055;572761;53655.731721341144;55020.174697379574;56712.86574268492;92330.53834730784;95062.52468737612;1105.3257512917114;1110.600183933767;1115.5259014918627;1138.6925530106826;1148.4085695866636;17468.47594572165;17903.910480447514;17908.820911790714;18026.729599056285;18157.54606134857;26172.345691357106;37242.441363380116;37955.71338836677;38383.42424863685;40102.1979560413;57139.42860571341;57487.42512574988;57839.710801445726;58201.417985821296;58256.41743582679;8623.784405389915;8889.422187557788;8919.509426981578;8982.730518084469;9048.457092574467;12420.130590858553;12548.49806007786;12765.744685106432;13099.148555343872;13272.402741876445;11421;11507.424628768695;11514.42427878586;11523.13576481784;11740.706482337668;11281.492332845206;11673.766524669629;11729.941350293195;11858;11963.76072478563;12352.567660131852;12432.875671243171;12440.81338779901;12558.43487043067;12647;8701.695440659547;8753.12468753145;8784.868226976729;8899.599518021576;8932.28541716674;11037.282576632493;11359.432028398713;11371.886281137082;11437.828432573351;11518.654440366803 13:04:45 INFO - PROCESS | 4504 | |3;mootools.html;1560.6956643454528;1606.1728209971864;1857.071464267866;1933.9033048347578;1950.1711772496685;7831.3343365813835;7910.604469776503;8569.485830850153;8812.91187088129;8866.379353445262;8466.365022623297;8488.83022339553;8499.192576705218;8519.616617252223;8578.528180950045;2347.835651504395;2350.3771500552325;2357.4577847095093;2372.78644921957;2376.5009348036933;2374.133441293924;2376.95246095078;2438.1100898172217;2440.8779561021965;2444.40112172518;2397.1130681647815;2401.9159329423474;2406.2781165650235;2426.0417135231573;2447.8286519943613;2373.6439534069855;2376.762323767618;2377;2392.5334559760854;2405.6391541268777;2389.6535002424725;2396.664466974625;2404.5912194926905;2410.6745589345387;2411.3007227904063;8824.602892869772;8855.24730397917;8859.867101993475;8870.112988701077;8934.061923498004;5266.657667251617;5293.470652934676;5306.124489459235;5316.680999140064;5351.331083614548;3564.8930532084078;3571.785692858437;3634.8364323605238;3672.375696131664;3690.8004898407858;1258.9496420143182;1295.1452041652558;1296.5008471738354;1306.614548708124;1333.1134795361074;11919.523219071227;11927.642170734893;11938.343391113573;11948.402579870972;12011.279323240633;4500.549945005539;4657.743824089707;4718.079974404958;4750.453697824794;4782.234842425195;10246.6413675521;10275.486225688686;10275.7431064224;10306.433146176882;10323.48382580868;5346.946530534723;5358.973205134027;5372.946270537323;5392.191171324254;5398.1093119634825;4451.109778044404;4916.975415122902;4996.550310472075;5059.468755780664;5066.695998240118;4144;4152.065785198306;4160.396742472324;4178;4194.916101677949;1317.9735906804613;1322.358656051814;1330.2683524061727;1390.7844284135974;1403.3123769353147;1103.8454616353717;1110.7389763405592;1116.9776604467866;1122.7698321844002;1139.9316041037564;6206.565540412128;6215.595986260879;6329.588576742497;6380.84047898797;6471.285109446;470.8822794301425;476.09066682636;479.87283369907004;484.530005894282;489.87997940504806;4309.569043095666;4357.477102747691;4357.694961352675;4378.934315985262;4397.494288156839;10501.684949451528;10878.619248326271;10996.560137594406;11004.559817607365;11020;10090.69727908164;10472.424016679004;10779.67660970172;10894.128469722404;10895.782084358427;8211.548364839991;8250;8278.337732981347;8288.544130072783;8290.8341833163;6115.388461153849;6312.558120931674;6354.205724284465;6365.777197798055;6383.329750376143;9328.95335523318;9630.807383852423;9656.517174141125;9665.178459830993;9673.951630241803;9848;9945.651902183388;10108.595656173671;10230.795384092426;10268.897311026794;7142.821429464305;8003.679852806055;8029.4379393441895;8106.9189308108525;8323.375746819134;8460.746177614436;8475.237228649452;8477.194666506672;8495.617697203765;8509.404341696269;7214.098237720285;7389.445791565761;7607.429442791702;7705.576193309422;7862.135165131716;7595.354394876497;7610.505317154367;7665.808354790952;7697.114831794415;7803.843923121392;7100.254473280231;7183.102112235971;7225.096862892138;7233.529820561646;7234.927650723636;5335.253064571041;5414.160805075219;5469.753861076181;5481.369642491165;5534.612577119724;5323.095073837534;5431.6740995540395;5477.835664930059;5529.364123125892;5625.156226566048 13:04:45 INFO - PROCESS | 4504 | |4;prototype.html;344.9517067610535;357.18561679371044;360.2848346033124;364.91059690375846;365.60332039736886;6456.8385790355205;6504.252011018734;6536.575122617027;6543.378379053994;6577.967110164448;6413.845507808593;6473.287938326792;6531.314212007742;6568.605883646985;6578.24350199726;4979;4979.755061234691;4989.850304490871;4991.525805048533;5000.249962505635;4981.9750901245625;4983.8504844854715;4988.850334489971;4991.450940396553;4991.775370108354;4945.258211268302;4953.752312384385;4956.975215123919;4958.826441074563;4963.40439147301;4821.204501257288;4932.926006109911;4933.506649335073;4936.605071594264;4939.703617782944;4365.432493775789;4381.846635367747;4391.6047555719815;4396.450443694538;4402.93395599063;6227.782027629011;6237.407446292595;6295.2760432550385;6352.46004089653;6366.71349789256;5749.482546570829;5800.274965629296;5830.62100963436;5843.5033022193165;5915.260592425947;6978.232394436608;6983.720651173947;6986.476014298897;6994.650267486605;7003.859922801566;4946.134426475388;4950.975245123787;4954.182559877616;4959.8264060758065;4962.528559786814;7208.49540532163;7295.817604559876;7310.890336644955;7317.707291708379;7319.963400183018;4807.351007613927;5093.134167191586;5104.03023425548;5108.923366149511;5121.052605268037;4966.950330496648;4998.9500104999215;5014.473480284591;5015.84952451427;5040.47075057121;5780.1907732917425;5814.360420353758;5819.82540523785;5828.979928512578;5830;6986.825329366807;6988.6855091521;6999.160100787938;7006.01915731798;7038.803403421328;1786.9903504519905;1810.809864964186;1811.1849667649346;1813.2112531049036;1813.7098064309912;1169.4971961030035;1177.7526719389025;1218.5674085699627;1227.4353797253184;1253.8996880249558;6690.063391125246;6740.359665831738;6744.966275168593;6750.32496750321;6765.221999470025;7159.212486626571;7178.5692858428665;7183.96408017967;7195.964020179866;7197;6699.765508207287;6717.764878229238;6721.193456785217;6724.327567243335;6746.156730408699;3851.9422208666892;3894.435306880543;3903.316919539069;3909.3940439231965;3912.3349030664854;7379.114506259176;7652.693892244248;7670.884936725954;7674.42441816866;7685.346745526693;7494.362979146725;7496.7001319947685;7512.549247045085;7537.54774713519;7548.094228692592;7609.771706848804;7616.352610028099;7627.4279429041935;7642;7661.118971318369;7160.10498687664;7319.487635865651;7319.963400182965;7346.265373462611;7384.18773934856;7158.391536719437;7219.530730502501;7225.927740722525;7230.927690723025;7231.746888858865;7593.316601505891;7617.390608751176;7624.656890439833;7639.083310002613;7649.541027538366;4881.487443818348;4943.703377797344;4949.034938187163;4961.479044700254;4970.105381031449;7175.712971481083;7311.4516411268305;7319.707211711472;7328.450366222662;7334.413246940126;7073.858522829618;7104.857902842017;7105.32499412555;7107;7126.394256488256;7035.437165026683;7039.718411263492;7051.6474176292;7056.259092795182;7067.858642827012;6808.9659551701925;6829.2487826338065;6847.760328388682;6862.4853136016;6864.38220560152;6896.620685862125;7082.185548661764;7109.324614161853;7134.60759658203;7153.928460715534;6711.228208755861;6824.112865327475;6825.795226143224;6921.892497200423;6998.790036298919 13:04:45 INFO - PROCESS | 4504 | |5;yui.html;842.3303473738381;842.9915700842994;846.9237768600825;888.5246393179648;962.6245764151978;14989.325480353384;15176.241187940614;15243.847561524395;15333.463328783495;15336.693266134684;13974.301284935764;14292.071015383994;14303;14370;14374.640633984156;740.0896896816919;865.0225245472639;887.6626881784913;894.8120894612139;900.621738869673;903.268352634365;906.6237511432747;907.0158877617793;909.6543313540845;911.4349103555771;935.1303287942211;937.5687183895416;937.8265020971143;938.1041105743998;938.197840846077;927.1701826864918;931.1573026411075;934.1685899549407;934.6588495199271;936.967206147785;684.8253695307715;685.9759908403182;687.8211664967095;692.3111504053448;692.3353580562666;14047;14248.786268205986;14257.714845703027;14268.85731142696;14280.785788213185;14741.778873316909;14767.409303627843;14799;14944.775828362583;14954.62613434662;11975.700607484796;12077.15459917806;12218.75562488754;12310.26138431697;12464.252144871247;3935.1736135411597;3953.920921581581;4028.8992775180564;4054.8783536493656;4139.130782535671;54061;54938.72530637361;54954.725226373615;55071.449285507435;55129.173062404094;11501.76996460066;11531.942340288246;11615.477303521362;11618.302901825917;11757.353345566076;20143.496412589804;20294.289699860434;20328.186872525228;20331;20349.59300814005;8814.603342849587;8830.690925817695;8932.419392739452;9027;9080.545972701339;4991.775370108354;5114.462981386975;5144.228365745168;5312.601554883322;5344.946550534522;3346.9497957530657;3423.298223864102;3424;3427.8800241991908;3429.725621950238;633.9270983836825;638.4796390941368;645.029231007331;651.2087813306855;658.2200092889941;741.3105811595268;778.1673609238061;861.978450538729;863.792689754467;864.7146441674232;9969.50152492387;10243.84634230487;10300.793984120275;10350;10361.119304859021;759.369723129801;829.1666874790917;832.2842355574202;832.4589017138908;849.5454931611682;4740.5733483986605;4765.5949244314625;4921.50784921505;4959.355283813081;4987.526185012418;66610.66694666496;67568;67966.66016669886;67976.32023679798;68205;56172;58986.705066474395;59037.048147592446;60385.39614603885;62167;47737.522624774;48000.51999480031;51503;52113;52169;9456.952715236379;9509.239260859253;9558.474283914451;9659.806803864023;9778.07108324708;39613;39671.2065758689;40369.59630403658;40502.79748601356;41167.382489263284;50089;50646;51464.485355147466;51483;53065;11275.492602833056;11345.205835591429;11380.089592832719;11505.25215861;11568.132390070947;12320.568780092653;12518.311492867979;12565.37173141321;12667.17663351916;12823.358832058173;12076.75846483083;12110.394480276127;12128.939355303168;12458.501659933501;12469.127161098637;13168.078234523491;13204.339783010619;13436.19382837033;13826.723465530431;13933.372998215307;11662.573134447723;12859.807102893652;12977.221366718028;13511.038057658208;13532.59402217935;10774.676759697222;10816.134709223086;10997.285176463503;11132.888671113185;11155.330680159217;11092.833607495733;11218.214724969173;11338.829917551408;11510.36692981894;11636.53453861836 13:04:45 INFO - PROCESS | 4504 | __end_tp_report 13:04:45 INFO - PROCESS | 4504 | __start_cc_report 13:04:45 INFO - PROCESS | 4504 | _x_x_mozilla_cycle_collect,342 13:04:45 INFO - PROCESS | 4504 | __end_cc_report 13:04:45 INFO - PROCESS | 4504 | __startTimestamp1464206685289__endTimestamp 13:04:45 INFO - PROCESS | 4504 | 13:04:45 INFO - PROCESS | 4504 | ------- Summary: start ------- 13:04:45 INFO - PROCESS | 4504 | Number of tests: 6 13:04:45 INFO - PROCESS | 4504 | 13:04:45 INFO - PROCESS | 4504 | [#0] dojo.html Cycles:165 Average:5540.86 Median:5747.40 stddev:612.10 (10.7%) stddev-sans-first:588.90 13:04:45 INFO - PROCESS | 4504 | Values: 3330.0 3395.9 3407.5 3431.1 3442.2 5553.7 5572.7 5614.2 5618.8 5630.7 5551.1 5561.4 5584.9 5599.3 5627.9 5038.6 5067.4 5103.9 5124.4 5140.0 4914.8 5002.9 5130.7 5192.9 5209.2 5114.8 5132.4 5152.1 5156.3 5175.2 5098.1 5140.7 5148.7 5157.3 5186.6 4887.3 4934.5 5045.1 5072.6 5111.8 5360.2 5383.9 5405.0 5412.9 5435.8 5845.2 5855.1 5871.6 5901.3 5904.3 5861.0 5882.9 5933.2 5950.5 6038.2 5633.1 5671.3 5686.1 5692.5 5700.8 6106.3 6156.8 6158.9 6162.2 6185.0 5650.8 5791.6 5841.4 5908.5 5921.1 6024.8 6042.0 6052.1 6053.7 6059.4 5966.7 5970.6 6005.7 6011.9 6023.5 5769.9 5841.8 5892.5 5944.4 5951.1 4508.5 4519.6 4533.4 4540.2 4568.5 4037.9 4072.7 4100.0 4103.4 4121.4 5572.3 5685.0 5687.9 5692.9 5730.4 5893.4 5900.9 5954.7 5957.3 5985.0 5567.2 5664.4 5676.9 5698.1 5718.4 4936.4 4943.6 4945.2 4971.9 5014.0 6103.7 6104.7 6113.3 6141.0 6147.4 5859.4 5895.4 5907.5 5918.3 5969.1 6204.2 6207.3 6217.5 6220.3 6222.2 5898.1 5906.3 5909.9 5931.8 5944.0 5619.4 5923.4 6004.8 6007.8 6036.6 5900.0 5935.3 5939.1 5966.6 5972.9 5843.2 5845.3 5895.6 5896.3 5900.8 5491.0 5637.9 5711.4 5717.7 5750.9 5810.9 5827.9 5836.3 5858.2 5884.9 5628.0 5747.4 5748.9 5751.6 5751.9 13:04:45 INFO - PROCESS | 4504 | 13:04:45 INFO - PROCESS | 4504 | [#1] ext.html Cycles:180 Average:60110.11 Median:43136.07 stddev:112896.96 (261.7%) stddev-sans-first:113125.48 13:04:45 INFO - PROCESS | 4504 | Values: 678.7 684.1 691.9 729.6 751.9 33562.8 39142.6 40326.4 40526.0 40527.6 42997.1 43143.8 43670.0 43775.0 44035.1 8755.8 8990.5 8992.6 9004.3 9012.0 8812.1 8868.7 8873.9 8945.5 9035.6 9074.7 9154.4 9156.1 9166.3 9201.7 9015.5 9030.6 9069.9 9084.5 9126.2 8984.1 8994.3 9053.5 9081.0 9086.7 41451.6 42693.8 42821.8 43179.6 43230.6 3834.4 3927.5 3943.2 3974.1 3976.8 33091.3 33481.7 33608.0 33796.7 33817.3 4622.7 4654.9 4673.3 4704.7 4732.5 310286.0 310505.0 310566.0 311097.4 311163.0 60931.7 61483.7 61548.4 61650.7 61908.7 75270.6 76834.0 77142.0 77321.6 77505.0 18392.8 18498.1 18531.5 18544.0 18546.6 15383.3 15386.0 15427.8 15436.5 15440.4 20717.6 21173.4 21280.6 21458.9 21472.0 7547.9 7684.0 7762.8 7822.3 7832.1 1089.0 1101.2 1155.8 1162.0 1202.7 32470.0 32955.0 33054.0 33218.7 34241.1 1228.9 1248.8 1311.3 1317.8 1323.1 17246.3 17260.6 17331.8 17395.8 17400.7 477823.0 492259.0 499514.0 523497.0 528349.0 54518.5 55421.4 55434.4 55459.0 55527.0 1513.7 1517.9 1537.1 1565.9 1670.2 33029.5 34271.3 34329.8 34533.0 34807.8 54442.0 59607.7 61067.4 61263.4 61581.7 435494.0 442841.0 445220.0 445348.0 446014.0 41805.4 42120.4 42394.0 42567.0 46217.0 51104.7 51462.2 51523.7 52285.7 52356.7 40989.6 43425.8 43594.6 44143.8 44733.3 42407.6 43128.4 43382.6 43470.6 43715.8 39056.4 39170.8 39337.4 39492.8 39507.2 37238.8 37338.8 37513.8 37611.0 38285.6 29387.9 29760.3 30024.2 30084.8 30427.4 13:04:45 INFO - PROCESS | 4504 | 13:04:45 INFO - PROCESS | 4504 | [#2] jquery.html Cycles:180 Average:30236.73 Median:11983.99 stddev:91307.08 (761.9%) stddev-sans-first:91535.75 13:04:45 INFO - PROCESS | 4504 | Values: 413.6 424.5 438.2 439.0 444.6 18414.4 19155.4 19179.2 20779.6 21792.9 13189.5 13402.4 17567.4 20378.0 20398.0 5290.8 5468.3 5516.5 5528.9 6614.1 6421.0 6520.2 6527.3 6539.5 6575.9 6256.7 6424.6 6428.4 6449.5 6516.0 6391.3 6398.3 6404.2 6407.2 6408.2 5809.4 5882.3 5947.9 6003.2 6010.8 14671.8 15042.7 15634.5 23692.9 24276.5 2491.5 2519.6 2733.4 2810.4 2835.2 8476.8 10750.2 10759.2 11023.7 14177.1 2002.4 2054.4 2069.0 2118.0 2153.3 77465.2 80061.0 81507.2 82766.0 82901.0 11538.9 11664.0 11923.9 11938.5 12023.1 16568.9 16660.9 16676.0 16734.9 16761.7 8680.4 8780.8 8798.6 8857.2 8946.0 8286.5 8404.3 8454.6 8483.4 8484.3 5143.7 5156.1 5162.6 5174.2 5197.5 2036.2 2093.3 2129.8 2152.2 2175.1 1043.9 1063.6 1126.3 1139.8 1159.9 19121.7 19534.9 19846.0 19970.1 20018.0 1041.4 1156.7 1157.1 1195.3 1214.9 11158.8 11307.3 11332.1 11340.9 11353.1 545854.0 546398.0 559365.0 564055.0 572761.0 53655.7 55020.2 56712.9 92330.5 95062.5 1105.3 1110.6 1115.5 1138.7 1148.4 17468.5 17903.9 17908.8 18026.7 18157.5 26172.3 37242.4 37955.7 38383.4 40102.2 57139.4 57487.4 57839.7 58201.4 58256.4 8623.8 8889.4 8919.5 8982.7 9048.5 12420.1 12548.5 12765.7 13099.1 13272.4 11421.0 11507.4 11514.4 11523.1 11740.7 11281.5 11673.8 11729.9 11858.0 11963.8 12352.6 12432.9 12440.8 12558.4 12647.0 8701.7 8753.1 8784.9 8899.6 8932.3 11037.3 11359.4 11371.9 11437.8 11518.7 13:04:45 INFO - PROCESS | 4504 | 13:04:45 INFO - PROCESS | 4504 | [#3] mootools.html Cycles:180 Average:5840.58 Median:2631.05 stddev:3203.07 (121.7%) stddev-sans-first:3195.90 13:04:45 INFO - PROCESS | 4504 | Values: 1560.7 1606.2 1857.1 1933.9 1950.2 7831.3 7910.6 8569.5 8812.9 8866.4 8466.4 8488.8 8499.2 8519.6 8578.5 2347.8 2350.4 2357.5 2372.8 2376.5 2374.1 2377.0 2438.1 2440.9 2444.4 2397.1 2401.9 2406.3 2426.0 2447.8 2373.6 2376.8 2377.0 2392.5 2405.6 2389.7 2396.7 2404.6 2410.7 2411.3 8824.6 8855.2 8859.9 8870.1 8934.1 5266.7 5293.5 5306.1 5316.7 5351.3 3564.9 3571.8 3634.8 3672.4 3690.8 1258.9 1295.1 1296.5 1306.6 1333.1 11919.5 11927.6 11938.3 11948.4 12011.3 4500.5 4657.7 4718.1 4750.5 4782.2 10246.6 10275.5 10275.7 10306.4 10323.5 5346.9 5359.0 5372.9 5392.2 5398.1 4451.1 4917.0 4996.6 5059.5 5066.7 4144.0 4152.1 4160.4 4178.0 4194.9 1318.0 1322.4 1330.3 1390.8 1403.3 1103.8 1110.7 1117.0 1122.8 1139.9 6206.6 6215.6 6329.6 6380.8 6471.3 470.9 476.1 479.9 484.5 489.9 4309.6 4357.5 4357.7 4378.9 4397.5 10501.7 10878.6 10996.6 11004.6 11020.0 10090.7 10472.4 10779.7 10894.1 10895.8 8211.5 8250.0 8278.3 8288.5 8290.8 6115.4 6312.6 6354.2 6365.8 6383.3 9329.0 9630.8 9656.5 9665.2 9674.0 9848.0 9945.7 10108.6 10230.8 10268.9 7142.8 8003.7 8029.4 8106.9 8323.4 8460.7 8475.2 8477.2 8495.6 8509.4 7214.1 7389.4 7607.4 7705.6 7862.1 7595.4 7610.5 7665.8 7697.1 7803.8 7100.3 7183.1 7225.1 7233.5 7234.9 5335.3 5414.2 5469.8 5481.4 5534.6 5323.1 5431.7 5477.8 5529.4 5625.2 13:04:45 INFO - PROCESS | 4504 | 13:04:45 INFO - PROCESS | 4504 | [#4] prototype.html Cycles:180 Average:5874.48 Median:6694.91 stddev:1785.37 (26.7%) stddev-sans-first:1741.47 13:04:45 INFO - PROCESS | 4504 | Values: 345.0 357.2 360.3 364.9 365.6 6456.8 6504.3 6536.6 6543.4 6578.0 6413.8 6473.3 6531.3 6568.6 6578.2 4979.0 4979.8 4989.9 4991.5 5000.2 4982.0 4983.9 4988.9 4991.5 4991.8 4945.3 4953.8 4957.0 4958.8 4963.4 4821.2 4932.9 4933.5 4936.6 4939.7 4365.4 4381.8 4391.6 4396.5 4402.9 6227.8 6237.4 6295.3 6352.5 6366.7 5749.5 5800.3 5830.6 5843.5 5915.3 6978.2 6983.7 6986.5 6994.7 7003.9 4946.1 4951.0 4954.2 4959.8 4962.5 7208.5 7295.8 7310.9 7317.7 7320.0 4807.4 5093.1 5104.0 5108.9 5121.1 4967.0 4999.0 5014.5 5015.8 5040.5 5780.2 5814.4 5819.8 5829.0 5830.0 6986.8 6988.7 6999.2 7006.0 7038.8 1787.0 1810.8 1811.2 1813.2 1813.7 1169.5 1177.8 1218.6 1227.4 1253.9 6690.1 6740.4 6745.0 6750.3 6765.2 7159.2 7178.6 7184.0 7196.0 7197.0 6699.8 6717.8 6721.2 6724.3 6746.2 3851.9 3894.4 3903.3 3909.4 3912.3 7379.1 7652.7 7670.9 7674.4 7685.3 7494.4 7496.7 7512.5 7537.5 7548.1 7609.8 7616.4 7627.4 7642.0 7661.1 7160.1 7319.5 7320.0 7346.3 7384.2 7158.4 7219.5 7225.9 7230.9 7231.7 7593.3 7617.4 7624.7 7639.1 7649.5 4881.5 4943.7 4949.0 4961.5 4970.1 7175.7 7311.5 7319.7 7328.5 7334.4 7073.9 7104.9 7105.3 7107.0 7126.4 7035.4 7039.7 7051.6 7056.3 7067.9 6809.0 6829.2 6847.8 6862.5 6864.4 6896.6 7082.2 7109.3 7134.6 7153.9 6711.2 6824.1 6825.8 6921.9 6998.8 13:04:45 INFO - PROCESS | 4504 | 13:04:45 INFO - PROCESS | 4504 | [#5] yui.html Cycles:180 Average:15698.93 Median:26251.56 stddev:18297.58 (69.7%) stddev-sans-first:18314.89 13:04:45 INFO - PROCESS | 4504 | Values: 842.3 843.0 846.9 888.5 962.6 14989.3 15176.2 15243.8 15333.5 15336.7 13974.3 14292.1 14303.0 14370.0 14374.6 740.1 865.0 887.7 894.8 900.6 903.3 906.6 907.0 909.7 911.4 935.1 937.6 937.8 938.1 938.2 927.2 931.2 934.2 934.7 937.0 684.8 686.0 687.8 692.3 692.3 14047.0 14248.8 14257.7 14268.9 14280.8 14741.8 14767.4 14799.0 14944.8 14954.6 11975.7 12077.2 12218.8 12310.3 12464.3 3935.2 3953.9 4028.9 4054.9 4139.1 54061.0 54938.7 54954.7 55071.4 55129.2 11501.8 11531.9 11615.5 11618.3 11757.4 20143.5 20294.3 20328.2 20331.0 20349.6 8814.6 8830.7 8932.4 9027.0 9080.5 4991.8 5114.5 5144.2 5312.6 5344.9 3346.9 3423.3 3424.0 3427.9 3429.7 633.9 638.5 645.0 651.2 658.2 741.3 778.2 862.0 863.8 864.7 9969.5 10243.8 10300.8 10350.0 10361.1 759.4 829.2 832.3 832.5 849.5 4740.6 4765.6 4921.5 4959.4 4987.5 66610.7 67568.0 67966.7 67976.3 68205.0 56172.0 58986.7 59037.0 60385.4 62167.0 47737.5 48000.5 51503.0 52113.0 52169.0 9457.0 9509.2 9558.5 9659.8 9778.1 39613.0 39671.2 40369.6 40502.8 41167.4 50089.0 50646.0 51464.5 51483.0 53065.0 11275.5 11345.2 11380.1 11505.3 11568.1 12320.6 12518.3 12565.4 12667.2 12823.4 12076.8 12110.4 12128.9 12458.5 12469.1 13168.1 13204.3 13436.2 13826.7 13933.4 11662.6 12859.8 12977.2 13511.0 13532.6 10774.7 10816.1 10997.3 11132.9 11155.3 11092.8 11218.2 11338.8 11510.4 11636.5 13:04:45 INFO - PROCESS | 4504 | -------- Summary: end -------- 13:04:45 INFO - PROCESS | 4504 | 13:04:45 INFO - TEST-INFO | 4504: exit 0 13:04:46 INFO - TEST-OK | dromaeo_css | took 1108968ms 13:04:46 INFO - TEST-START | kraken 13:04:46 INFO - operating with platform_type : linux_ 13:04:46 INFO - Initialising browser for kraken test... 13:04:46 INFO - TEST-INFO | started process 4752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2DYhKX/profile http://localhost:50776/getInfo.html) 13:04:49 INFO - PROCESS | 4752 | 13:04:49 INFO - PROCESS | 4752 | (process:4831): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:04:50 INFO - PROCESS | 4752 | __metrics Screen width/height:1600/1200 13:04:50 INFO - PROCESS | 4752 | colorDepth:24 13:04:50 INFO - PROCESS | 4752 | Browser inner width/height: 1024/697 13:04:50 INFO - PROCESS | 4752 | __metrics 13:04:51 ERROR - PROCESS | 4752 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 13:04:51 INFO - TEST-INFO | 4752: exit 0 13:04:51 INFO - Browser initialized. 13:04:51 INFO - Running cycle 1/1 for kraken test... 13:04:51 INFO - TEST-INFO | started process 4882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2DYhKX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:04:53 INFO - PROCESS | 4882 | 13:04:53 INFO - PROCESS | 4882 | (process:4954): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:05:03 INFO - PROCESS | 4882 | RSS: Main: 152293376 13:05:03 INFO - PROCESS | 4882 | 13:05:06 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:50776/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50776/tests/kraken/driver.html?testName=audio-beat-detection) 13:05:07 INFO - PROCESS | 4882 | RSS: Main: 156463104 13:05:07 INFO - PROCESS | 4882 | 13:05:09 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:50776/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50776/tests/kraken/driver.html?testName=audio-dft) 13:05:10 INFO - PROCESS | 4882 | RSS: Main: 157380608 13:05:10 INFO - PROCESS | 4882 | 13:05:13 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:50776/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50776/tests/kraken/driver.html?testName=audio-fft) 13:05:13 INFO - PROCESS | 4882 | RSS: Main: 157655040 13:05:13 INFO - PROCESS | 4882 | 13:05:15 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:50776/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50776/tests/kraken/driver.html?testName=audio-oscillator) 13:05:16 INFO - PROCESS | 4882 | RSS: Main: 157212672 13:05:16 INFO - PROCESS | 4882 | 13:05:18 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:50776/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50776/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:05:19 INFO - PROCESS | 4882 | RSS: Main: 157007872 13:05:19 INFO - PROCESS | 4882 | 13:05:22 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:50776/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50776/tests/kraken/driver.html?testName=imaging-darkroom) 13:05:23 INFO - PROCESS | 4882 | RSS: Main: 157589504 13:05:23 INFO - PROCESS | 4882 | 13:05:26 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:50776/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50776/tests/kraken/driver.html?testName=imaging-desaturate) 13:05:27 INFO - PROCESS | 4882 | RSS: Main: 157446144 13:05:27 INFO - PROCESS | 4882 | 13:05:29 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:50776/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50776/tests/kraken/driver.html?testName=json-parse-financial) 13:05:30 INFO - PROCESS | 4882 | RSS: Main: 157470720 13:05:30 INFO - PROCESS | 4882 | 13:05:32 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:50776/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50776/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:05:32 INFO - PROCESS | 4882 | RSS: Main: 157351936 13:05:32 INFO - PROCESS | 4882 | 13:05:34 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:50776/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50776/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:05:34 INFO - PROCESS | 4882 | RSS: Main: 157700096 13:05:34 INFO - PROCESS | 4882 | 13:05:36 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:50776/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50776/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:05:37 INFO - PROCESS | 4882 | RSS: Main: 157585408 13:05:37 INFO - PROCESS | 4882 | 13:05:40 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:50776/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50776/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:05:40 INFO - PROCESS | 4882 | RSS: Main: 158396416 13:05:40 INFO - PROCESS | 4882 | 13:05:43 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:50776/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50776/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:05:44 INFO - PROCESS | 4882 | RSS: Main: 157499392 13:05:44 INFO - PROCESS | 4882 | 13:05:45 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:50776/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50776/tests/kraken/driver.html?testName=ai-astar) 13:05:46 INFO - PROCESS | 4882 | RSS: Main: 159752192 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | __start_tp_report 13:05:46 INFO - PROCESS | 4882 | _x_x_mozilla_page_load 13:05:46 INFO - PROCESS | 4882 | _x_x_mozilla_page_load_details 13:05:46 INFO - PROCESS | 4882 | |i|pagename|runs| 13:05:46 INFO - PROCESS | 4882 | |0;ai-astar;109;112;104;110;112;115;100;112;111;111 13:05:46 INFO - PROCESS | 4882 | |1;audio-beat-detection;156;125;151;186;128;156;158;139;180;133 13:05:46 INFO - PROCESS | 4882 | |2;audio-dft;163;163;165;161;162;162;161;161;161;162 13:05:46 INFO - PROCESS | 4882 | |3;audio-fft;75;75;74;178;77;72;74;76;152;76 13:05:46 INFO - PROCESS | 4882 | |4;audio-oscillator;93;92;156;92;92;94;148;92;94;151 13:05:46 INFO - PROCESS | 4882 | |5;imaging-gaussian-blur;116;117;118;117;117;117;117;117;117;118 13:05:46 INFO - PROCESS | 4882 | |6;imaging-darkroom;146;146;146;148;146;149;146;148;147;146 13:05:46 INFO - PROCESS | 4882 | |7;imaging-desaturate;96;95;95;96;95;96;96;94;96;95 13:05:46 INFO - PROCESS | 4882 | |8;json-parse-financial;56;59;57;61;56;59;61;71;55;56 13:05:46 INFO - PROCESS | 4882 | |9;json-stringify-tinderbox;58;60;59;59;58;58;58;59;58;59 13:05:46 INFO - PROCESS | 4882 | |10;stanford-crypto-aes;72;79;83;72;74;76;75;81;76;74 13:05:46 INFO - PROCESS | 4882 | |11;stanford-crypto-ccm;120;112;117;112;114;115;112;113;133;137 13:05:46 INFO - PROCESS | 4882 | |12;stanford-crypto-pbkdf2;163;166;164;164;164;171;169;163;160;161 13:05:46 INFO - PROCESS | 4882 | |13;stanford-crypto-sha256-iterative;69;68;66;67;65;68;66;64;68;67 13:05:46 INFO - PROCESS | 4882 | __end_tp_report 13:05:46 INFO - PROCESS | 4882 | __start_cc_report 13:05:46 INFO - PROCESS | 4882 | _x_x_mozilla_cycle_collect,860 13:05:46 INFO - PROCESS | 4882 | __end_cc_report 13:05:46 INFO - PROCESS | 4882 | __startTimestamp1464206746015__endTimestamp 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | ------- Summary: start ------- 13:05:46 INFO - PROCESS | 4882 | Number of tests: 14 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.50 stddev:4.40 (3.9%) stddev-sans-first:4.66 13:05:46 INFO - PROCESS | 4882 | Values: 109.0 112.0 104.0 110.0 112.0 115.0 100.0 112.0 111.0 111.0 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:156.00 stddev:20.65 (13.2%) stddev-sans-first:21.83 13:05:46 INFO - PROCESS | 4882 | Values: 156.0 125.0 151.0 186.0 128.0 156.0 158.0 139.0 180.0 133.0 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.32 13:05:46 INFO - PROCESS | 4882 | Values: 163.0 163.0 165.0 161.0 162.0 162.0 161.0 161.0 161.0 162.0 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.00 stddev:38.52 (51.4%) stddev-sans-first:40.30 13:05:46 INFO - PROCESS | 4882 | Values: 75.0 75.0 74.0 178.0 77.0 72.0 74.0 76.0 152.0 76.0 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:92.00 stddev:28.55 (31.0%) stddev-sans-first:29.58 13:05:46 INFO - PROCESS | 4882 | Values: 93.0 92.0 156.0 92.0 92.0 94.0 148.0 92.0 94.0 151.0 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 13:05:46 INFO - PROCESS | 4882 | Values: 116.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:146.50 stddev:1.14 (0.8%) stddev-sans-first:1.17 13:05:46 INFO - PROCESS | 4882 | Values: 146.0 146.0 146.0 148.0 146.0 149.0 146.0 148.0 147.0 146.0 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 13:05:46 INFO - PROCESS | 4882 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 96.0 94.0 96.0 95.0 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:4.70 (8.0%) stddev-sans-first:4.85 13:05:46 INFO - PROCESS | 4882 | Values: 56.0 59.0 57.0 61.0 56.0 59.0 61.0 71.0 55.0 56.0 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 13:05:46 INFO - PROCESS | 4882 | Values: 58.0 60.0 59.0 59.0 58.0 58.0 58.0 59.0 58.0 59.0 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:3.71 (4.9%) stddev-sans-first:3.61 13:05:46 INFO - PROCESS | 4882 | Values: 72.0 79.0 83.0 72.0 74.0 76.0 75.0 81.0 76.0 74.0 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:116.00 stddev:9.11 (7.9%) stddev-sans-first:9.64 13:05:46 INFO - PROCESS | 4882 | Values: 120.0 112.0 117.0 112.0 114.0 115.0 112.0 113.0 133.0 137.0 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:164.00 stddev:3.37 (2.1%) stddev-sans-first:3.54 13:05:46 INFO - PROCESS | 4882 | Values: 163.0 166.0 164.0 164.0 164.0 171.0 169.0 163.0 160.0 161.0 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - PROCESS | 4882 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.50 stddev:1.55 (2.3%) stddev-sans-first:1.42 13:05:46 INFO - PROCESS | 4882 | Values: 69.0 68.0 66.0 67.0 65.0 68.0 66.0 64.0 68.0 67.0 13:05:46 INFO - PROCESS | 4882 | -------- Summary: end -------- 13:05:46 INFO - PROCESS | 4882 | 13:05:46 INFO - TEST-INFO | 4882: exit 0 13:05:46 INFO - TEST-OK | kraken | took 60861ms 13:05:46 INFO - SUITE-END | took 1169s 13:05:47 INFO - Completed test suite (00:19:30) 13:05:47 INFO - javascript benchmark 13:05:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.966700332997, 3395.8981230563086, 3407.5059116428133, 3431.107911942894, 3442.173878269216, 5553.666779993203, 5572.665640061599, 5614.214010038588, 5618.803341883035, 5630.746616402262, 5551.056320425528, 5561.360443548993, 5584.91622625661, 5599.300087489064, 5627.887442251163, 5038.571721403676, 5067.391912970449, 5103.872403189913, 5124.359455068116, 5139.974300128494, 4914.75426228689, 5002.874928126789, 5130.743462826862, 5192.92210616841, 5209.244659524366, 5114.820981265657, 5132.409772876111, 5152.1498952672955, 5156.252343410203, 5175.223716442545, 5098.082345177866, 5140.742962851861, 5148.716820574867, 5157.277981082651, 5186.636935414523, 4887.291342755316, 4934.531219534175, 5045.142325804622, 5072.644914855961, 5111.7699703513435, 5360.222767698662, 5383.892322153574, 5404.972975135139, 5412.91880621791, 5435.809746658848, 5845.210896528956, 5855.121731740273, 5871.6183448075735, 5901.262342207224, 5904.261967254093, 5861.0, 5882.852928676817, 5933.22868027158, 5950.494207992326, 6038.154658347835, 5633.126865335879, 5671.319441667027, 5686.118651609007, 5692.459216374438, 5700.828975130711, 6106.267247930188, 6156.846078848064, 6158.907616385758, 6162.168107305546, 6185.041318595625, 5650.830475085754, 5791.623544469596, 5841.386654401312, 5908.497777688945, 5921.111833224964, 6024.849378765566, 6042.0, 6052.092186172109, 6053.697315134225, 6059.394060593905, 5966.671833049224, 5970.552208584373, 6005.6997150142315, 6011.909821352683, 6023.518118550505, 5769.913451298234, 5841.824745257649, 5892.5285977122585, 5944.405559444021, 5951.137085122719, 4508.526604706459, 4519.593236608721, 4533.433320834895, 4540.228161212536, 4568.520305367889, 4037.9394309085387, 4072.6741860651077, 4100.036491424513, 4103.4460347853255, 4121.423000779893, 5572.3034620672415, 5684.971575142098, 5687.857803554862, 5692.9146062809095, 5730.36965933747, 5893.44012318829, 5900.940990590039, 5954.702264886739, 5957.285125784933, 5985.0, 5567.164925261243, 5664.376918538957, 5676.8864622707315, 5698.116791897262, 5718.428157184248, 4936.358273424432, 4943.604511639132, 4945.23348880924, 4971.875703107451, 5014.022265658162, 6103.6948152592195, 6104.725287362079, 6113.32753397126, 6141.0, 6147.415995480422, 5859.414058594107, 5895.351511333664, 5907.49786268172, 5918.319393269829, 5969.104634304716, 6204.162438070803, 6207.286162091236, 6217.533684973736, 6220.284667263141, 6222.191115155001, 5898.144769008555, 5906.26171728534, 5909.940900590939, 5931.7627294907725, 5943.970280148572, 5619.409961954099, 5923.437273459014, 6004.759809607567, 6007.849803754766, 6036.577439579188, 5900.0, 5935.2877654681715, 5939.07944268639, 5966.642001479925, 5972.8805423892145, 5843.181954526454, 5845.269341332333, 5895.616784908967, 5896.321922978912, 5900.822975310747, 5490.972545137409, 5637.887242255214, 5711.400302968129, 5717.714114294352, 5750.913736294043, 5810.941890581209, 5827.9417205829095, 5836.299644042572, 5858.209141765807, 5884.911726324023, 5628.043232650377, 5747.396523365153, 5748.856278593069, 5751.568632352507, 5751.884962300647], "value": 5501.657405796622, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.7047634279089, 684.1072400517323, 691.9065926099977, 729.6278897762143, 751.936085432738, 33562.83218583907, 39142.60857391429, 40326.39510407346, 40526.0, 40527.59472405275, 42997.140057198834, 43143.78428107863, 43670.0, 43775.0, 44035.11929761403, 8755.824883502342, 8990.505522196276, 8992.64029438825, 9004.324675649352, 9011.95494022529, 8812.1187881212, 8868.689595864145, 8873.911260887406, 8945.463272203657, 9035.638574457047, 9074.682386116454, 9154.359194856363, 9156.084391560824, 9166.312526560534, 9201.677941272057, 9015.45907245564, 9030.638774449015, 9069.909300906973, 9084.50035248061, 9126.224270936946, 8984.056674049196, 8994.32542559304, 9053.547322633907, 9080.954595227047, 9086.68196613122, 41451.58548414507, 42693.78653106745, 42821.78589107034, 43179.56820431818, 43230.56769432297, 3834.405667121601, 3927.469791578129, 3943.1719338938856, 3974.0660944678266, 3976.7812770297624, 33091.33817323664, 33481.6651833481, 33608.0, 33796.662033379595, 33817.32365352704, 4622.653301002439, 4654.86035418938, 4673.299005149221, 4704.741239231841, 4732.455767586703, 310286.0, 310505.0, 310566.0, 311097.44451277825, 311163.0, 60931.69534152301, 61483.69258153681, 61548.38451615426, 61650.69174654098, 61908.69045654833, 75270.62364688142, 76834.0, 77142.0, 77321.61339193268, 77505.0, 18392.816071839377, 18498.075096245135, 18531.536711582317, 18544.0, 18546.629067418846, 15383.307751151226, 15386.0, 15427.768583471257, 15436.536903892902, 15440.382384704486, 20717.58564828725, 21173.364799056053, 21280.574388512145, 21458.892705536684, 21472.0, 7547.924520754832, 7684.0, 7762.8059298516855, 7822.295993360511, 7832.099308579586, 1088.9509972051276, 1101.24014430043, 1155.7804017236867, 1161.9825702614467, 1202.7053371923935, 32470.0, 32955.0, 33054.0, 33218.66781332204, 34241.143971400415, 1228.9324087175112, 1248.831407759959, 1311.272243904623, 1317.7957416600443, 1323.0738483061896, 17246.310147594206, 17260.568485787706, 17331.826681733022, 17395.826041739674, 17400.73898891518, 477823.0, 492259.0, 499514.0, 523497.0, 528349.0, 54518.45481545134, 55421.44578554243, 55434.44565554293, 55459.0, 55527.0, 1513.7275290447606, 1517.9089254644757, 1537.1468834796794, 1565.9217039147998, 1670.2066518403904, 33029.50455743118, 34271.31457370789, 34329.828350858086, 34533.0, 34807.82596087003, 54442.0, 59607.70196148992, 61067.38932610617, 61263.38736612577, 61581.692091539255, 435494.0, 442841.0, 445220.0, 445348.0, 446014.0, 41805.372919406844, 42120.36819447772, 42394.0, 42567.0, 46217.0, 51104.74447627738, 51462.22806657978, 51523.742381287855, 52285.7385713069, 52356.73821630867, 40989.59010409858, 43425.782871085445, 43594.56405436032, 44143.77928110339, 44733.32900006568, 42407.575924240366, 43128.35307470328, 43382.56617433912, 43470.565294347914, 43715.78142109269, 39056.39043439739, 39170.80414597909, 39337.40993885151, 39492.80253598714, 39507.209855802146, 37238.8138059308, 37338.8133059333, 37513.812430938764, 37611.0, 38285.6171438282, 29387.85306073456, 29760.255993600334, 30024.249393764458, 30084.84957575198, 30427.391452171276], "value": 21407.180867091105, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.5533623686418, 424.5012110769845, 438.17622869006266, 438.95829896159853, 444.61762883919823, 18414.44756657299, 19155.42533723989, 19179.232830686775, 20779.584408311825, 21792.89103554484, 13189.472421103144, 13402.396892139852, 17567.385141520048, 20378.0, 20398.0, 5290.761915713783, 5468.343798744137, 5516.475934786189, 5528.917066244009, 6614.107095542088, 6421.036844473343, 6520.18497687789, 6527.314631963647, 6539.542232043759, 6575.901361479581, 6256.655883926383, 6424.646644434578, 6428.389303016206, 6449.54853160279, 6515.967420162892, 6391.296957334689, 6398.29618741938, 6404.199475065593, 6407.231132264134, 6408.166938297992, 5809.448102430305, 5882.323532793698, 5947.910781338283, 6003.189569408118, 6010.789622363196, 14671.77992330116, 15042.699146017017, 15634.45279415215, 23692.881535592212, 24276.514469710684, 2491.476789874129, 2519.6472493850874, 2733.3986522964915, 2810.437912417525, 2835.1636267301196, 8476.83046339076, 10750.193735469793, 10759.193060520414, 11023.669289921316, 14177.05081782994, 2002.389271272276, 2054.414491869825, 2069.048237810609, 2117.9788202117934, 2153.310940499041, 77465.22534774637, 80061.0, 81507.18492815056, 82765.9999999994, 82901.0, 11538.88461115395, 11664.0, 11923.880761192277, 11938.462769175409, 12023.098267629963, 16568.917155414147, 16660.916695416687, 16676.0, 16734.916325418297, 16761.664766704598, 8680.392372533863, 8780.824383512421, 8798.648054077894, 8857.158569935846, 8945.955270223738, 8286.46138001028, 8404.285635721033, 8454.577271136419, 8483.363747718946, 8484.278836298983, 5143.742812859342, 5156.071907056691, 5162.638615296968, 5174.223866420067, 5197.532222100029, 2036.1549956768072, 2093.2568938027084, 2129.787021297858, 2152.160657343637, 2175.0973346061205, 1043.9321444106108, 1063.5745701719375, 1126.2566705974182, 1139.8119310313705, 1159.913006524514, 19121.713174302397, 19534.90232548828, 19846.007699614962, 19970.129934783865, 20018.0, 1041.4220107840222, 1156.7397335599424, 1157.1032449851264, 1195.3246415775059, 1214.860291066521, 11158.832617510743, 11307.321560706385, 11332.093432525378, 11340.94329528347, 11353.148513861328, 545854.0, 546398.0, 559365.0, 564055.0, 572761.0, 53655.731721341144, 55020.174697379574, 56712.86574268492, 92330.53834730784, 95062.52468737612, 1105.3257512917114, 1110.600183933767, 1115.5259014918627, 1138.6925530106826, 1148.4085695866636, 17468.47594572165, 17903.910480447514, 17908.820911790714, 18026.729599056285, 18157.54606134857, 26172.345691357106, 37242.441363380116, 37955.71338836677, 38383.42424863685, 40102.1979560413, 57139.42860571341, 57487.42512574988, 57839.710801445726, 58201.417985821296, 58256.41743582679, 8623.784405389915, 8889.422187557788, 8919.509426981578, 8982.730518084469, 9048.457092574467, 12420.130590858553, 12548.49806007786, 12765.744685106432, 13099.148555343872, 13272.402741876445, 11421.0, 11507.424628768695, 11514.42427878586, 11523.13576481784, 11740.706482337668, 11281.492332845206, 11673.766524669629, 11729.941350293195, 11858.0, 11963.76072478563, 12352.567660131852, 12432.875671243171, 12440.81338779901, 12558.43487043067, 12647.0, 8701.695440659547, 8753.12468753145, 8784.868226976729, 8899.599518021576, 8932.28541716674, 11037.282576632493, 11359.432028398713, 11371.886281137082, 11437.828432573351, 11518.654440366803], "value": 9529.46031341763, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1560.6956643454528, 1606.1728209971864, 1857.071464267866, 1933.9033048347578, 1950.1711772496685, 7831.3343365813835, 7910.604469776503, 8569.485830850153, 8812.91187088129, 8866.379353445262, 8466.365022623297, 8488.83022339553, 8499.192576705218, 8519.616617252223, 8578.528180950045, 2347.835651504395, 2350.3771500552325, 2357.4577847095093, 2372.78644921957, 2376.5009348036933, 2374.133441293924, 2376.95246095078, 2438.1100898172217, 2440.8779561021965, 2444.40112172518, 2397.1130681647815, 2401.9159329423474, 2406.2781165650235, 2426.0417135231573, 2447.8286519943613, 2373.6439534069855, 2376.762323767618, 2377.0, 2392.5334559760854, 2405.6391541268777, 2389.6535002424725, 2396.664466974625, 2404.5912194926905, 2410.6745589345387, 2411.3007227904063, 8824.602892869772, 8855.24730397917, 8859.867101993475, 8870.112988701077, 8934.061923498004, 5266.657667251617, 5293.470652934676, 5306.124489459235, 5316.680999140064, 5351.331083614548, 3564.8930532084078, 3571.785692858437, 3634.8364323605238, 3672.375696131664, 3690.8004898407858, 1258.9496420143182, 1295.1452041652558, 1296.5008471738354, 1306.614548708124, 1333.1134795361074, 11919.523219071227, 11927.642170734893, 11938.343391113573, 11948.402579870972, 12011.279323240633, 4500.549945005539, 4657.743824089707, 4718.079974404958, 4750.453697824794, 4782.234842425195, 10246.6413675521, 10275.486225688686, 10275.7431064224, 10306.433146176882, 10323.48382580868, 5346.946530534723, 5358.973205134027, 5372.946270537323, 5392.191171324254, 5398.1093119634825, 4451.109778044404, 4916.975415122902, 4996.550310472075, 5059.468755780664, 5066.695998240118, 4144.0, 4152.065785198306, 4160.396742472324, 4178.0, 4194.916101677949, 1317.9735906804613, 1322.358656051814, 1330.2683524061727, 1390.7844284135974, 1403.3123769353147, 1103.8454616353717, 1110.7389763405592, 1116.9776604467866, 1122.7698321844002, 1139.9316041037564, 6206.565540412128, 6215.595986260879, 6329.588576742497, 6380.84047898797, 6471.285109446, 470.8822794301425, 476.09066682636, 479.87283369907004, 484.530005894282, 489.87997940504806, 4309.569043095666, 4357.477102747691, 4357.694961352675, 4378.934315985262, 4397.494288156839, 10501.684949451528, 10878.619248326271, 10996.560137594406, 11004.559817607365, 11020.0, 10090.69727908164, 10472.424016679004, 10779.67660970172, 10894.128469722404, 10895.782084358427, 8211.548364839991, 8250.0, 8278.337732981347, 8288.544130072783, 8290.8341833163, 6115.388461153849, 6312.558120931674, 6354.205724284465, 6365.777197798055, 6383.329750376143, 9328.95335523318, 9630.807383852423, 9656.517174141125, 9665.178459830993, 9673.951630241803, 9848.0, 9945.651902183388, 10108.595656173671, 10230.795384092426, 10268.897311026794, 7142.821429464305, 8003.679852806055, 8029.4379393441895, 8106.9189308108525, 8323.375746819134, 8460.746177614436, 8475.237228649452, 8477.194666506672, 8495.617697203765, 8509.404341696269, 7214.098237720285, 7389.445791565761, 7607.429442791702, 7705.576193309422, 7862.135165131716, 7595.354394876497, 7610.505317154367, 7665.808354790952, 7697.114831794415, 7803.843923121392, 7100.254473280231, 7183.102112235971, 7225.096862892138, 7233.529820561646, 7234.927650723636, 5335.253064571041, 5414.160805075219, 5469.753861076181, 5481.369642491165, 5534.612577119724, 5323.095073837534, 5431.6740995540395, 5477.835664930059, 5529.364123125892, 5625.156226566048], "value": 4682.982706079405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.9517067610535, 357.18561679371044, 360.2848346033124, 364.91059690375846, 365.60332039736886, 6456.8385790355205, 6504.252011018734, 6536.575122617027, 6543.378379053994, 6577.967110164448, 6413.845507808593, 6473.287938326792, 6531.314212007742, 6568.605883646985, 6578.24350199726, 4979.0, 4979.755061234691, 4989.850304490871, 4991.525805048533, 5000.249962505635, 4981.9750901245625, 4983.8504844854715, 4988.850334489971, 4991.450940396553, 4991.775370108354, 4945.258211268302, 4953.752312384385, 4956.975215123919, 4958.826441074563, 4963.40439147301, 4821.204501257288, 4932.926006109911, 4933.506649335073, 4936.605071594264, 4939.703617782944, 4365.432493775789, 4381.846635367747, 4391.6047555719815, 4396.450443694538, 4402.93395599063, 6227.782027629011, 6237.407446292595, 6295.2760432550385, 6352.46004089653, 6366.71349789256, 5749.482546570829, 5800.274965629296, 5830.62100963436, 5843.5033022193165, 5915.260592425947, 6978.232394436608, 6983.720651173947, 6986.476014298897, 6994.650267486605, 7003.859922801566, 4946.134426475388, 4950.975245123787, 4954.182559877616, 4959.8264060758065, 4962.528559786814, 7208.49540532163, 7295.817604559876, 7310.890336644955, 7317.707291708379, 7319.963400183018, 4807.351007613927, 5093.134167191586, 5104.03023425548, 5108.923366149511, 5121.052605268037, 4966.950330496648, 4998.9500104999215, 5014.473480284591, 5015.84952451427, 5040.47075057121, 5780.1907732917425, 5814.360420353758, 5819.82540523785, 5828.979928512578, 5830.0, 6986.825329366807, 6988.6855091521, 6999.160100787938, 7006.01915731798, 7038.803403421328, 1786.9903504519905, 1810.809864964186, 1811.1849667649346, 1813.2112531049036, 1813.7098064309912, 1169.4971961030035, 1177.7526719389025, 1218.5674085699627, 1227.4353797253184, 1253.8996880249558, 6690.063391125246, 6740.359665831738, 6744.966275168593, 6750.32496750321, 6765.221999470025, 7159.212486626571, 7178.5692858428665, 7183.96408017967, 7195.964020179866, 7197.0, 6699.765508207287, 6717.764878229238, 6721.193456785217, 6724.327567243335, 6746.156730408699, 3851.9422208666892, 3894.435306880543, 3903.316919539069, 3909.3940439231965, 3912.3349030664854, 7379.114506259176, 7652.693892244248, 7670.884936725954, 7674.42441816866, 7685.346745526693, 7494.362979146725, 7496.7001319947685, 7512.549247045085, 7537.54774713519, 7548.094228692592, 7609.771706848804, 7616.352610028099, 7627.4279429041935, 7642.0, 7661.118971318369, 7160.10498687664, 7319.487635865651, 7319.963400182965, 7346.265373462611, 7384.18773934856, 7158.391536719437, 7219.530730502501, 7225.927740722525, 7230.927690723025, 7231.746888858865, 7593.316601505891, 7617.390608751176, 7624.656890439833, 7639.083310002613, 7649.541027538366, 4881.487443818348, 4943.703377797344, 4949.034938187163, 4961.479044700254, 4970.105381031449, 7175.712971481083, 7311.4516411268305, 7319.707211711472, 7328.450366222662, 7334.413246940126, 7073.858522829618, 7104.857902842017, 7105.32499412555, 7107.0, 7126.394256488256, 7035.437165026683, 7039.718411263492, 7051.6474176292, 7056.259092795182, 7067.858642827012, 6808.9659551701925, 6829.2487826338065, 6847.760328388682, 6862.4853136016, 6864.38220560152, 6896.620685862125, 7082.185548661764, 7109.324614161853, 7134.60759658203, 7153.928460715534, 6711.228208755861, 6824.112865327475, 6825.795226143224, 6921.892497200423, 6998.790036298919], "value": 5292.566063953111, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [842.3303473738381, 842.9915700842994, 846.9237768600825, 888.5246393179648, 962.6245764151978, 14989.325480353384, 15176.241187940614, 15243.847561524395, 15333.463328783495, 15336.693266134684, 13974.301284935764, 14292.071015383994, 14303.0, 14370.0, 14374.640633984156, 740.0896896816919, 865.0225245472639, 887.6626881784913, 894.8120894612139, 900.621738869673, 903.268352634365, 906.6237511432747, 907.0158877617793, 909.6543313540845, 911.4349103555771, 935.1303287942211, 937.5687183895416, 937.8265020971143, 938.1041105743998, 938.197840846077, 927.1701826864918, 931.1573026411075, 934.1685899549407, 934.6588495199271, 936.967206147785, 684.8253695307715, 685.9759908403182, 687.8211664967095, 692.3111504053448, 692.3353580562666, 14047.0, 14248.786268205986, 14257.714845703027, 14268.85731142696, 14280.785788213185, 14741.778873316909, 14767.409303627843, 14799.0, 14944.775828362583, 14954.62613434662, 11975.700607484796, 12077.15459917806, 12218.75562488754, 12310.26138431697, 12464.252144871247, 3935.1736135411597, 3953.920921581581, 4028.8992775180564, 4054.8783536493656, 4139.130782535671, 54061.0, 54938.72530637361, 54954.725226373615, 55071.449285507435, 55129.173062404094, 11501.76996460066, 11531.942340288246, 11615.477303521362, 11618.302901825917, 11757.353345566076, 20143.496412589804, 20294.289699860434, 20328.186872525228, 20331.0, 20349.59300814005, 8814.603342849587, 8830.690925817695, 8932.419392739452, 9027.0, 9080.545972701339, 4991.775370108354, 5114.462981386975, 5144.228365745168, 5312.601554883322, 5344.946550534522, 3346.9497957530657, 3423.298223864102, 3424.0, 3427.8800241991908, 3429.725621950238, 633.9270983836825, 638.4796390941368, 645.029231007331, 651.2087813306855, 658.2200092889941, 741.3105811595268, 778.1673609238061, 861.978450538729, 863.792689754467, 864.7146441674232, 9969.50152492387, 10243.84634230487, 10300.793984120275, 10350.0, 10361.119304859021, 759.369723129801, 829.1666874790917, 832.2842355574202, 832.4589017138908, 849.5454931611682, 4740.5733483986605, 4765.5949244314625, 4921.50784921505, 4959.355283813081, 4987.526185012418, 66610.66694666496, 67568.0, 67966.66016669886, 67976.32023679798, 68205.0, 56172.0, 58986.705066474395, 59037.048147592446, 60385.39614603885, 62167.0, 47737.522624774, 48000.51999480031, 51503.0, 52113.0, 52169.0, 9456.952715236379, 9509.239260859253, 9558.474283914451, 9659.806803864023, 9778.07108324708, 39613.0, 39671.2065758689, 40369.59630403658, 40502.79748601356, 41167.382489263284, 50089.0, 50646.0, 51464.485355147466, 51483.0, 53065.0, 11275.492602833056, 11345.205835591429, 11380.089592832719, 11505.25215861, 11568.132390070947, 12320.568780092653, 12518.311492867979, 12565.37173141321, 12667.17663351916, 12823.358832058173, 12076.75846483083, 12110.394480276127, 12128.939355303168, 12458.501659933501, 12469.127161098637, 13168.078234523491, 13204.339783010619, 13436.19382837033, 13826.723465530431, 13933.372998215307, 11662.573134447723, 12859.807102893652, 12977.221366718028, 13511.038057658208, 13532.59402217935, 10774.676759697222, 10816.134709223086, 10997.285176463503, 11132.888671113185, 11155.330680159217, 11092.833607495733, 11218.214724969173, 11338.829917551408, 11510.36692981894, 11636.53453861836], "value": 7171.315162351502, "unit": "score"}], "name": "dromaeo_css", "value": 7644.070893941762, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 104.0, 110.0, 112.0, 115.0, 100.0, 112.0, 111.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 151.0, 186.0, 128.0, 156.0, 158.0, 139.0, 180.0, 133.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 161.0, 162.0, 162.0, 161.0, 161.0, 161.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 178.0, 77.0, 72.0, 74.0, 76.0, 152.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 156.0, 92.0, 92.0, 94.0, 148.0, 92.0, 94.0, 151.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 148.0, 146.0, 149.0, 146.0, 148.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 94.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 57.0, 61.0, 56.0, 59.0, 61.0, 71.0, 55.0, 56.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 59.0, 58.0, 58.0, 58.0, 59.0, 58.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 79.0, 83.0, 72.0, 74.0, 76.0, 75.0, 81.0, 76.0, 74.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 112.0, 117.0, 112.0, 114.0, 115.0, 112.0, 113.0, 133.0, 137.0], "value": 118.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 164.0, 164.0, 164.0, 171.0, 169.0, 163.0, 160.0, 161.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 66.0, 67.0, 65.0, 68.0, 66.0, 64.0, 68.0, 67.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1529.1999999999998, "alertThreshold": 2.0}]} 13:05:47 INFO - Return code: 0 13:05:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:05:47 ERROR - # TBPL SUCCESS # 13:05:47 INFO - Running post-action listener: _resource_record_post_action 13:05:47 INFO - Running post-run listener: _resource_record_post_run 13:05:48 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 266240; Write bytes: 261632000; Read time: 28; Write time: 200956 13:05:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13905920; Read time: 0; Write time: 3564 13:05:48 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 244625408; Read time: 28; Write time: 195868 13:05:48 INFO - Running post-run listener: _upload_blobber_files 13:05:48 INFO - Blob upload gear active. 13:05:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:05:48 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 13:05:48 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'] 13:05:48 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 13:05:48 INFO - (blobuploader) - INFO - Open directory for files ... 13:05:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:05:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:05:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:05:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:05:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:05:49 INFO - (blobuploader) - INFO - Done attempting. 13:05:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:05:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:05:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:05:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:05:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:05:50 INFO - (blobuploader) - INFO - Done attempting. 13:05:50 INFO - (blobuploader) - INFO - Iteration through files over. 13:05:50 INFO - Return code: 0 13:05:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:05:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:05:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdf4c4eceb4e5240287e65ef35f59528c78ae2e8f69ff907e129bb825fd7d8532a06f4f9425f58a24fb161259e85340981601251c685ec345b793403825fbf15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aab19a65cef7e7301a89db05831410b210bbfe58957355c295013e64432e4162ae00bb8d57c391d9302ae712c10d07c21274061e5905d77f734e8cc70d934ebd"} 13:05:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:05:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:05:50 INFO - Contents: 13:05:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdf4c4eceb4e5240287e65ef35f59528c78ae2e8f69ff907e129bb825fd7d8532a06f4f9425f58a24fb161259e85340981601251c685ec345b793403825fbf15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aab19a65cef7e7301a89db05831410b210bbfe58957355c295013e64432e4162ae00bb8d57c391d9302ae712c10d07c21274061e5905d77f734e8cc70d934ebd"} 13:05:50 INFO - Running post-run listener: copy_logs_to_upload_dir 13:05:50 INFO - Copying logs to upload dir... 13:05:50 INFO - mkdir: /builds/slave/test/build/upload/logs 13:05:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.213477 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-25 13:05:50.341076) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 13:05:50.344936) ========= 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=14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdf4c4eceb4e5240287e65ef35f59528c78ae2e8f69ff907e129bb825fd7d8532a06f4f9425f58a24fb161259e85340981601251c685ec345b793403825fbf15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aab19a65cef7e7301a89db05831410b210bbfe58957355c295013e64432e4162ae00bb8d57c391d9302ae712c10d07c21274061e5905d77f734e8cc70d934ebd"} build_url:https://queue.taskcluster.net/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/QRtL2RDFT-6uaGdg5Oqlog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdf4c4eceb4e5240287e65ef35f59528c78ae2e8f69ff907e129bb825fd7d8532a06f4f9425f58a24fb161259e85340981601251c685ec345b793403825fbf15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aab19a65cef7e7301a89db05831410b210bbfe58957355c295013e64432e4162ae00bb8d57c391d9302ae712c10d07c21274061e5905d77f734e8cc70d934ebd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 13:05:50.371233) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 13:05:50.371579) ========= 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=14ef55db36f7623abb31b9cf000001d5-1464205461.582974-1073709737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 13:05:50.455535) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 13:05:50.455871) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 13:05:50.456175) ========= ========= Total master_lag: 0.18 =========