builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1460642053.44 results: success (0) buildid: 20160414034258 builduid: 9072a776d8a1450aa476cd35d91f1938 revision: 589bd8060a90ac2022b7f6dee222cbc4bfc34aa7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 06:54:13.443814) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 06:54:13.444333) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 06:54:13.444768) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 06:54:13.466752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 06:54:13.467284) ========= 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=0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 06:54:13-- 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% 223M=0s 2016-04-14 06:54:13 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091815 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 06:54:13.572152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 06:54:13.572454) ========= 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=0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016387 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 06:54:13.622252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 06:54:13.622613) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 589bd8060a90ac2022b7f6dee222cbc4bfc34aa7 --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 589bd8060a90ac2022b7f6dee222cbc4bfc34aa7 --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=0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 06:54:13,848 truncating revision to first 12 chars 2016-04-14 06:54:13,848 Setting DEBUG logging. 2016-04-14 06:54:13,848 attempt 1/10 2016-04-14 06:54:13,848 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/589bd8060a90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 06:54:14,100 unpacking tar archive at: mozilla-aurora-589bd8060a90/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538381 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 06:54:14.173954) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 06:54:14.174285) ========= script_repo_revision: 589bd8060a90ac2022b7f6dee222cbc4bfc34aa7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 06:54:14.174687) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 06:54:14.174962) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 06:54:14.184488) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-04-14 06:54:14.184882) ========= /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=0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:54:14 INFO - MultiFileLogger online at 20160414 06:54:14 in /builds/slave/test 06:54:14 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 06:54:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:54:14 INFO - {'append_to_log': False, 06:54:14 INFO - 'base_work_dir': '/builds/slave/test', 06:54:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:54:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:54:14 INFO - 'branch': 'Mozilla-Aurora', 06:54:14 INFO - 'buildbot_json_path': 'buildprops.json', 06:54:14 INFO - 'config_files': ('talos/linux_config.py',), 06:54:14 INFO - 'default_actions': ('clobber', 06:54:14 INFO - 'read-buildbot-config', 06:54:14 INFO - 'download-and-extract', 06:54:14 INFO - 'populate-webroot', 06:54:14 INFO - 'create-virtualenv', 06:54:14 INFO - 'install', 06:54:14 INFO - 'run-tests'), 06:54:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:54:14 INFO - 'download_minidump_stackwalk': True, 06:54:14 INFO - 'download_symbols': 'ondemand', 06:54:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:54:14 INFO - 'tooltool.py': '/tools/tooltool.py', 06:54:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:54:14 INFO - '/tools/misc-python/virtualenv.py')}, 06:54:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:54:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:54:14 INFO - 'installer_path': 'installer.exe', 06:54:14 INFO - 'log_level': 'info', 06:54:14 INFO - 'log_name': 'talos', 06:54:14 INFO - 'log_to_console': True, 06:54:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:54:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:54:14 INFO - 'opt_config_files': (), 06:54:14 INFO - 'pip_index': False, 06:54:14 INFO - 'sps_profile': False, 06:54:14 INFO - 'sps_profile_interval': 0, 06:54:14 INFO - 'suite': 'dromaeojs-e10s', 06:54:14 INFO - 'system_bits': '32', 06:54:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:54:14 INFO - 'title': 'talos-linux64-ix-017', 06:54:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:54:14 INFO - 'use_talos_json': True, 06:54:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:54:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:54:14 INFO - 'work_dir': 'build'} 06:54:14 INFO - ##### 06:54:14 INFO - ##### Running clobber step. 06:54:14 INFO - ##### 06:54:14 INFO - Running pre-action listener: _resource_record_pre_action 06:54:14 INFO - Running main action method: clobber 06:54:14 INFO - rmtree: /builds/slave/test/build 06:54:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:54:14 INFO - Running post-action listener: _resource_record_post_action 06:54:14 INFO - ##### 06:54:14 INFO - ##### Running read-buildbot-config step. 06:54:14 INFO - ##### 06:54:14 INFO - Running pre-action listener: _resource_record_pre_action 06:54:14 INFO - Running main action method: read_buildbot_config 06:54:14 INFO - Using buildbot properties: 06:54:14 INFO - { 06:54:14 INFO - "project": "", 06:54:14 INFO - "product": "firefox", 06:54:14 INFO - "script_repo_revision": "production", 06:54:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:54:14 INFO - "repository": "", 06:54:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:54:14 INFO - "buildid": "20160414034258", 06:54:14 INFO - "pgo_build": "True", 06:54:14 INFO - "basedir": "/builds/slave/test", 06:54:14 INFO - "buildnumber": 200, 06:54:14 INFO - "slavename": "talos-linux64-ix-017", 06:54:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:54:14 INFO - "platform": "ubuntu64_hw", 06:54:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:54:14 INFO - "branch": "mozilla-aurora", 06:54:14 INFO - "repo_path": "releases/mozilla-aurora", 06:54:14 INFO - "revision": "589bd8060a90ac2022b7f6dee222cbc4bfc34aa7", 06:54:14 INFO - "stage_platform": "linux64-pgo", 06:54:14 INFO - "builduid": "9072a776d8a1450aa476cd35d91f1938", 06:54:14 INFO - "slavebuilddir": "test" 06:54:14 INFO - } 06:54:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 06:54:14 INFO - Running post-action listener: _resource_record_post_action 06:54:14 INFO - ##### 06:54:14 INFO - ##### Running download-and-extract step. 06:54:14 INFO - ##### 06:54:14 INFO - Running pre-action listener: _resource_record_pre_action 06:54:14 INFO - Running main action method: download_and_extract 06:54:14 INFO - mkdir: /builds/slave/test/build/tests 06:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:14 INFO - https://queue.taskcluster.net/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:54:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 06:54:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 06:54:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 06:54:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:54:16 INFO - Downloaded 1448 bytes. 06:54:16 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 06:54:16 INFO - Using the following test package requirements: 06:54:16 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 06:54:16 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:54:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:54:16 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:54:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:54:16 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:54:16 INFO - u'jsshell-linux-x86_64.zip'], 06:54:16 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:54:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:54:16 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 06:54:16 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:54:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:54:16 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:54:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:54:16 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:54:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:54:16 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 06:54:16 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:54:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:54:16 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:16 INFO - https://queue.taskcluster.net/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:54:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 06:54:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 06:54:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 06:54:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:54:17 INFO - Downloaded 23352304 bytes. 06:54:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:54:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:54:19 INFO - Return code: 0 06:54:19 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:19 INFO - https://queue.taskcluster.net/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:54:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 06:54:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 06:54:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 06:54:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:54:21 INFO - Downloaded 23352304 bytes. 06:54:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:54:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:54:22 INFO - Return code: 0 06:54:22 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')]} 06:54:22 INFO - https://queue.taskcluster.net/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:54:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 06:54:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 06:54:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 06:54:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:54:23 INFO - Downloaded 10845168 bytes. 06:54:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:54:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:54:24 INFO - Return code: 0 06:54:24 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')]} 06:54:24 INFO - https://queue.taskcluster.net/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:54:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 06:54:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 06:54:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 06:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:54:26 INFO - Downloaded 60575932 bytes. 06:54:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 06:54:26 INFO - mkdir: /builds/slave/test/properties 06:54:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:54:26 INFO - Writing to file /builds/slave/test/properties/build_url 06:54:26 INFO - Contents: 06:54:26 INFO - build_url:https://queue.taskcluster.net/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 06:54:28 INFO - Running post-action listener: _resource_record_post_action 06:54:28 INFO - Running post-action listener: set_extra_try_arguments 06:54:28 INFO - ##### 06:54:28 INFO - ##### Running populate-webroot step. 06:54:28 INFO - ##### 06:54:28 INFO - Running pre-action listener: _resource_record_pre_action 06:54:28 INFO - Running main action method: populate_webroot 06:54:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:54:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:54:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:54:28 INFO - '--tppagecycles', 06:54:28 INFO - '7'], 06:54:28 INFO - 'tests': ['tsvgm']}}, 06:54:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:54:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:54:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:54:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:54:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:54:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:54:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:28 INFO - 'talos_options': ['--e10s'], 06:54:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:28 INFO - 'tests': ['damp', 'tps']}, 06:54:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:28 INFO - 'talos_options': ['--e10s'], 06:54:28 INFO - 'tests': ['damp', 'tps']}, 06:54:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:54:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:54:28 INFO - 'other': {'tests': ['a11yr', 06:54:28 INFO - 'ts_paint', 06:54:28 INFO - 'tpaint', 06:54:28 INFO - 'sessionrestore', 06:54:28 INFO - 'sessionrestore_no_auto_restore', 06:54:28 INFO - 'tabpaint']}, 06:54:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:54:28 INFO - 'tests': ['a11yr', 06:54:28 INFO - 'ts_paint', 06:54:28 INFO - 'tpaint', 06:54:28 INFO - 'sessionrestore', 06:54:28 INFO - 'sessionrestore_no_auto_restore', 06:54:28 INFO - 'tabpaint']}, 06:54:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:54:28 INFO - 'tests': ['a11yr', 06:54:28 INFO - 'ts_paint', 06:54:28 INFO - 'tpaint', 06:54:28 INFO - 'sessionrestore', 06:54:28 INFO - 'sessionrestore_no_auto_restore', 06:54:28 INFO - 'tabpaint']}, 06:54:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:54:28 INFO - 'tests': ['a11yr', 06:54:28 INFO - 'ts_paint', 06:54:28 INFO - 'tpaint', 06:54:28 INFO - 'sessionrestore', 06:54:28 INFO - 'sessionrestore_no_auto_restore', 06:54:28 INFO - 'tabpaint']}, 06:54:28 INFO - 'other_l64': {'tests': ['a11yr', 06:54:28 INFO - 'ts_paint', 06:54:28 INFO - 'tpaint', 06:54:28 INFO - 'sessionrestore', 06:54:28 INFO - 'sessionrestore_no_auto_restore', 06:54:28 INFO - 'tabpaint']}, 06:54:28 INFO - 'other_nol64': {'tests': ['a11yr', 06:54:28 INFO - 'ts_paint', 06:54:28 INFO - 'tpaint', 06:54:28 INFO - 'sessionrestore', 06:54:28 INFO - 'sessionrestore_no_auto_restore', 06:54:28 INFO - 'tabpaint']}, 06:54:28 INFO - 'svgr': {'tests': ['tsvgx', 06:54:28 INFO - 'tsvgr_opacity', 06:54:28 INFO - 'tart', 06:54:28 INFO - 'tscrollx', 06:54:28 INFO - 'cart']}, 06:54:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:54:28 INFO - 'tests': ['tsvgx', 06:54:28 INFO - 'tsvgr_opacity', 06:54:28 INFO - 'tart', 06:54:28 INFO - 'tscrollx', 06:54:28 INFO - 'cart']}, 06:54:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:28 INFO - 'tests': ['tp5o']}, 06:54:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:28 INFO - 'talos_options': ['--e10s'], 06:54:28 INFO - 'tests': ['tp5o']}, 06:54:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:28 INFO - 'talos_options': ['--xperf_path', 06:54:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:28 INFO - 'tests': ['tp5n']}, 06:54:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:28 INFO - 'talos_options': ['--e10s', 06:54:28 INFO - '--xperf_path', 06:54:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:28 INFO - 'tests': ['tp5n']}}, 06:54:28 INFO - 'talos.zip': {'path': '', 06:54:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:54:28 INFO - Running post-action listener: _resource_record_post_action 06:54:28 INFO - ##### 06:54:28 INFO - ##### Running create-virtualenv step. 06:54:28 INFO - ##### 06:54:28 INFO - Running pre-action listener: _resource_record_pre_action 06:54:28 INFO - Running main action method: create_virtualenv 06:54:28 INFO - Creating virtualenv /builds/slave/test/build/venv 06:54:28 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 06:54:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:54:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:54:28 INFO - Using real prefix '/usr' 06:54:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:54:28 INFO - Installing distribute.............................................................................................................................................................................................done. 06:54:30 INFO - Installing pip.................done. 06:54:30 INFO - Return code: 0 06:54:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:54: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')]} 06:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:30 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 0x7fa7c397cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9160>, '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 0x29ba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ba4f0>, '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': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', '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 06:54:30 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 06:54:30 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 06:54:30 INFO - Using env: {'DISPLAY': ':0', 06:54:30 INFO - 'HOME': '/home/cltbld', 06:54:30 INFO - 'LANG': 'en_US.UTF-8', 06:54:30 INFO - 'LANGUAGE': 'en_US:en', 06:54:30 INFO - 'LOGNAME': 'cltbld', 06:54:30 INFO - 'MAIL': '/var/mail/cltbld', 06:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:30 INFO - 'MOZ_NO_REMOTE': '1', 06:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:30 INFO - 'NO_EM_RESTART': '1', 06:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:30 INFO - 'PWD': '/builds/slave/test', 06:54:30 INFO - 'SHELL': '/bin/bash', 06:54:30 INFO - 'SHLVL': '1', 06:54:30 INFO - 'TERM': 'linux', 06:54:30 INFO - 'TMOUT': '86400', 06:54:30 INFO - 'USER': 'cltbld', 06:54:30 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', 06:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:30 INFO - '_': '/tools/buildbot/bin/python'} 06:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:30 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 06:54:30 INFO - Cleaning up... 06:54:30 INFO - Return code: 0 06:54:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:54: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')]} 06:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:30 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 0x7fa7c397cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9160>, '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 0x29ba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ba4f0>, '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': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', '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 06:54:30 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 06:54:30 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 06:54:30 INFO - Using env: {'DISPLAY': ':0', 06:54:30 INFO - 'HOME': '/home/cltbld', 06:54:30 INFO - 'LANG': 'en_US.UTF-8', 06:54:30 INFO - 'LANGUAGE': 'en_US:en', 06:54:30 INFO - 'LOGNAME': 'cltbld', 06:54:30 INFO - 'MAIL': '/var/mail/cltbld', 06:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:30 INFO - 'MOZ_NO_REMOTE': '1', 06:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:30 INFO - 'NO_EM_RESTART': '1', 06:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:30 INFO - 'PWD': '/builds/slave/test', 06:54:30 INFO - 'SHELL': '/bin/bash', 06:54:30 INFO - 'SHLVL': '1', 06:54:30 INFO - 'TERM': 'linux', 06:54:30 INFO - 'TMOUT': '86400', 06:54:30 INFO - 'USER': 'cltbld', 06:54:30 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', 06:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:30 INFO - '_': '/tools/buildbot/bin/python'} 06:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:31 INFO - Downloading/unpacking psutil>=0.7.1 06:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:54:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:33 INFO - Installing collected packages: psutil 06:54:33 INFO - Running setup.py install for psutil 06:54:33 INFO - building 'psutil._psutil_linux' extension 06:54:33 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 06:54:33 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 06:54:33 INFO - building 'psutil._psutil_posix' extension 06:54:33 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 06:54:33 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 06:54:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:33 INFO - Successfully installed psutil 06:54:33 INFO - Cleaning up... 06:54:33 INFO - Return code: 0 06:54:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:54:33 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')]} 06:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:33 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')]} 06:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:33 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 0x7fa7c397cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9160>, '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 0x29ba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ba4f0>, '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': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', '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 06:54:33 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 06:54:33 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 06:54:33 INFO - Using env: {'DISPLAY': ':0', 06:54:33 INFO - 'HOME': '/home/cltbld', 06:54:33 INFO - 'LANG': 'en_US.UTF-8', 06:54:33 INFO - 'LANGUAGE': 'en_US:en', 06:54:33 INFO - 'LOGNAME': 'cltbld', 06:54:33 INFO - 'MAIL': '/var/mail/cltbld', 06:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:33 INFO - 'MOZ_NO_REMOTE': '1', 06:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:33 INFO - 'NO_EM_RESTART': '1', 06:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:33 INFO - 'PWD': '/builds/slave/test', 06:54:33 INFO - 'SHELL': '/bin/bash', 06:54:33 INFO - 'SHLVL': '1', 06:54:33 INFO - 'TERM': 'linux', 06:54:33 INFO - 'TMOUT': '86400', 06:54:33 INFO - 'USER': 'cltbld', 06:54:33 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', 06:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:33 INFO - '_': '/tools/buildbot/bin/python'} 06:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:54:33 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 06:54:33 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 06:54:33 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 06:54:33 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 06:54:33 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 06:54:33 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 06:54:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:54:35 INFO - Installing collected packages: mozsystemmonitor 06:54:35 INFO - Running setup.py install for mozsystemmonitor 06:54:35 INFO - Successfully installed mozsystemmonitor 06:54:35 INFO - Cleaning up... 06:54:35 INFO - Return code: 0 06:54:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:35 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 0x7fa7c397cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9160>, '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 0x29ba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ba4f0>, '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': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', '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 06:54:35 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 06:54:35 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 06:54:35 INFO - Using env: {'DISPLAY': ':0', 06:54:35 INFO - 'HOME': '/home/cltbld', 06:54:35 INFO - 'LANG': 'en_US.UTF-8', 06:54:35 INFO - 'LANGUAGE': 'en_US:en', 06:54:35 INFO - 'LOGNAME': 'cltbld', 06:54:35 INFO - 'MAIL': '/var/mail/cltbld', 06:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:35 INFO - 'MOZ_NO_REMOTE': '1', 06:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:35 INFO - 'NO_EM_RESTART': '1', 06:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:35 INFO - 'PWD': '/builds/slave/test', 06:54:35 INFO - 'SHELL': '/bin/bash', 06:54:35 INFO - 'SHLVL': '1', 06:54:35 INFO - 'TERM': 'linux', 06:54:35 INFO - 'TMOUT': '86400', 06:54:35 INFO - 'USER': 'cltbld', 06:54:35 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', 06:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:35 INFO - '_': '/tools/buildbot/bin/python'} 06:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:36 INFO - Downloading/unpacking blobuploader==1.2.4 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54:37 INFO - Downloading blobuploader-1.2.4.tar.gz 06:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:54:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:54:38 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 06:54:38 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 06:54:38 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 06:54:38 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 06:54:38 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 06:54:38 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 06:54:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:54:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:54:38 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 06:54:38 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 06:54:38 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 06:54:38 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 06:54:38 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 06:54:38 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 06:54:38 INFO - Downloading docopt-0.6.1.tar.gz 06:54:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:54:38 INFO - Installing collected packages: blobuploader, requests, docopt 06:54:38 INFO - Running setup.py install for blobuploader 06:54:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:54:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:54:38 INFO - Running setup.py install for requests 06:54:39 INFO - Running setup.py install for docopt 06:54:39 INFO - Successfully installed blobuploader requests docopt 06:54:39 INFO - Cleaning up... 06:54:39 INFO - Return code: 0 06:54:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:39 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 0x7fa7c397cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9160>, '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 0x29ba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ba4f0>, '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': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', '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 06:54:39 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 06:54:39 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 06:54:39 INFO - Using env: {'DISPLAY': ':0', 06:54:39 INFO - 'HOME': '/home/cltbld', 06:54:39 INFO - 'LANG': 'en_US.UTF-8', 06:54:39 INFO - 'LANGUAGE': 'en_US:en', 06:54:39 INFO - 'LOGNAME': 'cltbld', 06:54:39 INFO - 'MAIL': '/var/mail/cltbld', 06:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:39 INFO - 'MOZ_NO_REMOTE': '1', 06:54:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:39 INFO - 'NO_EM_RESTART': '1', 06:54:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:39 INFO - 'PWD': '/builds/slave/test', 06:54:39 INFO - 'SHELL': '/bin/bash', 06:54:39 INFO - 'SHLVL': '1', 06:54:39 INFO - 'TERM': 'linux', 06:54:39 INFO - 'TMOUT': '86400', 06:54:39 INFO - 'USER': 'cltbld', 06:54:39 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', 06:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:39 INFO - '_': '/tools/buildbot/bin/python'} 06:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:54:39 INFO - Running setup.py (path:/tmp/pip-_1W2oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:54:39 INFO - Running setup.py (path:/tmp/pip-PoFmae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:54:39 INFO - Running setup.py (path:/tmp/pip-jgSqTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:54:39 INFO - Running setup.py (path:/tmp/pip-87qZP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:54:39 INFO - Running setup.py (path:/tmp/pip-E4Xt1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:54:39 INFO - Running setup.py (path:/tmp/pip-PEg2qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:54:39 INFO - Running setup.py (path:/tmp/pip-FkJzWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:54:40 INFO - Running setup.py (path:/tmp/pip-n9g0u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:54:40 INFO - Running setup.py (path:/tmp/pip-pZvV8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:54:40 INFO - Running setup.py (path:/tmp/pip-pAYhQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:54:40 INFO - Running setup.py (path:/tmp/pip-34lbzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:54:40 INFO - Running setup.py (path:/tmp/pip-AGMsi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:54:40 INFO - Running setup.py (path:/tmp/pip-s_ZtRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:54:40 INFO - Running setup.py (path:/tmp/pip-GrOY9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:40 INFO - Running setup.py (path:/tmp/pip-gUf0L1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:54:40 INFO - Running setup.py (path:/tmp/pip-__L5O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:54:40 INFO - Running setup.py (path:/tmp/pip-laEwxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:54:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:54:40 INFO - Running setup.py install for manifestparser 06:54:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:54:40 INFO - Running setup.py install for mozcrash 06:54:40 INFO - Running setup.py install for mozdebug 06:54:41 INFO - Running setup.py install for mozdevice 06:54:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:54:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:54:41 INFO - Running setup.py install for mozfile 06:54:41 INFO - Running setup.py install for mozhttpd 06:54:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:54:41 INFO - Running setup.py install for mozinfo 06:54:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:54:41 INFO - Running setup.py install for mozInstall 06:54:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:54:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:54:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:54:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:54:41 INFO - Running setup.py install for mozleak 06:54:41 INFO - Running setup.py install for mozlog 06:54:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:54:41 INFO - Running setup.py install for moznetwork 06:54:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:54:41 INFO - Running setup.py install for mozprocess 06:54:42 INFO - Running setup.py install for mozprofile 06:54:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:54:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:54:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:54:42 INFO - Running setup.py install for mozrunner 06:54:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:54:42 INFO - Running setup.py install for mozscreenshot 06:54:42 INFO - Running setup.py install for moztest 06:54:42 INFO - Running setup.py install for mozversion 06:54:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:54:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:54:42 INFO - Cleaning up... 06:54:42 INFO - Return code: 0 06:54:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:42 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 0x7fa7c397cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9160>, '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 0x29ba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ba4f0>, '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': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', '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 06:54:42 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 06:54:42 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 06:54:42 INFO - Using env: {'DISPLAY': ':0', 06:54:42 INFO - 'HOME': '/home/cltbld', 06:54:42 INFO - 'LANG': 'en_US.UTF-8', 06:54:42 INFO - 'LANGUAGE': 'en_US:en', 06:54:42 INFO - 'LOGNAME': 'cltbld', 06:54:42 INFO - 'MAIL': '/var/mail/cltbld', 06:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:42 INFO - 'MOZ_NO_REMOTE': '1', 06:54:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:42 INFO - 'NO_EM_RESTART': '1', 06:54:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:42 INFO - 'PWD': '/builds/slave/test', 06:54:42 INFO - 'SHELL': '/bin/bash', 06:54:42 INFO - 'SHLVL': '1', 06:54:42 INFO - 'TERM': 'linux', 06:54:42 INFO - 'TMOUT': '86400', 06:54:42 INFO - 'USER': 'cltbld', 06:54:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', 06:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:42 INFO - '_': '/tools/buildbot/bin/python'} 06:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:54:42 INFO - Running setup.py (path:/tmp/pip-XT3Fdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:54:42 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)) 06:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:54:42 INFO - Running setup.py (path:/tmp/pip-vX6mXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:54:42 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)) 06:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:54:42 INFO - Running setup.py (path:/tmp/pip-tbs4Et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:54:42 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)) 06:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:54:43 INFO - Running setup.py (path:/tmp/pip-xZAf5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:54:43 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)) 06:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:54:43 INFO - Running setup.py (path:/tmp/pip-xIIhJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:54:43 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)) 06:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:54:43 INFO - Running setup.py (path:/tmp/pip-Zo4dwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:54:43 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)) 06:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:54:43 INFO - Running setup.py (path:/tmp/pip-8Fnqx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:54:43 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)) 06:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:54:43 INFO - Running setup.py (path:/tmp/pip-pAF9q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:54:43 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)) 06:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:54:43 INFO - Running setup.py (path:/tmp/pip-Tv0LBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:54:43 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)) 06:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:54:43 INFO - Running setup.py (path:/tmp/pip-xeQvhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:54:43 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)) 06:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:54:43 INFO - Running setup.py (path:/tmp/pip-FT6CNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:54:43 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)) 06:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:54:43 INFO - Running setup.py (path:/tmp/pip-VgNLlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:54:43 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)) 06:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:54:43 INFO - Running setup.py (path:/tmp/pip-JoDhCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:54:43 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)) 06:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:54:43 INFO - Running setup.py (path:/tmp/pip-74yit0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:54:43 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)) 06:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:43 INFO - Running setup.py (path:/tmp/pip-_HCawU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:43 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)) 06:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:54:43 INFO - Running setup.py (path:/tmp/pip-flOuXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:54:43 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)) 06:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:54:43 INFO - Running setup.py (path:/tmp/pip-C_QYV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:54:44 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)) 06:54:44 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)) 06:54:44 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)) 06:54:44 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)) 06:54:44 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)) 06:54:44 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)) 06:54:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:45 INFO - Downloading blessings-1.6.tar.gz 06:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:54:45 INFO - Installing collected packages: blessings 06:54:45 INFO - Running setup.py install for blessings 06:54:46 INFO - Successfully installed blessings 06:54:46 INFO - Cleaning up... 06:54:46 INFO - Return code: 0 06:54:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:54:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:54:46 INFO - Reading from file tmpfile_stdout 06:54:46 INFO - Current package versions: 06:54:46 INFO - argparse == 1.2.1 06:54:46 INFO - blessings == 1.6 06:54:46 INFO - blobuploader == 1.2.4 06:54:46 INFO - docopt == 0.6.1 06:54:46 INFO - manifestparser == 1.1 06:54:46 INFO - mozInstall == 1.12 06:54:46 INFO - mozcrash == 0.17 06:54:46 INFO - mozdebug == 0.1 06:54:46 INFO - mozdevice == 0.48 06:54:46 INFO - mozfile == 1.2 06:54:46 INFO - mozhttpd == 0.7 06:54:46 INFO - mozinfo == 0.9 06:54:46 INFO - mozleak == 0.1 06:54:46 INFO - mozlog == 3.1 06:54:46 INFO - moznetwork == 0.27 06:54:46 INFO - mozprocess == 0.22 06:54:46 INFO - mozprofile == 0.28 06:54:46 INFO - mozrunner == 6.11 06:54:46 INFO - mozscreenshot == 0.1 06:54:46 INFO - mozsystemmonitor == 0.0 06:54:46 INFO - moztest == 0.7 06:54:46 INFO - mozversion == 1.4 06:54:46 INFO - psutil == 3.1.1 06:54:46 INFO - requests == 1.2.3 06:54:46 INFO - wsgiref == 0.1.2 06:54:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54: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')]} 06:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:46 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 0x7fa7c397cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9160>, '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 0x29ba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ba4f0>, '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': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', '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 06:54:46 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 06:54:46 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 06:54:46 INFO - Using env: {'DISPLAY': ':0', 06:54:46 INFO - 'HOME': '/home/cltbld', 06:54:46 INFO - 'LANG': 'en_US.UTF-8', 06:54:46 INFO - 'LANGUAGE': 'en_US:en', 06:54:46 INFO - 'LOGNAME': 'cltbld', 06:54:46 INFO - 'MAIL': '/var/mail/cltbld', 06:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:46 INFO - 'MOZ_NO_REMOTE': '1', 06:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:46 INFO - 'NO_EM_RESTART': '1', 06:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:46 INFO - 'PWD': '/builds/slave/test', 06:54:46 INFO - 'SHELL': '/bin/bash', 06:54:46 INFO - 'SHLVL': '1', 06:54:46 INFO - 'TERM': 'linux', 06:54:46 INFO - 'TMOUT': '86400', 06:54:46 INFO - 'USER': 'cltbld', 06:54:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', 06:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:46 INFO - '_': '/tools/buildbot/bin/python'} 06:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:46 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)) 06:54:46 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)) 06:54:46 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)) 06:54:46 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)) 06:54:46 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)) 06:54:46 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)) 06:54:46 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)) 06:54:46 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)) 06:54:46 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)) 06:54:46 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)) 06:54:46 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)) 06:54:46 INFO - Cleaning up... 06:54:46 INFO - Return code: 0 06:54:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:54: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')]} 06:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7c397cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9160>, '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 0x29ba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ba4f0>, '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': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', '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 06:54:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:54:46 INFO - Using env: {'DISPLAY': ':0', 06:54:46 INFO - 'HOME': '/home/cltbld', 06:54:46 INFO - 'LANG': 'en_US.UTF-8', 06:54:46 INFO - 'LANGUAGE': 'en_US:en', 06:54:46 INFO - 'LOGNAME': 'cltbld', 06:54:46 INFO - 'MAIL': '/var/mail/cltbld', 06:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:46 INFO - 'MOZ_NO_REMOTE': '1', 06:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:46 INFO - 'NO_EM_RESTART': '1', 06:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:46 INFO - 'PWD': '/builds/slave/test', 06:54:46 INFO - 'SHELL': '/bin/bash', 06:54:46 INFO - 'SHLVL': '1', 06:54:46 INFO - 'TERM': 'linux', 06:54:46 INFO - 'TMOUT': '86400', 06:54:46 INFO - 'USER': 'cltbld', 06:54:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', 06:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:46 INFO - '_': '/tools/buildbot/bin/python'} 06:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:46 INFO - Downloading/unpacking jsonschema 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:54:48 INFO - Downloading/unpacking functools32 (from jsonschema) 06:54:48 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 06:54:48 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 06:54:48 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 06:54:48 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 06:54:48 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 06:54:48 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 06:54:48 INFO - Downloading functools32-3.2.3-2.tar.gz 06:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:54:48 INFO - warning: no files found matching '*.txt' 06:54:48 INFO - no previously-included directories found matching 'build' 06:54:48 INFO - no previously-included directories found matching 'dist' 06:54:48 INFO - no previously-included directories found matching '.git*' 06:54:48 INFO - Installing collected packages: jsonschema, functools32 06:54:48 INFO - Running setup.py install for functools32 06:54:49 INFO - warning: no files found matching '*.txt' 06:54:49 INFO - no previously-included directories found matching 'build' 06:54:49 INFO - no previously-included directories found matching 'dist' 06:54:49 INFO - no previously-included directories found matching '.git*' 06:54:49 INFO - Successfully installed jsonschema functools32 06:54:49 INFO - Cleaning up... 06:54:49 INFO - Return code: 0 06:54:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:49 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 0x7fa7c397cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9160>, '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 0x29ba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ba4f0>, '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': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', '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 06:54:49 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 06:54:49 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 06:54:49 INFO - Using env: {'DISPLAY': ':0', 06:54:49 INFO - 'HOME': '/home/cltbld', 06:54:49 INFO - 'LANG': 'en_US.UTF-8', 06:54:49 INFO - 'LANGUAGE': 'en_US:en', 06:54:49 INFO - 'LOGNAME': 'cltbld', 06:54:49 INFO - 'MAIL': '/var/mail/cltbld', 06:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:49 INFO - 'MOZ_NO_REMOTE': '1', 06:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:49 INFO - 'NO_EM_RESTART': '1', 06:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:49 INFO - 'PWD': '/builds/slave/test', 06:54:49 INFO - 'SHELL': '/bin/bash', 06:54:49 INFO - 'SHLVL': '1', 06:54:49 INFO - 'TERM': 'linux', 06:54:49 INFO - 'TMOUT': '86400', 06:54:49 INFO - 'USER': 'cltbld', 06:54:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', 06:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:49 INFO - '_': '/tools/buildbot/bin/python'} 06:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:49 INFO - Downloading/unpacking flake8 06:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:54:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:54:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:54:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:54:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:54:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:54:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:54:52 INFO - no previously-included directories found matching 'docs/_build' 06:54:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:54:52 INFO - Running setup.py install for pep8 06:54:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:54:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:54:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:54:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:54:52 INFO - no previously-included directories found matching 'docs/_build' 06:54:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:54:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:54:52 INFO - Cleaning up... 06:54:52 INFO - Return code: 0 06:54:52 INFO - Running post-action listener: _resource_record_post_action 06:54:52 INFO - Running post-action listener: _start_resource_monitoring 06:54:52 INFO - Starting resource monitoring. 06:54:52 INFO - ##### 06:54:52 INFO - ##### Running install step. 06:54:52 INFO - ##### 06:54:52 INFO - Running pre-action listener: _resource_record_pre_action 06:54:52 INFO - Running main action method: install 06:54:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:54:52 INFO - Reading from file tmpfile_stdout 06:54:52 INFO - Detecting whether we're running mozinstall >=1.0... 06:54:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:54:52 INFO - Reading from file tmpfile_stdout 06:54:52 INFO - Output received: 06:54:52 INFO - Usage: mozinstall [options] installer 06:54:52 INFO - Options: 06:54:52 INFO - -h, --help show this help message and exit 06:54:52 INFO - -d DEST, --destination=DEST 06:54:52 INFO - Directory to install application into. [default: 06:54:52 INFO - "/builds/slave/test"] 06:54:52 INFO - --app=APP Application being installed. [default: firefox] 06:54:52 INFO - mkdir: /builds/slave/test/build/application 06:54:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:55:07 INFO - Reading from file tmpfile_stdout 06:55:07 INFO - Output received: 06:55:07 INFO - /builds/slave/test/build/application/firefox/firefox 06:55:07 INFO - Running post-action listener: _resource_record_post_action 06:55:07 INFO - ##### 06:55:07 INFO - ##### Running run-tests step. 06:55:07 INFO - ##### 06:55:07 INFO - Running pre-action listener: _resource_record_pre_action 06:55:07 INFO - Running main action method: run_tests 06:55:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:55:07 INFO - Python 2.7.3 06:55:07 INFO - Return code: 0 06:55:07 INFO - grabbing minidump binary from tooltool 06:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:07 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 0x29b9160>, '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 0x29ba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ba4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:55:07 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 06:55:07 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 06:55:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:55:07 INFO - Return code: 0 06:55:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:55:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:55:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:55:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:55:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:55:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:55:08 INFO - Return code: 0 06:55:08 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/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 06:55:08 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/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 06:55:08 INFO - Using env: {'DISPLAY': ':0', 06:55:08 INFO - 'HOME': '/home/cltbld', 06:55:08 INFO - 'LANG': 'en_US.UTF-8', 06:55:08 INFO - 'LANGUAGE': 'en_US:en', 06:55:08 INFO - 'LOGNAME': 'cltbld', 06:55:08 INFO - 'MAIL': '/var/mail/cltbld', 06:55:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:55:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:08 INFO - 'MOZ_NO_REMOTE': '1', 06:55:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:08 INFO - 'NO_EM_RESTART': '1', 06:55:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:08 INFO - 'PWD': '/builds/slave/test', 06:55:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:55:08 INFO - 'SHELL': '/bin/bash', 06:55:08 INFO - 'SHLVL': '1', 06:55:08 INFO - 'TERM': 'linux', 06:55:08 INFO - 'TMOUT': '86400', 06:55:08 INFO - 'USER': 'cltbld', 06:55:08 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020', 06:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:08 INFO - '_': '/tools/buildbot/bin/python'} 06:55:08 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/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 06:55:09 INFO - mozversion application_buildid: 20160414034258 06:55:09 INFO - mozversion application_changeset: 589bd8060a90ac2022b7f6dee222cbc4bfc34aa7 06:55:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:55:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:55:09 INFO - mozversion application_name: Firefox 06:55:09 INFO - mozversion application_remotingname: firefox-dev 06:55:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:55:09 INFO - mozversion application_vendor: Mozilla 06:55:09 INFO - mozversion application_version: 47.0a2 06:55:09 INFO - mozversion platform_buildid: 20160414034258 06:55:09 INFO - mozversion platform_changeset: 589bd8060a90ac2022b7f6dee222cbc4bfc34aa7 06:55:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:55:09 INFO - mozversion platform_version: 47.0a2 06:55:09 INFO - using testdate: 1460642109 06:55:09 INFO - actual date: 1460642109 06:55:09 INFO - starting webserver on 'localhost:52332' 06:55:09 INFO - SUITE-START | Running 2 tests 06:55:09 INFO - TEST-START | dromaeo_css 06:55:09 INFO - operating with platform_type : linux_ 06:55:09 INFO - Initialising browser for dromaeo_css test... 06:55:09 INFO - TEST-INFO | started process 6236 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmBau_f/profile http://localhost:52332/getInfo.html) 06:55:12 INFO - PROCESS | 6236 | 06:55:12 INFO - PROCESS | 6236 | (process:6314): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:55:13 INFO - PROCESS | 6236 | __metrics Screen width/height:1600/1200 06:55:13 INFO - PROCESS | 6236 | colorDepth:24 06:55:13 INFO - PROCESS | 6236 | Browser inner width/height: 1024/697 06:55:13 INFO - PROCESS | 6236 | __metrics 06:55:14 ERROR - PROCESS | 6236 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 06:55:14 INFO - TEST-INFO | 6236: exit 0 06:55:14 INFO - Browser initialized. 06:55:14 INFO - Running cycle 1/1 for dromaeo_css test... 06:55:14 INFO - TEST-INFO | started process 6365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmBau_f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:16 INFO - PROCESS | 6365 | 06:55:16 INFO - PROCESS | 6365 | (process:6434): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:55:26 INFO - PROCESS | 6365 | RSS: Main: 151203840 06:55:26 INFO - PROCESS | 6365 | 06:56:16 INFO - PROCESS | 6365 | 1460642176181 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] 06:58:24 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:52332/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52332/tests/dromaeo/cssquery-ext.html) 06:58:25 INFO - PROCESS | 6365 | RSS: Main: 155561984 06:58:25 INFO - PROCESS | 6365 | 07:01:27 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:52332/tests/dromaeo/cssquery-ext.html (next: http://localhost:52332/tests/dromaeo/cssquery-jquery.html) 07:01:27 INFO - PROCESS | 6365 | RSS: Main: 153186304 07:01:27 INFO - PROCESS | 6365 | 07:04:29 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:52332/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52332/tests/dromaeo/cssquery-mootools.html) 07:04:29 INFO - PROCESS | 6365 | RSS: Main: 153317376 07:04:29 INFO - PROCESS | 6365 | 07:07:31 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:52332/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52332/tests/dromaeo/cssquery-prototype.html) 07:07:32 INFO - PROCESS | 6365 | RSS: Main: 152170496 07:07:32 INFO - PROCESS | 6365 | 07:10:34 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:52332/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52332/tests/dromaeo/cssquery-yui.html) 07:10:35 INFO - PROCESS | 6365 | RSS: Main: 153591808 07:10:35 INFO - PROCESS | 6365 | 07:13:37 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:52332/tests/dromaeo/cssquery-yui.html (next: http://localhost:52332/tests/dromaeo/cssquery-dojo.html) 07:13:37 INFO - PROCESS | 6365 | RSS: Main: 155303936 07:13:37 INFO - PROCESS | 6365 | 07:13:37 INFO - PROCESS | 6365 | __start_tp_report 07:13:37 INFO - PROCESS | 6365 | _x_x_mozilla_page_load 07:13:37 INFO - PROCESS | 6365 | _x_x_mozilla_page_load_details 07:13:37 INFO - PROCESS | 6365 | |i|pagename|runs| 07:13:37 INFO - PROCESS | 6365 | |0;dojo.html;3331.9833400833;3393.881214157504;3418.2479854432017;3419;3421.7433692473055;5477.698726570042;5500.037493438652;5508.55931525478;5523.6409633373805;5547.6671399716;5383.380911195214;5418.241446197536;5434.83695489136;5484.067708489556;5484.177373393993;5027.924581131286;5033.496650334965;5082.0598189334905;5086.516780905808;5160.509751573613;4932.136876046696;5034.82378116766;5149.124648809711;5165.509276618715;5172.8706782330555;5067.670601410915;5072.594192464612;5144.974275128619;5164.664296820713;5172.689638621695;5123.282740416326;5140.049090918192;5148.099082660557;5151;5167.457416971239;4818.566329030404;4894.8042078317185;4973.701577905337;5027;5088.618353623493;5178.326817513699;5202.843914682566;5218.295530103425;5234.895302093975;5257.4742525747115;5874.1776151338845;5919.585629005971;5932.7330270137945;5935.465808077293;5949.107633854913;5765.913511297292;5937.317208521033;5973.790917317873;5993.700314984277;6012.879742405171;5455.263539422207;5506.1190209566275;5514.476124768141;5515.117581186991;5529;5853.122031695195;5917.31950825652;5974.820755377345;5999.190109335271;6011.158437818709;5783.306003279633;5800.796972106041;5803.709814509258;5821.446962538552;5858.443447872445;5891.7054147292465;5924.11138329254;5924.348321684612;5935.554833387513;5952.226210592596;5734.369219385864;5847.736851841677;5858.502027327725;5873.911891321633;5900.350961394243;5955.196048533479;5965.642061476238;5965.880682386328;5971.701414929236;6006.879862402728;4541.091781643684;4544.3198498207585;4548.522405147478;4549.886252843706;4580.24425969718;4002.6197511236387;4075.3683179107284;4092.7748973806133;4108.096218831853;4151.294279972412;5658.462446067617;5775.249217601685;5820.854478637983;5874.73563689635;5878.823635290948;5844.415558444207;5908.527317814564;5957.434043765836;5973.49225315853;5976.61152025117;5589.469000444951;5729.083346664597;5747.339056008529;5757.942420575824;5778.913316300259;5158.690478571298;5173.094708426011;5185.429602743695;5190.714510701872;5215;6256.593321434092;6261.342559031327;6262.780802671885;6268;6272.811815645447;5745.540356771365;5927.9703601481715;5943.138244954371;5953.761849526057;5967.075103358986;6214.974529202812;6243.001119820807;6293.842653933688;6298.11826344303;6301.96849015752;5869.325027621708;5874.17761513397;5874.794382196603;5877.73550190251;5911.172435858897;5647.717614119196;5898.3216930053595;5924.763009479572;5968.432998865101;5992.460678538952;5769.59612827098;5780.537556995514;5802.158686990447;5802.738876750472;5831.679257640871;5852.619579727304;5854.736536855937;5861.6189947653265;5863.589548731718;5877.294724633071;5444.891102177855;5709.429057094258;5761;5770.394108618535;5779.8555036124435;5802.1296805479515;5808.186853840551;5823.970880145572;5855.8536036597725;5869.236999190249;5545.916811247916;5682.943170568242;5706.857328566819;5712.828615141552;5744 07:13:37 INFO - PROCESS | 6365 | |1;ext.html;554.226853539313;567.5289509706944;575.1670902758168;578.412910895441;619.9999999999999;41621;42611.573884261146;42747.78626106865;42813.99999999996;42830.7858460708;43755.78122109385;44226.778866105626;44743.32885006719;44771.328430073576;44832.55167448324;8663.263622592087;8890.86663700045;8910.242629376511;8926.419782714103;8978.595963181673;8758.868616970718;8851.893513310835;8892.110788921122;8929.241014513775;8943.239824614915;8900.465972041698;8909.68816091437;8970.955145224265;8971.192592666659;8987.415817971843;8880.644774209057;8931.64273429062;8940.642374305053;8971.955140224323;8977.955110224473;8780.868286975701;8866.113388661146;8888.466691998501;8894.4663320201;8895.79906712592;34488.82755586231;40395.39406908899;40887.38668919969;40968.38547421791;40977.59022409767;3509.3683137035323;3617.5839778425557;3744.794036328001;3798.8670396536263;3864.864729734446;28995.565066524017;29321.41357172866;29810.552841707176;30002.549961750592;30059;4035.717499775017;4104.856330028435;4113.732607380541;4147.108371700068;4152.6055024772595;199898;200870;201803;201855;201936;60113;60345.396546034855;60422.09366859501;60675.393246066975;61096.38903610907;73013.26986730171;73350.63324683449;73664.26335736681;73769;73937.63031184918;15978.60053498672;16114.355425782838;16214;16329.51011469634;16405.42581009683;12663.113582049167;12793.808092878615;12885;12909.419076141596;12975.09174357786;22145.77854221437;22518.887405563197;22724.545509089727;22805.88597057004;22953.655695164587;8231.629576669064;8319.33613277335;8363.665453381796;8562.100979397199;8737.257333126756;1020.7090979070929;1057.6298295596634;1135.625243669587;1155.1913660437726;1215.489494412349;29339;29415.705842941297;29657;30163.245918851764;30325.696743032728;1165.1901928159848;1171.2796630072614;1224.1981502116128;1227.1655274413306;1232.48235740989;15371.231438428258;15811.841881581267;16078.276477558538;16158.838411615969;16159.272832722556;317633;491349;504036;509127;512375;54907.45092549103;55942.44057559453;55946.720266398406;56006;56258;1479.4895760962452;1479.9926000369715;1507.1785876697227;1510.8942374033932;1513.3038802150913;29581.704182957896;31184.22039449032;31288.460001598083;31702.682973169973;32019.67980320167;47781.52218477771;48781;49002.509974899796;49013.509864900894;49020.26469602888;310466;310817;311223;313457;314424;34389.14027149241;50986.23520647267;51207.48792512027;51721.96556068782;52092.73953630359;46847.29729053999;47343.28985065158;47522.52477475319;47575.52424475711;48054;39323;39434.80282598684;39798.01009949433;40425.1914961705;40514.79742601268;39170.41244381393;39306.86379714629;39705.40441893316;39746.80126599348;39759.2048159041;38782.224355513295;39179.60820391874;39675;39928.60071399249;39981.2003759929;34037;34707.65292347044;34961.65038349685;34994;35107.29785404226;26909.461810764067;27119.322016949733;27134.864325678245;27259.86370068137;27374.589381159698 07:13:37 INFO - PROCESS | 6365 | |2;jquery.html;377.6469001483612;384.79413513770123;386.01373490731186;387.5910913985744;400.0139655748583;17620.383286584973;18574.81425185748;18751.249950002017;18775.155118019688;18878.622427551458;17548.56128596786;18239.17923693434;18279.451616451493;18294.268229270845;18296.90851545744;5483.341998960121;5767.336756273019;5805.941940580604;5811.941880581204;5819.7963071292515;4287.442632457776;6126.7855625053135;6313.77901773438;6328.367163283658;6389.1694079769795;6087.3303936566945;6267.968660156693;6290.339514350996;6313;6316.305206427312;6184.938150618504;6195.690215489208;6239;6247.531435142382;6261.405166509197;5536.114221724505;5536.972315138399;5551.583631227633;5554.555635549146;5625;19855.60288794216;20589.38231853047;21735.782642173694;22182.223622173147;22372;2174.358564223558;2257.4582100295975;2329.3477826208687;2361.1027809432476;2707.9323016924536;10233.437160956144;10291.228157888188;10321.948390258001;12333.568325108577;12915.160514566523;1794.8205179482077;1943.2129987355145;1980.6137803128395;1982.9206831726713;1986.7715212750575;68580;70595;70819.64590177068;71276.64361678158;71366;10586.629467968583;10708.78582428347;10806.78386432267;10816.080633146114;10970.890291096986;15362;15418.537443876701;15456.918015739015;15488.535343939475;15548.378064877279;7812.804679882935;7913.406494512935;7934.365250780039;7992.320652744582;8057.637406316612;7481.551106933602;7508.62456877154;7576.7348142814735;7651.770446886602;7697.730579429693;4757.881052973703;4762.404699412574;4819.734914579732;4841.8547443576745;4842.055799119138;1917.3289348727833;2006.3579654510418;2041.6427125253022;2073.2225415469197;2075.941269952335;904.3217586809892;996.2478328861808;1031.8194315994672;1052.1004541117234;1073.1897417449775;17533.386331478338;17587.56031099207;17606.823931760773;17761.555961101076;18310.359137430125;1009.9545520451597;1010.7725761703705;1019.1577751875536;1110.4669758515959;1110.9944450277696;10372.27394082407;10393.37639741618;10520.26358154937;10540.262181647211;10550.894491055145;409744;413776;420700;432177;432482;75056.62471687715;78688;80774;80792;81327.593362034;987.3976874106789;995.0944640377367;1001.8747656542932;1010.6058637131524;1040.5837664934088;15964.20178991069;16084;16206;16267;16481.34074637001;24666;28654.14037578876;33841.66158338385;35828.92513224608;36206.637933620324;52143;52911.20633190582;53240.46759532355;53271.46728532665;53431;8679.435836670596;8731.825363492822;9017.729468115967;9036.909630903607;9165.77085572866;11276.94361528187;11350.262232955161;11580.710482238012;11812.232204906997;11937.641870743892;6677.933220667731;9967.754030746157;10025.899741002788;10276.948615256875;10545.261831671709;10609.310394824312;10622.89377106219;10634.946825265824;10880.292780969212;10908.672739817817;10666.73333166646;10861.239713219999;10991.175661825555;11099.334039957628;11274.323540587591;8790;8858.557072146237;8964.462132272085;9099.226565741987;9214.2628589714;10614.097801686943;10656.62701805433;10677.9466102669;10703.571857125939;10821.729456763644 07:13:37 INFO - PROCESS | 6365 | |3;mootools.html;1585.151943710115;1586.6112802363423;1861.0880668472444;1921.5100149461884;1950.0639692947393;7371.373433258166;8104.635291411886;8403.91596084039;8595.226429621332;8657.047724750273;8323.62543685534;8352.791180220498;8382.077971423154;8424.326053915687;8433;2366.8816559172014;2393.7366889642126;2410.915617953372;2411.5176964607062;2416.6254230594286;2308.3882771065682;2351.27110595715;2407.807375409963;2421.4551725861716;2423.7455067217866;2445.6576079348906;2460.6432067350224;2482.726900041003;2488.639147323637;2488.825782195247;2455.312512496486;2473.010795681733;2479.776820086192;2483.428811373376;2494.675692160026;2469.6172093325563;2487.0797804812155;2487.3035550046015;2497.4880149569294;2511.5855883779154;8432;8436.83126337476;8452.8732069019;8471.279941205004;8494.660213591449;5014.52362025607;5132.435432102466;5143.996920600484;5148.613853960968;5153;3264.836758162106;3272.918177045569;3318.2533929865826;3352.580927384077;3362.798232106057;1023.4801320039735;1069.3476979042778;1081.7073597051526;2032.3090149349143;2072.285061653727;11330;11390.316581005167;11496.252743571642;11505.539778408853;11510.136739744552;4388.626966707801;4498.347739577743;4516.051629157913;4542.159700455426;4551.431071116111;9163.221126204215;9193.63225470987;9218.354715169873;9229.630814767468;9266.11971862672;5025.84922452327;5027.798888044437;5046.369203849519;5064.670796398296;5067.847964561069;4061.9593804061583;4531.954680453153;4552.0668263006;4632.675712700146;4692.0381321828945;3517.982410087933;3567.5897271813556;3579.2483578448296;3586.874459393961;3622.7826330420257;1112.1103117506125;1114.4650567727535;1125.2123513540555;1127.075797845775;1132.2810015639964;1461.5761429185418;1462.203099310878;1472.955811325662;1485.7919891215238;1507.6833864888497;7870.803229919298;7919.802004949923;7967.8406431871035;8035.718749843727;8098;546.1698218707543;548.9295873047494;557.8326502049368;560.4283630696666;562.3561022629067;6036.788712395133;6084.361142080106;6107.96946015276;6114.021756519024;6165.599236049732;10079.596816127272;10276.486175691334;10354.378737275787;10359.896401036043;10394.792104157874;9324.347295689236;10107.241956853266;10216.591336346612;10268.948655256825;10273.794524109477;7890;7893.329067029367;7905.169957154531;7926.048874135141;7968.721094761656;7897.565633890191;7931.5637639928045;8001.599920004093;8114.918850811652;8156.755297341089;9054.411463254868;9154.313426493172;9257.398269112486;9287.442753434816;9336.673216437392;9164.862527061967;9229.169374756304;9297.86053209216;9429.669961551313;9640.807183856143;6409.9359006411205;7009.859802803813;7238.963805180941;7490.288422599844;7630.1606823248285;7614.16244213125;7711.305982461606;7743.032120984877;7770.378369730295;7829;6815.556988795713;7081.433485321265;7082.858342833218;7123.643817808985;7219.025431566672;6907.516473846984;6910.516263861682;6990.440764738707;7063.82340441493;7090.64546772649;7498.175200727806;7503.587302698404;7572;7626.275503827128;7647.273509016634;7096.7516136934955;7114.750983715545;7123.928760712534;7129.679164437716;7139.071920650283;6843.726250949906;7078.964605176941;7102.041224434842;7120.181179164462;7194.2086370498155 07:13:37 INFO - PROCESS | 6365 | |4;prototype.html;345.751059237349;351.1834983662984;360.5385107062959;367.2654690618763;369.4808793644929;6144.047672610742;6170.290416602092;6200.906986395207;6229.906551401727;6235.7505699771955;6213.94362958297;6218.81343559694;6221.875562488747;6255.468285195764;6272.059191121322;4916.065947469987;4918.631102667314;4922.409310882699;4924.236743304785;4935.012997400517;4918.434380046287;4923.384576927884;4933.876653083666;4942.912559236962;4946.0107978404285;4891.388576427947;4894.045661096087;4901.191303434929;4904.337914381566;4913.041956818422;4626.21354369758;4837.951620483803;4848.806047758086;4906.558409743105;4907.975460122694;4173;4181.958180418187;4188.476440444944;4191.1827193697245;4199.517055538621;5863.4722874941035;5864.325602555676;5872.677002764846;5874.353821079721;5887.4406931341455;5437.809676661337;5559.444055594448;5594.384617692051;5598.300212473441;5601.691906945116;6506.707198176094;6557.573757705733;6567.737290508374;6591.571547849375;6595.439387652055;4653.7440440775745;4658.627309815207;4661.557152070548;4664.696794708333;4668.253079507296;6865.27914568968;6869.725210991554;6894.276101009372;6935.271796461399;6940.340667636567;4768.237082066853;4781.641376896747;4781.95218047822;4794.232922732346;4798.688085274446;4705.670603057822;4825.227963525819;4834.7824347904425;4852.781624826891;4860.052289803454;5547.306586676666;5548.611597188158;5580.19087232349;5581.2186293918885;5587.8882422352135;6636.568623039487;6647.60114393138;6652.667366631649;6674.698433805458;6683.131192944886;1699.1419333236636;1711.1786342555642;1719.1919797695064;1722.1733567887234;1723.6035711786108;1104.276698762312;1136.8749437561862;1143.4168574027306;1152.4180288954024;1153.7692461507731;6410.871782564416;6484.610923344614;6646.634435106019;6691.297413771581;6696.06255124283;6914.585124892523;6959.09531760878;6961.164660240804;7040.155181378165;7059.435245180373;6624.436922861514;6657.3342665733035;6659.766908158192;6672.165979252593;6694.631795251308;3725.739198256096;3748.756330838487;3758;3758.830852611639;3768.7927164005696;7184.928150718531;7414.480986331013;7421.554706717507;7431.108267007994;7434.516756410816;7093.077899872984;7104.609246491389;7120.394766444911;7138.393236574845;7166.283371662792;7384.5200061996875;7385.483016188923;7389.371903388273;7391.926080739124;7424.109106907205;6841.794746157623;6868.896966545606;6909.965450172717;6925.480588955747;6935.687894044881;6679.432248258758;6835.384815366641;6860.794176174722;6927.7228910843005;6944.305569443015;7362.595057271901;7367.300106490089;7390.815229619087;7399.297066778648;7452.552846829208;4651.837185698484;4710;4718.598919091778;4730.47964723887;4732.574068333866;6870.587764734132;6903.206131294965;6908;6912.723491060502;6925.030495730501;6529.281779004211;6685.63229022389;6716.059751634677;6731.663416829041;6743.393094621508;6687.832804179934;6706.731730730716;6716.6902454021;6717.9328206719265;6746.123004009447;6543.770968016097;6581;6583.63789991555;6584.868302634016;6596.142501474777;6707.765228217184;6707.798766037026;6725.058491811053;6749.257581666111;6765.458763299022;6411.935880641134;6469.417752402306;6550.181227346582;6557.836054098686;6585.901211481927 07:13:37 INFO - PROCESS | 6365 | |5;yui.html;755.5126943121687;767.3400875247287;782.9686812527498;871.0592560035162;896.3143195455474;13827.170369777808;13969.23169225691;14032;14103.435862565499;14131.152130872155;12831.42258598363;12931.35343232837;12953.158044727086;12963;12963.416646250918;767.9270469305407;912.4798864647154;923.2383283790866;925.9999200863085;929.4005366538579;909.586138307072;912.2382810353363;918.1186061381048;918.3892711346946;922.1608336413865;950.4582388038821;956.0439560439561;958.9856152157723;960.5341409416427;981.6220755009338;951.3007939164778;952.3524003677531;953.9427634341962;955.3837774635356;960.9375390599623;713.1940906775311;716.183550752143;718.0987860235423;721.678852910455;724.1527412926888;12700.301483418409;12751.936240318832;12773.872261277362;13080.86919130806;13117.212967221998;13068.346582670829;13350.933245333808;13494.055416120875;13548;13621.25083120428;11240.775184496346;11249;11389.373584452851;11570.074394048455;11596.94201528987;3940.645341919241;3950.5851885551892;3960.6633436157963;3997.2205419943125;4059.7158198926086;49203;49840.750796246146;49933.50066499325;50674.746626267;51983.74008129935;9550.140487356171;9572.186364159124;9638.855417168748;9864.802703945881;10019.148372388428;16773.91613041927;16932.23804928781;18751.812481875008;19023.429297121107;19058.904705476383;7939.20607939213;8011.839763204704;8058.556779377191;8081.191880811989;8123.796905077302;4429.424174857248;4470.664700147502;4476.597106260452;4618.49196588375;4670.229412146958;3206.8556914938886;3215.099772063826;3217.9195520112185;3219.4687876500584;3239.7408207343356;583.585654185533;600.2946537818046;602.3524710935761;608.0180508478863;620.8509957610141;641.7850020243177;667.0960848050821;678.5352033856824;678.7556479667315;687.0998991321385;7197.244289349647;7439.51643143194;7460.1047874254355;7703.576303303372;7774.533527988226;524.8477941396952;560.246468499867;635.7393468677819;665.8368699668612;673.175360183771;3597.568291804948;3649.39784935488;3732.0989440185353;3846.538415390171;3916.373380259145;55651.72174139103;56230.43769562252;56244.71877640668;56372.71813640987;56469;51731.48268517267;51912;52685.47314526806;53005.204921926204;53852.730736346064;48175.759121204166;48231.517684823404;48350.27474587884;48567;49255.50744492509;8505.06444291115;8562.229399353839;8584.527850968258;8665.480071195749;8671;36463.088422789646;36834.26331473302;37277.25445491129;37355;37651.623483764815;42544;45550.54449455596;46545.76727116343;46659;46917.765411172724;11265.71835704114;11628.825567616661;11691.766164676488;11720.648380548597;11973.042156627624;11894.524219031488;12755.362231888183;12844;13092.672683182996;13134.73730525365;11973.461194246454;12196.207246528948;12294.692632684255;12334.691632709255;12572.30852303132;10733.624323148651;10804.297720648132;10840.132789376674;11066.170037247399;11149.386783726648;11553.701565051146;11803.468843901874;12165.087618428477;12170.756584868075;12258.387080646111;9540.33217674756;10293.84559231597;10309.22680798958;10563.52464139131;10589.311694739818;9840.950795245977;9992.218519922539;10193.725784276965;10249.692509224735;10486.632967846088 07:13:37 INFO - PROCESS | 6365 | __end_tp_report 07:13:37 INFO - PROCESS | 6365 | __start_cc_report 07:13:37 INFO - PROCESS | 6365 | _x_x_mozilla_cycle_collect,334 07:13:37 INFO - PROCESS | 6365 | __end_cc_report 07:13:37 INFO - PROCESS | 6365 | __startTimestamp1460643217434__endTimestamp 07:13:37 INFO - PROCESS | 6365 | 07:13:37 INFO - PROCESS | 6365 | ------- Summary: start ------- 07:13:37 INFO - PROCESS | 6365 | Number of tests: 6 07:13:37 INFO - PROCESS | 6365 | 07:13:37 INFO - PROCESS | 6365 | [#0] dojo.html Cycles:165 Average:5520.83 Median:5769.60 stddev:606.18 (10.5%) stddev-sans-first:583.22 07:13:37 INFO - PROCESS | 6365 | Values: 3332.0 3393.9 3418.2 3419.0 3421.7 5477.7 5500.0 5508.6 5523.6 5547.7 5383.4 5418.2 5434.8 5484.1 5484.2 5027.9 5033.5 5082.1 5086.5 5160.5 4932.1 5034.8 5149.1 5165.5 5172.9 5067.7 5072.6 5145.0 5164.7 5172.7 5123.3 5140.0 5148.1 5151.0 5167.5 4818.6 4894.8 4973.7 5027.0 5088.6 5178.3 5202.8 5218.3 5234.9 5257.5 5874.2 5919.6 5932.7 5935.5 5949.1 5765.9 5937.3 5973.8 5993.7 6012.9 5455.3 5506.1 5514.5 5515.1 5529.0 5853.1 5917.3 5974.8 5999.2 6011.2 5783.3 5800.8 5803.7 5821.4 5858.4 5891.7 5924.1 5924.3 5935.6 5952.2 5734.4 5847.7 5858.5 5873.9 5900.4 5955.2 5965.6 5965.9 5971.7 6006.9 4541.1 4544.3 4548.5 4549.9 4580.2 4002.6 4075.4 4092.8 4108.1 4151.3 5658.5 5775.2 5820.9 5874.7 5878.8 5844.4 5908.5 5957.4 5973.5 5976.6 5589.5 5729.1 5747.3 5757.9 5778.9 5158.7 5173.1 5185.4 5190.7 5215.0 6256.6 6261.3 6262.8 6268.0 6272.8 5745.5 5928.0 5943.1 5953.8 5967.1 6215.0 6243.0 6293.8 6298.1 6302.0 5869.3 5874.2 5874.8 5877.7 5911.2 5647.7 5898.3 5924.8 5968.4 5992.5 5769.6 5780.5 5802.2 5802.7 5831.7 5852.6 5854.7 5861.6 5863.6 5877.3 5444.9 5709.4 5761.0 5770.4 5779.9 5802.1 5808.2 5824.0 5855.9 5869.2 5545.9 5682.9 5706.9 5712.8 5744.0 07:13:37 INFO - PROCESS | 6365 | 07:13:37 INFO - PROCESS | 6365 | [#1] ext.html Cycles:180 Average:51254.09 Median:22008.46 stddev:91934.93 (417.7%) stddev-sans-first:92114.03 07:13:37 INFO - PROCESS | 6365 | Values: 554.2 567.5 575.2 578.4 620.0 41621.0 42611.6 42747.8 42814.0 42830.8 43755.8 44226.8 44743.3 44771.3 44832.6 8663.3 8890.9 8910.2 8926.4 8978.6 8758.9 8851.9 8892.1 8929.2 8943.2 8900.5 8909.7 8971.0 8971.2 8987.4 8880.6 8931.6 8940.6 8972.0 8978.0 8780.9 8866.1 8888.5 8894.5 8895.8 34488.8 40395.4 40887.4 40968.4 40977.6 3509.4 3617.6 3744.8 3798.9 3864.9 28995.6 29321.4 29810.6 30002.5 30059.0 4035.7 4104.9 4113.7 4147.1 4152.6 199898.0 200870.0 201803.0 201855.0 201936.0 60113.0 60345.4 60422.1 60675.4 61096.4 73013.3 73350.6 73664.3 73769.0 73937.6 15978.6 16114.4 16214.0 16329.5 16405.4 12663.1 12793.8 12885.0 12909.4 12975.1 22145.8 22518.9 22724.5 22805.9 22953.7 8231.6 8319.3 8363.7 8562.1 8737.3 1020.7 1057.6 1135.6 1155.2 1215.5 29339.0 29415.7 29657.0 30163.2 30325.7 1165.2 1171.3 1224.2 1227.2 1232.5 15371.2 15811.8 16078.3 16158.8 16159.3 317633.0 491349.0 504036.0 509127.0 512375.0 54907.5 55942.4 55946.7 56006.0 56258.0 1479.5 1480.0 1507.2 1510.9 1513.3 29581.7 31184.2 31288.5 31702.7 32019.7 47781.5 48781.0 49002.5 49013.5 49020.3 310466.0 310817.0 311223.0 313457.0 314424.0 34389.1 50986.2 51207.5 51722.0 52092.7 46847.3 47343.3 47522.5 47575.5 48054.0 39323.0 39434.8 39798.0 40425.2 40514.8 39170.4 39306.9 39705.4 39746.8 39759.2 38782.2 39179.6 39675.0 39928.6 39981.2 34037.0 34707.7 34961.7 34994.0 35107.3 26909.5 27119.3 27134.9 27259.9 27374.6 07:13:37 INFO - PROCESS | 6365 | 07:13:37 INFO - PROCESS | 6365 | [#2] jquery.html Cycles:180 Average:25765.16 Median:2293.40 stddev:69429.63 (3027.4%) stddev-sans-first:69598.23 07:13:37 INFO - PROCESS | 6365 | Values: 377.6 384.8 386.0 387.6 400.0 17620.4 18574.8 18751.2 18775.2 18878.6 17548.6 18239.2 18279.5 18294.3 18296.9 5483.3 5767.3 5805.9 5811.9 5819.8 4287.4 6126.8 6313.8 6328.4 6389.2 6087.3 6268.0 6290.3 6313.0 6316.3 6184.9 6195.7 6239.0 6247.5 6261.4 5536.1 5537.0 5551.6 5554.6 5625.0 19855.6 20589.4 21735.8 22182.2 22372.0 2174.4 2257.5 2329.3 2361.1 2707.9 10233.4 10291.2 10321.9 12333.6 12915.2 1794.8 1943.2 1980.6 1982.9 1986.8 68580.0 70595.0 70819.6 71276.6 71366.0 10586.6 10708.8 10806.8 10816.1 10970.9 15362.0 15418.5 15456.9 15488.5 15548.4 7812.8 7913.4 7934.4 7992.3 8057.6 7481.6 7508.6 7576.7 7651.8 7697.7 4757.9 4762.4 4819.7 4841.9 4842.1 1917.3 2006.4 2041.6 2073.2 2075.9 904.3 996.2 1031.8 1052.1 1073.2 17533.4 17587.6 17606.8 17761.6 18310.4 1010.0 1010.8 1019.2 1110.5 1111.0 10372.3 10393.4 10520.3 10540.3 10550.9 409744.0 413776.0 420700.0 432177.0 432482.0 75056.6 78688.0 80774.0 80792.0 81327.6 987.4 995.1 1001.9 1010.6 1040.6 15964.2 16084.0 16206.0 16267.0 16481.3 24666.0 28654.1 33841.7 35828.9 36206.6 52143.0 52911.2 53240.5 53271.5 53431.0 8679.4 8731.8 9017.7 9036.9 9165.8 11276.9 11350.3 11580.7 11812.2 11937.6 6677.9 9967.8 10025.9 10276.9 10545.3 10609.3 10622.9 10634.9 10880.3 10908.7 10666.7 10861.2 10991.2 11099.3 11274.3 8790.0 8858.6 8964.5 9099.2 9214.3 10614.1 10656.6 10677.9 10703.6 10821.7 07:13:37 INFO - PROCESS | 6365 | 07:13:37 INFO - PROCESS | 6365 | [#3] mootools.html Cycles:180 Average:5833.75 Median:553.38 stddev:3039.97 (549.3%) stddev-sans-first:3031.73 07:13:37 INFO - PROCESS | 6365 | Values: 1585.2 1586.6 1861.1 1921.5 1950.1 7371.4 8104.6 8403.9 8595.2 8657.0 8323.6 8352.8 8382.1 8424.3 8433.0 2366.9 2393.7 2410.9 2411.5 2416.6 2308.4 2351.3 2407.8 2421.5 2423.7 2445.7 2460.6 2482.7 2488.6 2488.8 2455.3 2473.0 2479.8 2483.4 2494.7 2469.6 2487.1 2487.3 2497.5 2511.6 8432.0 8436.8 8452.9 8471.3 8494.7 5014.5 5132.4 5144.0 5148.6 5153.0 3264.8 3272.9 3318.3 3352.6 3362.8 1023.5 1069.3 1081.7 2032.3 2072.3 11330.0 11390.3 11496.3 11505.5 11510.1 4388.6 4498.3 4516.1 4542.2 4551.4 9163.2 9193.6 9218.4 9229.6 9266.1 5025.8 5027.8 5046.4 5064.7 5067.8 4062.0 4532.0 4552.1 4632.7 4692.0 3518.0 3567.6 3579.2 3586.9 3622.8 1112.1 1114.5 1125.2 1127.1 1132.3 1461.6 1462.2 1473.0 1485.8 1507.7 7870.8 7919.8 7967.8 8035.7 8098.0 546.2 548.9 557.8 560.4 562.4 6036.8 6084.4 6108.0 6114.0 6165.6 10079.6 10276.5 10354.4 10359.9 10394.8 9324.3 10107.2 10216.6 10268.9 10273.8 7890.0 7893.3 7905.2 7926.0 7968.7 7897.6 7931.6 8001.6 8114.9 8156.8 9054.4 9154.3 9257.4 9287.4 9336.7 9164.9 9229.2 9297.9 9429.7 9640.8 6409.9 7009.9 7239.0 7490.3 7630.2 7614.2 7711.3 7743.0 7770.4 7829.0 6815.6 7081.4 7082.9 7123.6 7219.0 6907.5 6910.5 6990.4 7063.8 7090.6 7498.2 7503.6 7572.0 7626.3 7647.3 7096.8 7114.8 7123.9 7129.7 7139.1 6843.7 7079.0 7102.0 7120.2 7194.2 07:13:37 INFO - PROCESS | 6365 | 07:13:37 INFO - PROCESS | 6365 | [#4] prototype.html Cycles:180 Average:5629.34 Median:6411.40 stddev:1703.01 (26.6%) stddev-sans-first:1660.97 07:13:37 INFO - PROCESS | 6365 | Values: 345.8 351.2 360.5 367.3 369.5 6144.0 6170.3 6200.9 6229.9 6235.8 6213.9 6218.8 6221.9 6255.5 6272.1 4916.1 4918.6 4922.4 4924.2 4935.0 4918.4 4923.4 4933.9 4942.9 4946.0 4891.4 4894.0 4901.2 4904.3 4913.0 4626.2 4838.0 4848.8 4906.6 4908.0 4173.0 4182.0 4188.5 4191.2 4199.5 5863.5 5864.3 5872.7 5874.4 5887.4 5437.8 5559.4 5594.4 5598.3 5601.7 6506.7 6557.6 6567.7 6591.6 6595.4 4653.7 4658.6 4661.6 4664.7 4668.3 6865.3 6869.7 6894.3 6935.3 6940.3 4768.2 4781.6 4782.0 4794.2 4798.7 4705.7 4825.2 4834.8 4852.8 4860.1 5547.3 5548.6 5580.2 5581.2 5587.9 6636.6 6647.6 6652.7 6674.7 6683.1 1699.1 1711.2 1719.2 1722.2 1723.6 1104.3 1136.9 1143.4 1152.4 1153.8 6410.9 6484.6 6646.6 6691.3 6696.1 6914.6 6959.1 6961.2 7040.2 7059.4 6624.4 6657.3 6659.8 6672.2 6694.6 3725.7 3748.8 3758.0 3758.8 3768.8 7184.9 7414.5 7421.6 7431.1 7434.5 7093.1 7104.6 7120.4 7138.4 7166.3 7384.5 7385.5 7389.4 7391.9 7424.1 6841.8 6868.9 6910.0 6925.5 6935.7 6679.4 6835.4 6860.8 6927.7 6944.3 7362.6 7367.3 7390.8 7399.3 7452.6 4651.8 4710.0 4718.6 4730.5 4732.6 6870.6 6903.2 6908.0 6912.7 6925.0 6529.3 6685.6 6716.1 6731.7 6743.4 6687.8 6706.7 6716.7 6717.9 6746.1 6543.8 6581.0 6583.6 6584.9 6596.1 6707.8 6707.8 6725.1 6749.3 6765.5 6411.9 6469.4 6550.2 6557.8 6585.9 07:13:37 INFO - PROCESS | 6365 | 07:13:37 INFO - PROCESS | 6365 | [#5] yui.html Cycles:180 Average:14158.33 Median:25664.61 stddev:16298.65 (63.5%) stddev-sans-first:16313.29 07:13:37 INFO - PROCESS | 6365 | Values: 755.5 767.3 783.0 871.1 896.3 13827.2 13969.2 14032.0 14103.4 14131.2 12831.4 12931.4 12953.2 12963.0 12963.4 767.9 912.5 923.2 926.0 929.4 909.6 912.2 918.1 918.4 922.2 950.5 956.0 959.0 960.5 981.6 951.3 952.4 953.9 955.4 960.9 713.2 716.2 718.1 721.7 724.2 12700.3 12751.9 12773.9 13080.9 13117.2 13068.3 13350.9 13494.1 13548.0 13621.3 11240.8 11249.0 11389.4 11570.1 11596.9 3940.6 3950.6 3960.7 3997.2 4059.7 49203.0 49840.8 49933.5 50674.7 51983.7 9550.1 9572.2 9638.9 9864.8 10019.1 16773.9 16932.2 18751.8 19023.4 19058.9 7939.2 8011.8 8058.6 8081.2 8123.8 4429.4 4470.7 4476.6 4618.5 4670.2 3206.9 3215.1 3217.9 3219.5 3239.7 583.6 600.3 602.4 608.0 620.9 641.8 667.1 678.5 678.8 687.1 7197.2 7439.5 7460.1 7703.6 7774.5 524.8 560.2 635.7 665.8 673.2 3597.6 3649.4 3732.1 3846.5 3916.4 55651.7 56230.4 56244.7 56372.7 56469.0 51731.5 51912.0 52685.5 53005.2 53852.7 48175.8 48231.5 48350.3 48567.0 49255.5 8505.1 8562.2 8584.5 8665.5 8671.0 36463.1 36834.3 37277.3 37355.0 37651.6 42544.0 45550.5 46545.8 46659.0 46917.8 11265.7 11628.8 11691.8 11720.6 11973.0 11894.5 12755.4 12844.0 13092.7 13134.7 11973.5 12196.2 12294.7 12334.7 12572.3 10733.6 10804.3 10840.1 11066.2 11149.4 11553.7 11803.5 12165.1 12170.8 12258.4 9540.3 10293.8 10309.2 10563.5 10589.3 9841.0 9992.2 10193.7 10249.7 10486.6 07:13:37 INFO - PROCESS | 6365 | -------- Summary: end -------- 07:13:37 INFO - PROCESS | 6365 | 07:13:38 INFO - TEST-INFO | 6365: exit 0 07:13:38 INFO - TEST-OK | dromaeo_css | took 1108941ms 07:13:38 INFO - TEST-START | kraken 07:13:38 INFO - operating with platform_type : linux_ 07:13:38 INFO - Initialising browser for kraken test... 07:13:38 INFO - TEST-INFO | started process 6609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgTFYT8/profile http://localhost:52332/getInfo.html) 07:13:41 INFO - PROCESS | 6609 | 07:13:41 INFO - PROCESS | 6609 | (process:6682): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:13:42 INFO - PROCESS | 6609 | __metrics Screen width/height:1600/1200 07:13:42 INFO - PROCESS | 6609 | colorDepth:24 07:13:42 INFO - PROCESS | 6609 | Browser inner width/height: 1024/697 07:13:42 INFO - PROCESS | 6609 | __metrics 07:13:42 ERROR - PROCESS | 6609 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 07:13:43 INFO - TEST-INFO | 6609: exit 0 07:13:43 INFO - Browser initialized. 07:13:43 INFO - Running cycle 1/1 for kraken test... 07:13:43 INFO - TEST-INFO | started process 6733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgTFYT8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:45 INFO - PROCESS | 6733 | 07:13:45 INFO - PROCESS | 6733 | (process:6801): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:13:55 INFO - PROCESS | 6733 | RSS: Main: 150794240 07:13:55 INFO - PROCESS | 6733 | 07:13:57 INFO - PROCESS | 6733 | Cycle 1(1): loaded http://localhost:52332/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52332/tests/kraken/driver.html?testName=audio-beat-detection) 07:13:58 INFO - PROCESS | 6733 | RSS: Main: 156278784 07:13:58 INFO - PROCESS | 6733 | 07:14:01 INFO - PROCESS | 6733 | Cycle 1(1): loaded http://localhost:52332/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52332/tests/kraken/driver.html?testName=audio-dft) 07:14:01 INFO - PROCESS | 6733 | RSS: Main: 156266496 07:14:01 INFO - PROCESS | 6733 | 07:14:04 INFO - PROCESS | 6733 | Cycle 1(1): loaded http://localhost:52332/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52332/tests/kraken/driver.html?testName=audio-fft) 07:14:05 INFO - PROCESS | 6733 | RSS: Main: 156639232 07:14:05 INFO - PROCESS | 6733 | 07:14:07 INFO - PROCESS | 6733 | Cycle 1(1): loaded http://localhost:52332/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52332/tests/kraken/driver.html?testName=audio-oscillator) 07:14:07 INFO - PROCESS | 6733 | RSS: Main: 156794880 07:14:07 INFO - PROCESS | 6733 | 07:14:10 INFO - PROCESS | 6733 | Cycle 1(1): loaded http://localhost:52332/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52332/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:14:10 INFO - PROCESS | 6733 | RSS: Main: 156745728 07:14:10 INFO - PROCESS | 6733 | 07:14:13 INFO - PROCESS | 6733 | Cycle 1(1): loaded http://localhost:52332/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52332/tests/kraken/driver.html?testName=imaging-darkroom) 07:14:14 INFO - PROCESS | 6733 | RSS: Main: 156631040 07:14:14 INFO - PROCESS | 6733 | 07:14:17 INFO - PROCESS | 6733 | Cycle 1(1): loaded http://localhost:52332/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52332/tests/kraken/driver.html?testName=imaging-desaturate) 07:14:18 INFO - PROCESS | 6733 | RSS: Main: 156889088 07:14:18 INFO - PROCESS | 6733 | 07:14:21 INFO - PROCESS | 6733 | Cycle 1(1): loaded http://localhost:52332/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52332/tests/kraken/driver.html?testName=json-parse-financial) 07:14:21 INFO - PROCESS | 6733 | RSS: Main: 157040640 07:14:21 INFO - PROCESS | 6733 | 07:14:23 INFO - PROCESS | 6733 | Cycle 1(1): loaded http://localhost:52332/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52332/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:14:23 INFO - PROCESS | 6733 | RSS: Main: 156717056 07:14:23 INFO - PROCESS | 6733 | 07:14:25 INFO - PROCESS | 6733 | Cycle 1(1): loaded http://localhost:52332/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52332/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:14:26 INFO - PROCESS | 6733 | RSS: Main: 156778496 07:14:26 INFO - PROCESS | 6733 | 07:14:28 INFO - PROCESS | 6733 | Cycle 1(1): loaded http://localhost:52332/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52332/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:14:28 INFO - PROCESS | 6733 | RSS: Main: 157179904 07:14:28 INFO - PROCESS | 6733 | 07:14:31 INFO - PROCESS | 6733 | Cycle 1(1): loaded http://localhost:52332/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:14:31 INFO - PROCESS | 6733 | RSS: Main: 157175808 07:14:31 INFO - PROCESS | 6733 | 07:14:34 INFO - PROCESS | 6733 | Cycle 1(1): loaded http://localhost:52332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:14:35 INFO - PROCESS | 6733 | RSS: Main: 157122560 07:14:35 INFO - PROCESS | 6733 | 07:14:36 INFO - PROCESS | 6733 | Cycle 1(1): loaded http://localhost:52332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52332/tests/kraken/driver.html?testName=ai-astar) 07:14:37 INFO - PROCESS | 6733 | RSS: Main: 158834688 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | __start_tp_report 07:14:37 INFO - PROCESS | 6733 | _x_x_mozilla_page_load 07:14:37 INFO - PROCESS | 6733 | _x_x_mozilla_page_load_details 07:14:37 INFO - PROCESS | 6733 | |i|pagename|runs| 07:14:37 INFO - PROCESS | 6733 | |0;ai-astar;112;104;112;109;111;122;111;109;109;110 07:14:37 INFO - PROCESS | 6733 | |1;audio-beat-detection;161;136;155;161;132;156;155;128;177;129 07:14:37 INFO - PROCESS | 6733 | |2;audio-dft;163;161;161;162;164;163;162;163;165;162 07:14:37 INFO - PROCESS | 6733 | |3;audio-fft;76;76;75;164;77;76;76;76;163;76 07:14:37 INFO - PROCESS | 6733 | |4;audio-oscillator;93;93;149;92;93;93;146;93;95;145 07:14:37 INFO - PROCESS | 6733 | |5;imaging-gaussian-blur;117;118;118;118;117;118;117;117;118;117 07:14:37 INFO - PROCESS | 6733 | |6;imaging-darkroom;147;148;147;147;148;148;151;148;148;147 07:14:37 INFO - PROCESS | 6733 | |7;imaging-desaturate;97;97;97;97;96;96;97;95;96;96 07:14:37 INFO - PROCESS | 6733 | |8;json-parse-financial;57;56;56;55;55;54;57;64;54;57 07:14:37 INFO - PROCESS | 6733 | |9;json-stringify-tinderbox;68;65;66;66;65;65;65;67;66;65 07:14:37 INFO - PROCESS | 6733 | |10;stanford-crypto-aes;78;79;80;81;79;78;79;79;80;79 07:14:37 INFO - PROCESS | 6733 | |11;stanford-crypto-ccm;113;115;116;112;131;113;120;115;119;113 07:14:37 INFO - PROCESS | 6733 | |12;stanford-crypto-pbkdf2;147;150;160;149;143;136;150;146;146;152 07:14:37 INFO - PROCESS | 6733 | |13;stanford-crypto-sha256-iterative;80;71;70;69;69;67;67;67;67;66 07:14:37 INFO - PROCESS | 6733 | __end_tp_report 07:14:37 INFO - PROCESS | 6733 | __start_cc_report 07:14:37 INFO - PROCESS | 6733 | _x_x_mozilla_cycle_collect,825 07:14:37 INFO - PROCESS | 6733 | __end_cc_report 07:14:37 INFO - PROCESS | 6733 | __startTimestamp1460643276994__endTimestamp 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | ------- Summary: start ------- 07:14:37 INFO - PROCESS | 6733 | Number of tests: 14 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:4.53 (4.1%) stddev-sans-first:4.79 07:14:37 INFO - PROCESS | 6733 | Values: 112.0 104.0 112.0 109.0 111.0 122.0 111.0 109.0 109.0 110.0 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:155.50 stddev:16.64 (10.7%) stddev-sans-first:17.07 07:14:37 INFO - PROCESS | 6733 | Values: 161.0 136.0 155.0 161.0 132.0 156.0 155.0 128.0 177.0 129.0 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 07:14:37 INFO - PROCESS | 6733 | Values: 163.0 161.0 161.0 162.0 164.0 163.0 162.0 163.0 165.0 162.0 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:36.90 (48.5%) stddev-sans-first:38.59 07:14:37 INFO - PROCESS | 6733 | Values: 76.0 76.0 75.0 164.0 77.0 76.0 76.0 76.0 163.0 76.0 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:93.00 stddev:25.88 (27.8%) stddev-sans-first:26.78 07:14:37 INFO - PROCESS | 6733 | Values: 93.0 93.0 149.0 92.0 93.0 93.0 146.0 93.0 95.0 145.0 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:14:37 INFO - PROCESS | 6733 | Values: 117.0 118.0 118.0 118.0 117.0 118.0 117.0 117.0 118.0 117.0 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.20 (0.8%) stddev-sans-first:1.22 07:14:37 INFO - PROCESS | 6733 | Values: 147.0 148.0 147.0 147.0 148.0 148.0 151.0 148.0 148.0 147.0 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 07:14:37 INFO - PROCESS | 6733 | Values: 97.0 97.0 97.0 97.0 96.0 96.0 97.0 95.0 96.0 96.0 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.50 stddev:2.88 (5.1%) stddev-sans-first:3.05 07:14:37 INFO - PROCESS | 6733 | Values: 57.0 56.0 56.0 55.0 55.0 54.0 57.0 64.0 54.0 57.0 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:0.73 07:14:37 INFO - PROCESS | 6733 | Values: 68.0 65.0 66.0 66.0 65.0 65.0 65.0 67.0 66.0 65.0 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:0.92 (1.2%) stddev-sans-first:0.87 07:14:37 INFO - PROCESS | 6733 | Values: 78.0 79.0 80.0 81.0 79.0 78.0 79.0 79.0 80.0 79.0 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:115.50 stddev:5.68 (4.9%) stddev-sans-first:5.86 07:14:37 INFO - PROCESS | 6733 | Values: 113.0 115.0 116.0 112.0 131.0 113.0 120.0 115.0 119.0 113.0 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:149.50 stddev:6.21 (4.2%) stddev-sans-first:6.58 07:14:37 INFO - PROCESS | 6733 | Values: 147.0 150.0 160.0 149.0 143.0 136.0 150.0 146.0 146.0 152.0 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - PROCESS | 6733 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:4.08 (5.9%) stddev-sans-first:1.69 07:14:37 INFO - PROCESS | 6733 | Values: 80.0 71.0 70.0 69.0 69.0 67.0 67.0 67.0 67.0 66.0 07:14:37 INFO - PROCESS | 6733 | -------- Summary: end -------- 07:14:37 INFO - PROCESS | 6733 | 07:14:37 INFO - TEST-INFO | 6733: exit 0 07:14:38 INFO - TEST-OK | kraken | took 59925ms 07:14:38 INFO - SUITE-END | took 1168s 07:14:38 INFO - Completed test suite (00:19:28) 07:14:38 INFO - javascript benchmark 07:14:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3331.9833400833, 3393.881214157504, 3418.2479854432017, 3419.0, 3421.7433692473055, 5477.698726570042, 5500.037493438652, 5508.55931525478, 5523.6409633373805, 5547.6671399716, 5383.380911195214, 5418.241446197536, 5434.83695489136, 5484.067708489556, 5484.177373393993, 5027.924581131286, 5033.496650334965, 5082.0598189334905, 5086.516780905808, 5160.509751573613, 4932.136876046696, 5034.82378116766, 5149.124648809711, 5165.509276618715, 5172.8706782330555, 5067.670601410915, 5072.594192464612, 5144.974275128619, 5164.664296820713, 5172.689638621695, 5123.282740416326, 5140.049090918192, 5148.099082660557, 5151.0, 5167.457416971239, 4818.566329030404, 4894.8042078317185, 4973.701577905337, 5027.0, 5088.618353623493, 5178.326817513699, 5202.843914682566, 5218.295530103425, 5234.895302093975, 5257.4742525747115, 5874.1776151338845, 5919.585629005971, 5932.7330270137945, 5935.465808077293, 5949.107633854913, 5765.913511297292, 5937.317208521033, 5973.790917317873, 5993.700314984277, 6012.879742405171, 5455.263539422207, 5506.1190209566275, 5514.476124768141, 5515.117581186991, 5529.0, 5853.122031695195, 5917.31950825652, 5974.820755377345, 5999.190109335271, 6011.158437818709, 5783.306003279633, 5800.796972106041, 5803.709814509258, 5821.446962538552, 5858.443447872445, 5891.7054147292465, 5924.11138329254, 5924.348321684612, 5935.554833387513, 5952.226210592596, 5734.369219385864, 5847.736851841677, 5858.502027327725, 5873.911891321633, 5900.350961394243, 5955.196048533479, 5965.642061476238, 5965.880682386328, 5971.701414929236, 6006.879862402728, 4541.091781643684, 4544.3198498207585, 4548.522405147478, 4549.886252843706, 4580.24425969718, 4002.6197511236387, 4075.3683179107284, 4092.7748973806133, 4108.096218831853, 4151.294279972412, 5658.462446067617, 5775.249217601685, 5820.854478637983, 5874.73563689635, 5878.823635290948, 5844.415558444207, 5908.527317814564, 5957.434043765836, 5973.49225315853, 5976.61152025117, 5589.469000444951, 5729.083346664597, 5747.339056008529, 5757.942420575824, 5778.913316300259, 5158.690478571298, 5173.094708426011, 5185.429602743695, 5190.714510701872, 5215.0, 6256.593321434092, 6261.342559031327, 6262.780802671885, 6268.0, 6272.811815645447, 5745.540356771365, 5927.9703601481715, 5943.138244954371, 5953.761849526057, 5967.075103358986, 6214.974529202812, 6243.001119820807, 6293.842653933688, 6298.11826344303, 6301.96849015752, 5869.325027621708, 5874.17761513397, 5874.794382196603, 5877.73550190251, 5911.172435858897, 5647.717614119196, 5898.3216930053595, 5924.763009479572, 5968.432998865101, 5992.460678538952, 5769.59612827098, 5780.537556995514, 5802.158686990447, 5802.738876750472, 5831.679257640871, 5852.619579727304, 5854.736536855937, 5861.6189947653265, 5863.589548731718, 5877.294724633071, 5444.891102177855, 5709.429057094258, 5761.0, 5770.394108618535, 5779.8555036124435, 5802.1296805479515, 5808.186853840551, 5823.970880145572, 5855.8536036597725, 5869.236999190249, 5545.916811247916, 5682.943170568242, 5706.857328566819, 5712.828615141552, 5744.0], "unit": "score", "name": "dojo.html", "value": 5482.427369715321}, {"lowerIsBetter": false, "replicates": [554.226853539313, 567.5289509706944, 575.1670902758168, 578.412910895441, 619.9999999999999, 41621.0, 42611.573884261146, 42747.78626106865, 42813.99999999996, 42830.7858460708, 43755.78122109385, 44226.778866105626, 44743.32885006719, 44771.328430073576, 44832.55167448324, 8663.263622592087, 8890.86663700045, 8910.242629376511, 8926.419782714103, 8978.595963181673, 8758.868616970718, 8851.893513310835, 8892.110788921122, 8929.241014513775, 8943.239824614915, 8900.465972041698, 8909.68816091437, 8970.955145224265, 8971.192592666659, 8987.415817971843, 8880.644774209057, 8931.64273429062, 8940.642374305053, 8971.955140224323, 8977.955110224473, 8780.868286975701, 8866.113388661146, 8888.466691998501, 8894.4663320201, 8895.79906712592, 34488.82755586231, 40395.39406908899, 40887.38668919969, 40968.38547421791, 40977.59022409767, 3509.3683137035323, 3617.5839778425557, 3744.794036328001, 3798.8670396536263, 3864.864729734446, 28995.565066524017, 29321.41357172866, 29810.552841707176, 30002.549961750592, 30059.0, 4035.717499775017, 4104.856330028435, 4113.732607380541, 4147.108371700068, 4152.6055024772595, 199898.0, 200870.0, 201803.0, 201855.0, 201936.0, 60113.0, 60345.396546034855, 60422.09366859501, 60675.393246066975, 61096.38903610907, 73013.26986730171, 73350.63324683449, 73664.26335736681, 73769.0, 73937.63031184918, 15978.60053498672, 16114.355425782838, 16214.0, 16329.51011469634, 16405.42581009683, 12663.113582049167, 12793.808092878615, 12885.0, 12909.419076141596, 12975.09174357786, 22145.77854221437, 22518.887405563197, 22724.545509089727, 22805.88597057004, 22953.655695164587, 8231.629576669064, 8319.33613277335, 8363.665453381796, 8562.100979397199, 8737.257333126756, 1020.7090979070929, 1057.6298295596634, 1135.625243669587, 1155.1913660437726, 1215.489494412349, 29339.0, 29415.705842941297, 29657.0, 30163.245918851764, 30325.696743032728, 1165.1901928159848, 1171.2796630072614, 1224.1981502116128, 1227.1655274413306, 1232.48235740989, 15371.231438428258, 15811.841881581267, 16078.276477558538, 16158.838411615969, 16159.272832722556, 317633.0, 491349.0, 504036.0, 509127.0, 512375.0, 54907.45092549103, 55942.44057559453, 55946.720266398406, 56006.0, 56258.0, 1479.4895760962452, 1479.9926000369715, 1507.1785876697227, 1510.8942374033932, 1513.3038802150913, 29581.704182957896, 31184.22039449032, 31288.460001598083, 31702.682973169973, 32019.67980320167, 47781.52218477771, 48781.0, 49002.509974899796, 49013.509864900894, 49020.26469602888, 310466.0, 310817.0, 311223.0, 313457.0, 314424.0, 34389.14027149241, 50986.23520647267, 51207.48792512027, 51721.96556068782, 52092.73953630359, 46847.29729053999, 47343.28985065158, 47522.52477475319, 47575.52424475711, 48054.0, 39323.0, 39434.80282598684, 39798.01009949433, 40425.1914961705, 40514.79742601268, 39170.41244381393, 39306.86379714629, 39705.40441893316, 39746.80126599348, 39759.2048159041, 38782.224355513295, 39179.60820391874, 39675.0, 39928.60071399249, 39981.2003759929, 34037.0, 34707.65292347044, 34961.65038349685, 34994.0, 35107.29785404226, 26909.461810764067, 27119.322016949733, 27134.864325678245, 27259.86370068137, 27374.589381159698], "unit": "score", "name": "ext.html", "value": 19941.96504002307}, {"lowerIsBetter": false, "replicates": [377.6469001483612, 384.79413513770123, 386.01373490731186, 387.5910913985744, 400.0139655748583, 17620.383286584973, 18574.81425185748, 18751.249950002017, 18775.155118019688, 18878.622427551458, 17548.56128596786, 18239.17923693434, 18279.451616451493, 18294.268229270845, 18296.90851545744, 5483.341998960121, 5767.336756273019, 5805.941940580604, 5811.941880581204, 5819.7963071292515, 4287.442632457776, 6126.7855625053135, 6313.77901773438, 6328.367163283658, 6389.1694079769795, 6087.3303936566945, 6267.968660156693, 6290.339514350996, 6313.0, 6316.305206427312, 6184.938150618504, 6195.690215489208, 6239.0, 6247.531435142382, 6261.405166509197, 5536.114221724505, 5536.972315138399, 5551.583631227633, 5554.555635549146, 5625.0, 19855.60288794216, 20589.38231853047, 21735.782642173694, 22182.223622173147, 22372.0, 2174.358564223558, 2257.4582100295975, 2329.3477826208687, 2361.1027809432476, 2707.9323016924536, 10233.437160956144, 10291.228157888188, 10321.948390258001, 12333.568325108577, 12915.160514566523, 1794.8205179482077, 1943.2129987355145, 1980.6137803128395, 1982.9206831726713, 1986.7715212750575, 68580.0, 70595.0, 70819.64590177068, 71276.64361678158, 71366.0, 10586.629467968583, 10708.78582428347, 10806.78386432267, 10816.080633146114, 10970.890291096986, 15362.0, 15418.537443876701, 15456.918015739015, 15488.535343939475, 15548.378064877279, 7812.804679882935, 7913.406494512935, 7934.365250780039, 7992.320652744582, 8057.637406316612, 7481.551106933602, 7508.62456877154, 7576.7348142814735, 7651.770446886602, 7697.730579429693, 4757.881052973703, 4762.404699412574, 4819.734914579732, 4841.8547443576745, 4842.055799119138, 1917.3289348727833, 2006.3579654510418, 2041.6427125253022, 2073.2225415469197, 2075.941269952335, 904.3217586809892, 996.2478328861808, 1031.8194315994672, 1052.1004541117234, 1073.1897417449775, 17533.386331478338, 17587.56031099207, 17606.823931760773, 17761.555961101076, 18310.359137430125, 1009.9545520451597, 1010.7725761703705, 1019.1577751875536, 1110.4669758515959, 1110.9944450277696, 10372.27394082407, 10393.37639741618, 10520.26358154937, 10540.262181647211, 10550.894491055145, 409744.0, 413776.0, 420700.0, 432177.0, 432482.0, 75056.62471687715, 78688.0, 80774.0, 80792.0, 81327.593362034, 987.3976874106789, 995.0944640377367, 1001.8747656542932, 1010.6058637131524, 1040.5837664934088, 15964.20178991069, 16084.0, 16206.0, 16267.0, 16481.34074637001, 24666.0, 28654.14037578876, 33841.66158338385, 35828.92513224608, 36206.637933620324, 52143.0, 52911.20633190582, 53240.46759532355, 53271.46728532665, 53431.0, 8679.435836670596, 8731.825363492822, 9017.729468115967, 9036.909630903607, 9165.77085572866, 11276.94361528187, 11350.262232955161, 11580.710482238012, 11812.232204906997, 11937.641870743892, 6677.933220667731, 9967.754030746157, 10025.899741002788, 10276.948615256875, 10545.261831671709, 10609.310394824312, 10622.89377106219, 10634.946825265824, 10880.292780969212, 10908.672739817817, 10666.73333166646, 10861.239713219999, 10991.175661825555, 11099.334039957628, 11274.323540587591, 8790.0, 8858.557072146237, 8964.462132272085, 9099.226565741987, 9214.2628589714, 10614.097801686943, 10656.62701805433, 10677.9466102669, 10703.571857125939, 10821.729456763644], "unit": "score", "name": "jquery.html", "value": 8893.286707107254}, {"lowerIsBetter": false, "replicates": [1585.151943710115, 1586.6112802363423, 1861.0880668472444, 1921.5100149461884, 1950.0639692947393, 7371.373433258166, 8104.635291411886, 8403.91596084039, 8595.226429621332, 8657.047724750273, 8323.62543685534, 8352.791180220498, 8382.077971423154, 8424.326053915687, 8433.0, 2366.8816559172014, 2393.7366889642126, 2410.915617953372, 2411.5176964607062, 2416.6254230594286, 2308.3882771065682, 2351.27110595715, 2407.807375409963, 2421.4551725861716, 2423.7455067217866, 2445.6576079348906, 2460.6432067350224, 2482.726900041003, 2488.639147323637, 2488.825782195247, 2455.312512496486, 2473.010795681733, 2479.776820086192, 2483.428811373376, 2494.675692160026, 2469.6172093325563, 2487.0797804812155, 2487.3035550046015, 2497.4880149569294, 2511.5855883779154, 8432.0, 8436.83126337476, 8452.8732069019, 8471.279941205004, 8494.660213591449, 5014.52362025607, 5132.435432102466, 5143.996920600484, 5148.613853960968, 5153.0, 3264.836758162106, 3272.918177045569, 3318.2533929865826, 3352.580927384077, 3362.798232106057, 1023.4801320039735, 1069.3476979042778, 1081.7073597051526, 2032.3090149349143, 2072.285061653727, 11330.0, 11390.316581005167, 11496.252743571642, 11505.539778408853, 11510.136739744552, 4388.626966707801, 4498.347739577743, 4516.051629157913, 4542.159700455426, 4551.431071116111, 9163.221126204215, 9193.63225470987, 9218.354715169873, 9229.630814767468, 9266.11971862672, 5025.84922452327, 5027.798888044437, 5046.369203849519, 5064.670796398296, 5067.847964561069, 4061.9593804061583, 4531.954680453153, 4552.0668263006, 4632.675712700146, 4692.0381321828945, 3517.982410087933, 3567.5897271813556, 3579.2483578448296, 3586.874459393961, 3622.7826330420257, 1112.1103117506125, 1114.4650567727535, 1125.2123513540555, 1127.075797845775, 1132.2810015639964, 1461.5761429185418, 1462.203099310878, 1472.955811325662, 1485.7919891215238, 1507.6833864888497, 7870.803229919298, 7919.802004949923, 7967.8406431871035, 8035.718749843727, 8098.0, 546.1698218707543, 548.9295873047494, 557.8326502049368, 560.4283630696666, 562.3561022629067, 6036.788712395133, 6084.361142080106, 6107.96946015276, 6114.021756519024, 6165.599236049732, 10079.596816127272, 10276.486175691334, 10354.378737275787, 10359.896401036043, 10394.792104157874, 9324.347295689236, 10107.241956853266, 10216.591336346612, 10268.948655256825, 10273.794524109477, 7890.0, 7893.329067029367, 7905.169957154531, 7926.048874135141, 7968.721094761656, 7897.565633890191, 7931.5637639928045, 8001.599920004093, 8114.918850811652, 8156.755297341089, 9054.411463254868, 9154.313426493172, 9257.398269112486, 9287.442753434816, 9336.673216437392, 9164.862527061967, 9229.169374756304, 9297.86053209216, 9429.669961551313, 9640.807183856143, 6409.9359006411205, 7009.859802803813, 7238.963805180941, 7490.288422599844, 7630.1606823248285, 7614.16244213125, 7711.305982461606, 7743.032120984877, 7770.378369730295, 7829.0, 6815.556988795713, 7081.433485321265, 7082.858342833218, 7123.643817808985, 7219.025431566672, 6907.516473846984, 6910.516263861682, 6990.440764738707, 7063.82340441493, 7090.64546772649, 7498.175200727806, 7503.587302698404, 7572.0, 7626.275503827128, 7647.273509016634, 7096.7516136934955, 7114.750983715545, 7123.928760712534, 7129.679164437716, 7139.071920650283, 6843.726250949906, 7078.964605176941, 7102.041224434842, 7120.181179164462, 7194.2086370498155], "unit": "score", "name": "mootools.html", "value": 4749.126059867453}, {"lowerIsBetter": false, "replicates": [345.751059237349, 351.1834983662984, 360.5385107062959, 367.2654690618763, 369.4808793644929, 6144.047672610742, 6170.290416602092, 6200.906986395207, 6229.906551401727, 6235.7505699771955, 6213.94362958297, 6218.81343559694, 6221.875562488747, 6255.468285195764, 6272.059191121322, 4916.065947469987, 4918.631102667314, 4922.409310882699, 4924.236743304785, 4935.012997400517, 4918.434380046287, 4923.384576927884, 4933.876653083666, 4942.912559236962, 4946.0107978404285, 4891.388576427947, 4894.045661096087, 4901.191303434929, 4904.337914381566, 4913.041956818422, 4626.21354369758, 4837.951620483803, 4848.806047758086, 4906.558409743105, 4907.975460122694, 4173.0, 4181.958180418187, 4188.476440444944, 4191.1827193697245, 4199.517055538621, 5863.4722874941035, 5864.325602555676, 5872.677002764846, 5874.353821079721, 5887.4406931341455, 5437.809676661337, 5559.444055594448, 5594.384617692051, 5598.300212473441, 5601.691906945116, 6506.707198176094, 6557.573757705733, 6567.737290508374, 6591.571547849375, 6595.439387652055, 4653.7440440775745, 4658.627309815207, 4661.557152070548, 4664.696794708333, 4668.253079507296, 6865.27914568968, 6869.725210991554, 6894.276101009372, 6935.271796461399, 6940.340667636567, 4768.237082066853, 4781.641376896747, 4781.95218047822, 4794.232922732346, 4798.688085274446, 4705.670603057822, 4825.227963525819, 4834.7824347904425, 4852.781624826891, 4860.052289803454, 5547.306586676666, 5548.611597188158, 5580.19087232349, 5581.2186293918885, 5587.8882422352135, 6636.568623039487, 6647.60114393138, 6652.667366631649, 6674.698433805458, 6683.131192944886, 1699.1419333236636, 1711.1786342555642, 1719.1919797695064, 1722.1733567887234, 1723.6035711786108, 1104.276698762312, 1136.8749437561862, 1143.4168574027306, 1152.4180288954024, 1153.7692461507731, 6410.871782564416, 6484.610923344614, 6646.634435106019, 6691.297413771581, 6696.06255124283, 6914.585124892523, 6959.09531760878, 6961.164660240804, 7040.155181378165, 7059.435245180373, 6624.436922861514, 6657.3342665733035, 6659.766908158192, 6672.165979252593, 6694.631795251308, 3725.739198256096, 3748.756330838487, 3758.0, 3758.830852611639, 3768.7927164005696, 7184.928150718531, 7414.480986331013, 7421.554706717507, 7431.108267007994, 7434.516756410816, 7093.077899872984, 7104.609246491389, 7120.394766444911, 7138.393236574845, 7166.283371662792, 7384.5200061996875, 7385.483016188923, 7389.371903388273, 7391.926080739124, 7424.109106907205, 6841.794746157623, 6868.896966545606, 6909.965450172717, 6925.480588955747, 6935.687894044881, 6679.432248258758, 6835.384815366641, 6860.794176174722, 6927.7228910843005, 6944.305569443015, 7362.595057271901, 7367.300106490089, 7390.815229619087, 7399.297066778648, 7452.552846829208, 4651.837185698484, 4710.0, 4718.598919091778, 4730.47964723887, 4732.574068333866, 6870.587764734132, 6903.206131294965, 6908.0, 6912.723491060502, 6925.030495730501, 6529.281779004211, 6685.63229022389, 6716.059751634677, 6731.663416829041, 6743.393094621508, 6687.832804179934, 6706.731730730716, 6716.6902454021, 6717.9328206719265, 6746.123004009447, 6543.770968016097, 6581.0, 6583.63789991555, 6584.868302634016, 6596.142501474777, 6707.765228217184, 6707.798766037026, 6725.058491811053, 6749.257581666111, 6765.458763299022, 6411.935880641134, 6469.417752402306, 6550.181227346582, 6557.836054098686, 6585.901211481927], "unit": "score", "name": "prototype.html", "value": 5077.145079932192}, {"lowerIsBetter": false, "replicates": [755.5126943121687, 767.3400875247287, 782.9686812527498, 871.0592560035162, 896.3143195455474, 13827.170369777808, 13969.23169225691, 14032.0, 14103.435862565499, 14131.152130872155, 12831.42258598363, 12931.35343232837, 12953.158044727086, 12963.0, 12963.416646250918, 767.9270469305407, 912.4798864647154, 923.2383283790866, 925.9999200863085, 929.4005366538579, 909.586138307072, 912.2382810353363, 918.1186061381048, 918.3892711346946, 922.1608336413865, 950.4582388038821, 956.0439560439561, 958.9856152157723, 960.5341409416427, 981.6220755009338, 951.3007939164778, 952.3524003677531, 953.9427634341962, 955.3837774635356, 960.9375390599623, 713.1940906775311, 716.183550752143, 718.0987860235423, 721.678852910455, 724.1527412926888, 12700.301483418409, 12751.936240318832, 12773.872261277362, 13080.86919130806, 13117.212967221998, 13068.346582670829, 13350.933245333808, 13494.055416120875, 13548.0, 13621.25083120428, 11240.775184496346, 11249.0, 11389.373584452851, 11570.074394048455, 11596.94201528987, 3940.645341919241, 3950.5851885551892, 3960.6633436157963, 3997.2205419943125, 4059.7158198926086, 49203.0, 49840.750796246146, 49933.50066499325, 50674.746626267, 51983.74008129935, 9550.140487356171, 9572.186364159124, 9638.855417168748, 9864.802703945881, 10019.148372388428, 16773.91613041927, 16932.23804928781, 18751.812481875008, 19023.429297121107, 19058.904705476383, 7939.20607939213, 8011.839763204704, 8058.556779377191, 8081.191880811989, 8123.796905077302, 4429.424174857248, 4470.664700147502, 4476.597106260452, 4618.49196588375, 4670.229412146958, 3206.8556914938886, 3215.099772063826, 3217.9195520112185, 3219.4687876500584, 3239.7408207343356, 583.585654185533, 600.2946537818046, 602.3524710935761, 608.0180508478863, 620.8509957610141, 641.7850020243177, 667.0960848050821, 678.5352033856824, 678.7556479667315, 687.0998991321385, 7197.244289349647, 7439.51643143194, 7460.1047874254355, 7703.576303303372, 7774.533527988226, 524.8477941396952, 560.246468499867, 635.7393468677819, 665.8368699668612, 673.175360183771, 3597.568291804948, 3649.39784935488, 3732.0989440185353, 3846.538415390171, 3916.373380259145, 55651.72174139103, 56230.43769562252, 56244.71877640668, 56372.71813640987, 56469.0, 51731.48268517267, 51912.0, 52685.47314526806, 53005.204921926204, 53852.730736346064, 48175.759121204166, 48231.517684823404, 48350.27474587884, 48567.0, 49255.50744492509, 8505.06444291115, 8562.229399353839, 8584.527850968258, 8665.480071195749, 8671.0, 36463.088422789646, 36834.26331473302, 37277.25445491129, 37355.0, 37651.623483764815, 42544.0, 45550.54449455596, 46545.76727116343, 46659.0, 46917.765411172724, 11265.71835704114, 11628.825567616661, 11691.766164676488, 11720.648380548597, 11973.042156627624, 11894.524219031488, 12755.362231888183, 12844.0, 13092.672683182996, 13134.73730525365, 11973.461194246454, 12196.207246528948, 12294.692632684255, 12334.691632709255, 12572.30852303132, 10733.624323148651, 10804.297720648132, 10840.132789376674, 11066.170037247399, 11149.386783726648, 11553.701565051146, 11803.468843901874, 12165.087618428477, 12170.756584868075, 12258.387080646111, 9540.33217674756, 10293.84559231597, 10309.22680798958, 10563.52464139131, 10589.311694739818, 9840.950795245977, 9992.218519922539, 10193.725784276965, 10249.692509224735, 10486.632967846088], "unit": "score", "name": "yui.html", "value": 6546.369340400923}], "name": "dromaeo_css", "value": 7317.212308987208}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 104.0, 112.0, 109.0, 111.0, 122.0, 111.0, 109.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [161.0, 136.0, 155.0, 161.0, 132.0, 156.0, 155.0, 128.0, 177.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 162.0, 164.0, 163.0, 162.0, 163.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 75.0, 164.0, 77.0, 76.0, 76.0, 76.0, 163.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.5}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 149.0, 92.0, 93.0, 93.0, 146.0, 93.0, 95.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.5}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 151.0, 148.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 55.0, 55.0, 54.0, 57.0, 64.0, 54.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 67.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.8}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 80.0, 81.0, 79.0, 78.0, 79.0, 79.0, 80.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.2}, {"lowerIsBetter": true, "replicates": [113.0, 115.0, 116.0, 112.0, 131.0, 113.0, 120.0, 115.0, 119.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.7}, {"lowerIsBetter": true, "replicates": [147.0, 150.0, 160.0, 149.0, 143.0, 136.0, 150.0, 146.0, 146.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [80.0, 71.0, 70.0, 69.0, 69.0, 67.0, 67.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1522.4}]} 07:14:38 INFO - Return code: 0 07:14:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:14:38 ERROR - # TBPL SUCCESS # 07:14:38 INFO - Running post-action listener: _resource_record_post_action 07:14:38 INFO - Running post-run listener: _resource_record_post_run 07:14:39 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 266240; Write bytes: 500473856; Read time: 36; Write time: 398416 07:14:39 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 244977664; Read time: 0; Write time: 245384 07:14:39 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 266240; Write bytes: 255496192; Read time: 36; Write time: 153032 07:14:39 INFO - Running post-run listener: _upload_blobber_files 07:14:39 INFO - Blob upload gear active. 07:14:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:14:39 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 07:14:39 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'] 07:14:39 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 07:14:39 INFO - (blobuploader) - INFO - Open directory for files ... 07:14:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:14:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:14:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:40 INFO - (blobuploader) - INFO - Done attempting. 07:14:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:14:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:14:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:41 INFO - (blobuploader) - INFO - Done attempting. 07:14:41 INFO - (blobuploader) - INFO - Iteration through files over. 07:14:41 INFO - Return code: 0 07:14:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:14:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:14:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/259aa485eadba04b5d485645c67cf33583de0c165af1ecc5f11e5f3a5d44ba14612831edab10ded237a92c6d4af04fb52634438f65c39464255fce1a8759d9b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/348fe0712754db5e970c4605b51e42f9c279138806bdf9f237d4d799cc1d4db8622fa91cafb6ce112df61f3d91084dea7f220b29d969c7169fecca3fd67a3e59"} 07:14:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:14:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:14:41 INFO - Contents: 07:14:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/259aa485eadba04b5d485645c67cf33583de0c165af1ecc5f11e5f3a5d44ba14612831edab10ded237a92c6d4af04fb52634438f65c39464255fce1a8759d9b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/348fe0712754db5e970c4605b51e42f9c279138806bdf9f237d4d799cc1d4db8622fa91cafb6ce112df61f3d91084dea7f220b29d969c7169fecca3fd67a3e59"} 07:14:41 INFO - Running post-run listener: copy_logs_to_upload_dir 07:14:41 INFO - Copying logs to upload dir... 07:14:41 INFO - mkdir: /builds/slave/test/build/upload/logs 07:14:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.978749 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-04-14 07:14:41.178714) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 07:14:41.182783) ========= 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=0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020 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/259aa485eadba04b5d485645c67cf33583de0c165af1ecc5f11e5f3a5d44ba14612831edab10ded237a92c6d4af04fb52634438f65c39464255fce1a8759d9b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/348fe0712754db5e970c4605b51e42f9c279138806bdf9f237d4d799cc1d4db8622fa91cafb6ce112df61f3d91084dea7f220b29d969c7169fecca3fd67a3e59"} build_url:https://queue.taskcluster.net/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/aEyEq59MR8euMH3CZeBHZw/artifacts/public/build/firefox-47.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/259aa485eadba04b5d485645c67cf33583de0c165af1ecc5f11e5f3a5d44ba14612831edab10ded237a92c6d4af04fb52634438f65c39464255fce1a8759d9b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/348fe0712754db5e970c4605b51e42f9c279138806bdf9f237d4d799cc1d4db8622fa91cafb6ce112df61f3d91084dea7f220b29d969c7169fecca3fd67a3e59"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 07:14:41.207646) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:14:41.207989) ========= 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=0333a256a5e4f052382dd180000001b1-1460639820.12864-478823020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:14:41.291255) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 07:14:41.291601) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 07:14:41.291912) ========= ========= Total master_lag: 0.17 =========