builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-040 starttime: 1461753578.23 results: success (0) buildid: 20160425062348 builduid: abe90fc74b164da98c10377025c22763 revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.230108) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.230485) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.231552) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.262787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.263046) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 03:39:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.8M=0s 2016-04-27 03:39:39 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118904 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.417719) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.418005) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017357 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.496432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:38.496746) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8551b253f4061db31e4be7829c2f70c2610caf42 --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 8551b253f4061db31e4be7829c2f70c2610caf42 --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=9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 03:39:39,351 truncating revision to first 12 chars 2016-04-27 03:39:39,351 Setting DEBUG logging. 2016-04-27 03:39:39,351 attempt 1/10 2016-04-27 03:39:39,351 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8551b253f406?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 03:39:39,637 unpacking tar archive at: mozilla-aurora-8551b253f406/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555142 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:39.075549) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:39.075860) ========= script_repo_revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:39.076251) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:39.076518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:39.088622) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-04-27 03:39:39.088941) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:39:40 INFO - MultiFileLogger online at 20160427 03:39:40 in /builds/slave/test 03:39:40 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 03:39:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:39:40 INFO - {'append_to_log': False, 03:39:40 INFO - 'base_work_dir': '/builds/slave/test', 03:39:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:39:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:39:40 INFO - 'branch': 'Mozilla-Aurora', 03:39:40 INFO - 'buildbot_json_path': 'buildprops.json', 03:39:40 INFO - 'config_files': ('talos/linux_config.py',), 03:39:40 INFO - 'default_actions': ('clobber', 03:39:40 INFO - 'read-buildbot-config', 03:39:40 INFO - 'download-and-extract', 03:39:40 INFO - 'populate-webroot', 03:39:40 INFO - 'create-virtualenv', 03:39:40 INFO - 'install', 03:39:40 INFO - 'run-tests'), 03:39:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:39:40 INFO - 'download_minidump_stackwalk': True, 03:39:40 INFO - 'download_symbols': 'ondemand', 03:39:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:39:40 INFO - 'tooltool.py': '/tools/tooltool.py', 03:39:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:39:40 INFO - '/tools/misc-python/virtualenv.py')}, 03:39:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:39:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:39:40 INFO - 'installer_path': 'installer.exe', 03:39:40 INFO - 'log_level': 'info', 03:39:40 INFO - 'log_name': 'talos', 03:39:40 INFO - 'log_to_console': True, 03:39:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:39:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:39:40 INFO - 'opt_config_files': (), 03:39:40 INFO - 'pip_index': False, 03:39:40 INFO - 'sps_profile': False, 03:39:40 INFO - 'sps_profile_interval': 0, 03:39:40 INFO - 'suite': 'dromaeojs-e10s', 03:39:40 INFO - 'system_bits': '32', 03:39:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:39:40 INFO - 'title': 'talos-linux64-ix-040', 03:39:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:39:40 INFO - 'use_talos_json': True, 03:39:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:39:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:39:40 INFO - 'work_dir': 'build'} 03:39:40 INFO - ##### 03:39:40 INFO - ##### Running clobber step. 03:39:40 INFO - ##### 03:39:40 INFO - Running pre-action listener: _resource_record_pre_action 03:39:40 INFO - Running main action method: clobber 03:39:40 INFO - rmtree: /builds/slave/test/build 03:39:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:39:40 INFO - Running post-action listener: _resource_record_post_action 03:39:40 INFO - ##### 03:39:40 INFO - ##### Running read-buildbot-config step. 03:39:40 INFO - ##### 03:39:40 INFO - Running pre-action listener: _resource_record_pre_action 03:39:40 INFO - Running main action method: read_buildbot_config 03:39:40 INFO - Using buildbot properties: 03:39:40 INFO - { 03:39:40 INFO - "project": "", 03:39:40 INFO - "product": "firefox", 03:39:40 INFO - "script_repo_revision": "production", 03:39:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:39:40 INFO - "repository": "", 03:39:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:39:40 INFO - "buildid": "20160425062348", 03:39:40 INFO - "pgo_build": "True", 03:39:40 INFO - "basedir": "/builds/slave/test", 03:39:40 INFO - "buildnumber": 326, 03:39:40 INFO - "slavename": "talos-linux64-ix-040", 03:39:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:39:40 INFO - "platform": "ubuntu64_hw", 03:39:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:39:40 INFO - "branch": "mozilla-aurora", 03:39:40 INFO - "repo_path": "releases/mozilla-aurora", 03:39:40 INFO - "revision": "8551b253f4061db31e4be7829c2f70c2610caf42", 03:39:40 INFO - "stage_platform": "linux64-pgo", 03:39:40 INFO - "builduid": "abe90fc74b164da98c10377025c22763", 03:39:40 INFO - "slavebuilddir": "test" 03:39:40 INFO - } 03:39:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:39:40 INFO - Running post-action listener: _resource_record_post_action 03:39:40 INFO - ##### 03:39:40 INFO - ##### Running download-and-extract step. 03:39:40 INFO - ##### 03:39:40 INFO - Running pre-action listener: _resource_record_pre_action 03:39:40 INFO - Running main action method: download_and_extract 03:39:40 INFO - mkdir: /builds/slave/test/build/tests 03:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:40 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:39:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:39:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:39:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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 03:39:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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 03:39:41 INFO - Downloaded 1448 bytes. 03:39:41 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:39:41 INFO - Using the following test package requirements: 03:39:41 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:41 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:41 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:39:41 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:41 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:39:41 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:41 INFO - u'jsshell-linux-x86_64.zip'], 03:39:41 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:41 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:39:41 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:41 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:41 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:39:41 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:41 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:39:41 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:41 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:39:41 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:41 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:41 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:39:41 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:41 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:39:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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 03:39:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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 03:40:11 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip: timed out 03:40:11 INFO - retry: attempt #1 caught exception: timed out 03:40:11 INFO - retry: Failed, sleeping 30 seconds before retrying 03:40:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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 #2 03:40:44 INFO - Downloaded 23359918 bytes. 03:40:44 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'] 03:40:44 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 03:40:45 INFO - Return code: 0 03:40:45 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 03:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:45 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:40:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:40:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:40:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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 03:40:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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 03:40:49 INFO - Downloaded 23359918 bytes. 03:40:49 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'] 03:40:49 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 03:40:50 INFO - Return code: 0 03:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:50 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:40:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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 03:40:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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 03:40:52 INFO - Downloaded 10845194 bytes. 03:40:52 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'] 03:40:52 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 03:40:52 INFO - Return code: 0 03:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:52 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:40:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:40:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:40:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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 03:40:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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 03:40:54 INFO - Downloaded 60835591 bytes. 03:40:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:40:54 INFO - mkdir: /builds/slave/test/properties 03:40:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:40:54 INFO - Writing to file /builds/slave/test/properties/build_url 03:40:54 INFO - Contents: 03:40:54 INFO - build_url:https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:40:55 INFO - Running post-action listener: _resource_record_post_action 03:40:55 INFO - Running post-action listener: set_extra_try_arguments 03:40:55 INFO - ##### 03:40:55 INFO - ##### Running populate-webroot step. 03:40:55 INFO - ##### 03:40:55 INFO - Running pre-action listener: _resource_record_pre_action 03:40:55 INFO - Running main action method: populate_webroot 03:40:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:40:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:40:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:40:55 INFO - '--tppagecycles', 03:40:55 INFO - '7'], 03:40:55 INFO - 'tests': ['tsvgm']}}, 03:40:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:40:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:40:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:40:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:40:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:40:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:40:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:55 INFO - 'talos_options': ['--e10s'], 03:40:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:55 INFO - 'tests': ['damp', 'tps']}, 03:40:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:55 INFO - 'talos_options': ['--e10s'], 03:40:55 INFO - 'tests': ['damp', 'tps']}, 03:40:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:40:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:40:55 INFO - 'other': {'tests': ['a11yr', 03:40:55 INFO - 'ts_paint', 03:40:55 INFO - 'tpaint', 03:40:55 INFO - 'sessionrestore', 03:40:55 INFO - 'sessionrestore_no_auto_restore', 03:40:55 INFO - 'tabpaint']}, 03:40:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:40:55 INFO - 'tests': ['a11yr', 03:40:55 INFO - 'ts_paint', 03:40:55 INFO - 'tpaint', 03:40:55 INFO - 'sessionrestore', 03:40:55 INFO - 'sessionrestore_no_auto_restore', 03:40:55 INFO - 'tabpaint']}, 03:40:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:40:55 INFO - 'tests': ['a11yr', 03:40:55 INFO - 'ts_paint', 03:40:55 INFO - 'tpaint', 03:40:55 INFO - 'sessionrestore', 03:40:55 INFO - 'sessionrestore_no_auto_restore', 03:40:55 INFO - 'tabpaint']}, 03:40:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:40:55 INFO - 'tests': ['a11yr', 03:40:55 INFO - 'ts_paint', 03:40:55 INFO - 'tpaint', 03:40:55 INFO - 'sessionrestore', 03:40:55 INFO - 'sessionrestore_no_auto_restore', 03:40:55 INFO - 'tabpaint']}, 03:40:55 INFO - 'other_l64': {'tests': ['a11yr', 03:40:55 INFO - 'ts_paint', 03:40:55 INFO - 'tpaint', 03:40:55 INFO - 'sessionrestore', 03:40:55 INFO - 'sessionrestore_no_auto_restore', 03:40:55 INFO - 'tabpaint']}, 03:40:55 INFO - 'other_nol64': {'tests': ['a11yr', 03:40:55 INFO - 'ts_paint', 03:40:55 INFO - 'tpaint', 03:40:55 INFO - 'sessionrestore', 03:40:55 INFO - 'sessionrestore_no_auto_restore', 03:40:55 INFO - 'tabpaint']}, 03:40:55 INFO - 'svgr': {'tests': ['tsvgx', 03:40:55 INFO - 'tsvgr_opacity', 03:40:55 INFO - 'tart', 03:40:55 INFO - 'tscrollx', 03:40:55 INFO - 'cart']}, 03:40:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:40:55 INFO - 'tests': ['tsvgx', 03:40:55 INFO - 'tsvgr_opacity', 03:40:55 INFO - 'tart', 03:40:55 INFO - 'tscrollx', 03:40:55 INFO - 'cart']}, 03:40:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:55 INFO - 'tests': ['tp5o']}, 03:40:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:55 INFO - 'talos_options': ['--e10s'], 03:40:55 INFO - 'tests': ['tp5o']}, 03:40:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:55 INFO - 'talos_options': ['--xperf_path', 03:40:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:55 INFO - 'tests': ['tp5n']}, 03:40:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:55 INFO - 'talos_options': ['--e10s', 03:40:55 INFO - '--xperf_path', 03:40:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:55 INFO - 'tests': ['tp5n']}}, 03:40:55 INFO - 'talos.zip': {'path': '', 03:40:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:40:55 INFO - Running post-action listener: _resource_record_post_action 03:40:55 INFO - ##### 03:40:55 INFO - ##### Running create-virtualenv step. 03:40:55 INFO - ##### 03:40:55 INFO - Running pre-action listener: _resource_record_pre_action 03:40:55 INFO - Running main action method: create_virtualenv 03:40:55 INFO - Creating virtualenv /builds/slave/test/build/venv 03:40:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:40:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:40:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:40:55 INFO - Using real prefix '/usr' 03:40:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:40:55 INFO - Installing distribute.............................................................................................................................................................................................done. 03:40:57 INFO - Installing pip.................done. 03:40:57 INFO - Return code: 0 03:40:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:57 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 0x7fb28672ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628160>, '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 0x1629060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16294f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:40:57 INFO - Using env: {'DISPLAY': ':0', 03:40:57 INFO - 'HOME': '/home/cltbld', 03:40:57 INFO - 'LANG': 'en_US.UTF-8', 03:40:57 INFO - 'LANGUAGE': 'en_US:en', 03:40:57 INFO - 'LOGNAME': 'cltbld', 03:40:57 INFO - 'MAIL': '/var/mail/cltbld', 03:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:57 INFO - 'MOZ_NO_REMOTE': '1', 03:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:57 INFO - 'NO_EM_RESTART': '1', 03:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:57 INFO - 'PWD': '/builds/slave/test', 03:40:57 INFO - 'SHELL': '/bin/bash', 03:40:57 INFO - 'SHLVL': '1', 03:40:57 INFO - 'TERM': 'linux', 03:40:57 INFO - 'TMOUT': '86400', 03:40:57 INFO - 'USER': 'cltbld', 03:40:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 03:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:57 INFO - '_': '/tools/buildbot/bin/python'} 03:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:40:57 INFO - Cleaning up... 03:40:57 INFO - Return code: 0 03:40:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:57 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 0x7fb28672ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628160>, '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 0x1629060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16294f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:40:57 INFO - Using env: {'DISPLAY': ':0', 03:40:57 INFO - 'HOME': '/home/cltbld', 03:40:57 INFO - 'LANG': 'en_US.UTF-8', 03:40:57 INFO - 'LANGUAGE': 'en_US:en', 03:40:57 INFO - 'LOGNAME': 'cltbld', 03:40:57 INFO - 'MAIL': '/var/mail/cltbld', 03:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:57 INFO - 'MOZ_NO_REMOTE': '1', 03:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:57 INFO - 'NO_EM_RESTART': '1', 03:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:57 INFO - 'PWD': '/builds/slave/test', 03:40:57 INFO - 'SHELL': '/bin/bash', 03:40:57 INFO - 'SHLVL': '1', 03:40:57 INFO - 'TERM': 'linux', 03:40:57 INFO - 'TMOUT': '86400', 03:40:57 INFO - 'USER': 'cltbld', 03:40:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 03:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:57 INFO - '_': '/tools/buildbot/bin/python'} 03:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:58 INFO - Downloading/unpacking psutil>=0.7.1 03:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:41:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:00 INFO - Installing collected packages: psutil 03:41:00 INFO - Running setup.py install for psutil 03:41:00 INFO - building 'psutil._psutil_linux' extension 03:41:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:41:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:41:00 INFO - building 'psutil._psutil_posix' extension 03:41:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:41:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:41:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:00 INFO - Successfully installed psutil 03:41:00 INFO - Cleaning up... 03:41:00 INFO - Return code: 0 03:41:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:00 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 0x7fb28672ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628160>, '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 0x1629060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16294f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:41:00 INFO - Using env: {'DISPLAY': ':0', 03:41:00 INFO - 'HOME': '/home/cltbld', 03:41:00 INFO - 'LANG': 'en_US.UTF-8', 03:41:00 INFO - 'LANGUAGE': 'en_US:en', 03:41:00 INFO - 'LOGNAME': 'cltbld', 03:41:00 INFO - 'MAIL': '/var/mail/cltbld', 03:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:00 INFO - 'MOZ_NO_REMOTE': '1', 03:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:00 INFO - 'NO_EM_RESTART': '1', 03:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:00 INFO - 'PWD': '/builds/slave/test', 03:41:00 INFO - 'SHELL': '/bin/bash', 03:41:00 INFO - 'SHLVL': '1', 03:41:00 INFO - 'TERM': 'linux', 03:41:00 INFO - 'TMOUT': '86400', 03:41:00 INFO - 'USER': 'cltbld', 03:41:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 03:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:00 INFO - '_': '/tools/buildbot/bin/python'} 03:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:41:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:41:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:41:02 INFO - Installing collected packages: mozsystemmonitor 03:41:02 INFO - Running setup.py install for mozsystemmonitor 03:41:02 INFO - Successfully installed mozsystemmonitor 03:41:02 INFO - Cleaning up... 03:41:02 INFO - Return code: 0 03:41:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb28672ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628160>, '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 0x1629060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16294f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:41:02 INFO - Using env: {'DISPLAY': ':0', 03:41:02 INFO - 'HOME': '/home/cltbld', 03:41:02 INFO - 'LANG': 'en_US.UTF-8', 03:41:02 INFO - 'LANGUAGE': 'en_US:en', 03:41:02 INFO - 'LOGNAME': 'cltbld', 03:41:02 INFO - 'MAIL': '/var/mail/cltbld', 03:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:02 INFO - 'MOZ_NO_REMOTE': '1', 03:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:02 INFO - 'NO_EM_RESTART': '1', 03:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:02 INFO - 'PWD': '/builds/slave/test', 03:41:02 INFO - 'SHELL': '/bin/bash', 03:41:02 INFO - 'SHLVL': '1', 03:41:02 INFO - 'TERM': 'linux', 03:41:02 INFO - 'TMOUT': '86400', 03:41:02 INFO - 'USER': 'cltbld', 03:41:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 03:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:02 INFO - '_': '/tools/buildbot/bin/python'} 03:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:04 INFO - Downloading blobuploader-1.2.4.tar.gz 03:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:41:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:41:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:05 INFO - Downloading docopt-0.6.1.tar.gz 03:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:41:05 INFO - Installing collected packages: blobuploader, requests, docopt 03:41:05 INFO - Running setup.py install for blobuploader 03:41:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:41:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:41:05 INFO - Running setup.py install for requests 03:41:06 INFO - Running setup.py install for docopt 03:41:06 INFO - Successfully installed blobuploader requests docopt 03:41:06 INFO - Cleaning up... 03:41:06 INFO - Return code: 0 03:41:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:06 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 0x7fb28672ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628160>, '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 0x1629060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16294f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:06 INFO - Using env: {'DISPLAY': ':0', 03:41:06 INFO - 'HOME': '/home/cltbld', 03:41:06 INFO - 'LANG': 'en_US.UTF-8', 03:41:06 INFO - 'LANGUAGE': 'en_US:en', 03:41:06 INFO - 'LOGNAME': 'cltbld', 03:41:06 INFO - 'MAIL': '/var/mail/cltbld', 03:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:06 INFO - 'MOZ_NO_REMOTE': '1', 03:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:06 INFO - 'NO_EM_RESTART': '1', 03:41:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:06 INFO - 'PWD': '/builds/slave/test', 03:41:06 INFO - 'SHELL': '/bin/bash', 03:41:06 INFO - 'SHLVL': '1', 03:41:06 INFO - 'TERM': 'linux', 03:41:06 INFO - 'TMOUT': '86400', 03:41:06 INFO - 'USER': 'cltbld', 03:41:06 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 03:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:06 INFO - '_': '/tools/buildbot/bin/python'} 03:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:06 INFO - Running setup.py (path:/tmp/pip-dAPygU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:06 INFO - Running setup.py (path:/tmp/pip-VF8AIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:06 INFO - Running setup.py (path:/tmp/pip-8QYp6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:06 INFO - Running setup.py (path:/tmp/pip-m0XWot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:06 INFO - Running setup.py (path:/tmp/pip-RzxxAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:06 INFO - Running setup.py (path:/tmp/pip-mq_trw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:06 INFO - Running setup.py (path:/tmp/pip-p8cFFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:07 INFO - Running setup.py (path:/tmp/pip-vEtxHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:07 INFO - Running setup.py (path:/tmp/pip-xgdZGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:07 INFO - Running setup.py (path:/tmp/pip-OjOgKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:07 INFO - Running setup.py (path:/tmp/pip-ytRLb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:07 INFO - Running setup.py (path:/tmp/pip-7b0gVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:07 INFO - Running setup.py (path:/tmp/pip-MuPrA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:07 INFO - Running setup.py (path:/tmp/pip-DReGAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:07 INFO - Running setup.py (path:/tmp/pip-ThgKwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:07 INFO - Running setup.py (path:/tmp/pip-f0LCSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:07 INFO - Running setup.py (path:/tmp/pip-SCg8v5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:41:07 INFO - Running setup.py install for manifestparser 03:41:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:41:07 INFO - Running setup.py install for mozcrash 03:41:07 INFO - Running setup.py install for mozdebug 03:41:08 INFO - Running setup.py install for mozdevice 03:41:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:41:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:41:08 INFO - Running setup.py install for mozfile 03:41:08 INFO - Running setup.py install for mozhttpd 03:41:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:41:08 INFO - Running setup.py install for mozinfo 03:41:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:41:08 INFO - Running setup.py install for mozInstall 03:41:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:41:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:41:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:41:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:41:08 INFO - Running setup.py install for mozleak 03:41:08 INFO - Running setup.py install for mozlog 03:41:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:41:08 INFO - Running setup.py install for moznetwork 03:41:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:41:08 INFO - Running setup.py install for mozprocess 03:41:08 INFO - Running setup.py install for mozprofile 03:41:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:41:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:41:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:41:09 INFO - Running setup.py install for mozrunner 03:41:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:41:09 INFO - Running setup.py install for mozscreenshot 03:41:09 INFO - Running setup.py install for moztest 03:41:09 INFO - Running setup.py install for mozversion 03:41:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:41:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:41:09 INFO - Cleaning up... 03:41:09 INFO - Return code: 0 03:41:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:09 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 0x7fb28672ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628160>, '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 0x1629060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16294f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:09 INFO - Using env: {'DISPLAY': ':0', 03:41:09 INFO - 'HOME': '/home/cltbld', 03:41:09 INFO - 'LANG': 'en_US.UTF-8', 03:41:09 INFO - 'LANGUAGE': 'en_US:en', 03:41:09 INFO - 'LOGNAME': 'cltbld', 03:41:09 INFO - 'MAIL': '/var/mail/cltbld', 03:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:09 INFO - 'MOZ_NO_REMOTE': '1', 03:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:09 INFO - 'NO_EM_RESTART': '1', 03:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:09 INFO - 'PWD': '/builds/slave/test', 03:41:09 INFO - 'SHELL': '/bin/bash', 03:41:09 INFO - 'SHLVL': '1', 03:41:09 INFO - 'TERM': 'linux', 03:41:09 INFO - 'TMOUT': '86400', 03:41:09 INFO - 'USER': 'cltbld', 03:41:09 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 03:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:09 INFO - '_': '/tools/buildbot/bin/python'} 03:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:09 INFO - Running setup.py (path:/tmp/pip-59j6n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:09 INFO - Running setup.py (path:/tmp/pip-yKiCsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:09 INFO - Running setup.py (path:/tmp/pip-Xtn2CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:09 INFO - Running setup.py (path:/tmp/pip-zfF5ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:10 INFO - Running setup.py (path:/tmp/pip-SuztTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:10 INFO - Running setup.py (path:/tmp/pip-FCRYd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:10 INFO - Running setup.py (path:/tmp/pip-yfZVO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:10 INFO - Running setup.py (path:/tmp/pip-lvmUFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:10 INFO - Running setup.py (path:/tmp/pip-jpq11R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:10 INFO - Running setup.py (path:/tmp/pip-3X82O1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:10 INFO - Running setup.py (path:/tmp/pip-NrHft_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:10 INFO - Running setup.py (path:/tmp/pip-45GYjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:10 INFO - Running setup.py (path:/tmp/pip-7J3qaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:10 INFO - Running setup.py (path:/tmp/pip-rOQ2WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:10 INFO - Running setup.py (path:/tmp/pip-cN7UOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:10 INFO - Running setup.py (path:/tmp/pip-F5zBaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:10 INFO - Running setup.py (path:/tmp/pip-cby_Cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:12 INFO - Downloading blessings-1.6.tar.gz 03:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:41:12 INFO - Installing collected packages: blessings 03:41:12 INFO - Running setup.py install for blessings 03:41:13 INFO - Successfully installed blessings 03:41:13 INFO - Cleaning up... 03:41:13 INFO - Return code: 0 03:41:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:41:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:13 INFO - Reading from file tmpfile_stdout 03:41:13 INFO - Current package versions: 03:41:13 INFO - argparse == 1.2.1 03:41:13 INFO - blessings == 1.6 03:41:13 INFO - blobuploader == 1.2.4 03:41:13 INFO - docopt == 0.6.1 03:41:13 INFO - manifestparser == 1.1 03:41:13 INFO - mozInstall == 1.12 03:41:13 INFO - mozcrash == 0.17 03:41:13 INFO - mozdebug == 0.1 03:41:13 INFO - mozdevice == 0.48 03:41:13 INFO - mozfile == 1.2 03:41:13 INFO - mozhttpd == 0.7 03:41:13 INFO - mozinfo == 0.9 03:41:13 INFO - mozleak == 0.1 03:41:13 INFO - mozlog == 3.1 03:41:13 INFO - moznetwork == 0.27 03:41:13 INFO - mozprocess == 0.22 03:41:13 INFO - mozprofile == 0.28 03:41:13 INFO - mozrunner == 6.11 03:41:13 INFO - mozscreenshot == 0.1 03:41:13 INFO - mozsystemmonitor == 0.0 03:41:13 INFO - moztest == 0.7 03:41:13 INFO - mozversion == 1.4 03:41:13 INFO - psutil == 3.1.1 03:41:13 INFO - requests == 1.2.3 03:41:13 INFO - wsgiref == 0.1.2 03:41:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:13 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 0x7fb28672ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628160>, '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 0x1629060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16294f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:13 INFO - Using env: {'DISPLAY': ':0', 03:41:13 INFO - 'HOME': '/home/cltbld', 03:41:13 INFO - 'LANG': 'en_US.UTF-8', 03:41:13 INFO - 'LANGUAGE': 'en_US:en', 03:41:13 INFO - 'LOGNAME': 'cltbld', 03:41:13 INFO - 'MAIL': '/var/mail/cltbld', 03:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:13 INFO - 'MOZ_NO_REMOTE': '1', 03:41:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:13 INFO - 'NO_EM_RESTART': '1', 03:41:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:13 INFO - 'PWD': '/builds/slave/test', 03:41:13 INFO - 'SHELL': '/bin/bash', 03:41:13 INFO - 'SHLVL': '1', 03:41:13 INFO - 'TERM': 'linux', 03:41:13 INFO - 'TMOUT': '86400', 03:41:13 INFO - 'USER': 'cltbld', 03:41:13 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 03:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:13 INFO - '_': '/tools/buildbot/bin/python'} 03:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:41:13 INFO - Cleaning up... 03:41:13 INFO - Return code: 0 03:41:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:13 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 0x7fb28672ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628160>, '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 0x1629060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16294f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:41:13 INFO - Using env: {'DISPLAY': ':0', 03:41:13 INFO - 'HOME': '/home/cltbld', 03:41:13 INFO - 'LANG': 'en_US.UTF-8', 03:41:13 INFO - 'LANGUAGE': 'en_US:en', 03:41:13 INFO - 'LOGNAME': 'cltbld', 03:41:13 INFO - 'MAIL': '/var/mail/cltbld', 03:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:13 INFO - 'MOZ_NO_REMOTE': '1', 03:41:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:13 INFO - 'NO_EM_RESTART': '1', 03:41:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:13 INFO - 'PWD': '/builds/slave/test', 03:41:13 INFO - 'SHELL': '/bin/bash', 03:41:13 INFO - 'SHLVL': '1', 03:41:13 INFO - 'TERM': 'linux', 03:41:13 INFO - 'TMOUT': '86400', 03:41:13 INFO - 'USER': 'cltbld', 03:41:13 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 03:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:13 INFO - '_': '/tools/buildbot/bin/python'} 03:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:13 INFO - Downloading/unpacking jsonschema 03:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:41:15 INFO - Downloading/unpacking functools32 (from jsonschema) 03:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:15 INFO - Downloading functools32-3.2.3-2.tar.gz 03:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:41:15 INFO - warning: no files found matching '*.txt' 03:41:15 INFO - no previously-included directories found matching 'build' 03:41:15 INFO - no previously-included directories found matching 'dist' 03:41:15 INFO - no previously-included directories found matching '.git*' 03:41:15 INFO - Installing collected packages: jsonschema, functools32 03:41:15 INFO - Running setup.py install for functools32 03:41:16 INFO - warning: no files found matching '*.txt' 03:41:16 INFO - no previously-included directories found matching 'build' 03:41:16 INFO - no previously-included directories found matching 'dist' 03:41:16 INFO - no previously-included directories found matching '.git*' 03:41:16 INFO - Successfully installed jsonschema functools32 03:41:16 INFO - Cleaning up... 03:41:16 INFO - Return code: 0 03:41:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:41: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')]} 03:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41: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')]} 03:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:16 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 0x7fb28672ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1628160>, '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 0x1629060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16294f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:41:16 INFO - Using env: {'DISPLAY': ':0', 03:41:16 INFO - 'HOME': '/home/cltbld', 03:41:16 INFO - 'LANG': 'en_US.UTF-8', 03:41:16 INFO - 'LANGUAGE': 'en_US:en', 03:41:16 INFO - 'LOGNAME': 'cltbld', 03:41:16 INFO - 'MAIL': '/var/mail/cltbld', 03:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:16 INFO - 'MOZ_NO_REMOTE': '1', 03:41:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:16 INFO - 'NO_EM_RESTART': '1', 03:41:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:16 INFO - 'PWD': '/builds/slave/test', 03:41:16 INFO - 'SHELL': '/bin/bash', 03:41:16 INFO - 'SHLVL': '1', 03:41:16 INFO - 'TERM': 'linux', 03:41:16 INFO - 'TMOUT': '86400', 03:41:16 INFO - 'USER': 'cltbld', 03:41:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 03:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:16 INFO - '_': '/tools/buildbot/bin/python'} 03:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:16 INFO - Downloading/unpacking flake8 03:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:41:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:41:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:41:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:41:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:41:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:41:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:41:19 INFO - no previously-included directories found matching 'docs/_build' 03:41:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:41:19 INFO - Running setup.py install for pep8 03:41:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:41:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:41:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:41:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:41:19 INFO - no previously-included directories found matching 'docs/_build' 03:41:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:41:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:41:19 INFO - Cleaning up... 03:41:19 INFO - Return code: 0 03:41:19 INFO - Running post-action listener: _resource_record_post_action 03:41:19 INFO - Running post-action listener: _start_resource_monitoring 03:41:19 INFO - Starting resource monitoring. 03:41:19 INFO - ##### 03:41:19 INFO - ##### Running install step. 03:41:19 INFO - ##### 03:41:19 INFO - Running pre-action listener: _resource_record_pre_action 03:41:19 INFO - Running main action method: install 03:41:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:19 INFO - Reading from file tmpfile_stdout 03:41:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:41:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:41:19 INFO - Reading from file tmpfile_stdout 03:41:19 INFO - Output received: 03:41:19 INFO - Usage: mozinstall [options] installer 03:41:19 INFO - Options: 03:41:19 INFO - -h, --help show this help message and exit 03:41:19 INFO - -d DEST, --destination=DEST 03:41:19 INFO - Directory to install application into. [default: 03:41:19 INFO - "/builds/slave/test"] 03:41:19 INFO - --app=APP Application being installed. [default: firefox] 03:41:19 INFO - mkdir: /builds/slave/test/build/application 03:41:19 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'] 03:41:19 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 03:41:34 INFO - Reading from file tmpfile_stdout 03:41:34 INFO - Output received: 03:41:34 INFO - /builds/slave/test/build/application/firefox/firefox 03:41:34 INFO - Running post-action listener: _resource_record_post_action 03:41:34 INFO - ##### 03:41:34 INFO - ##### Running run-tests step. 03:41:34 INFO - ##### 03:41:34 INFO - Running pre-action listener: _resource_record_pre_action 03:41:34 INFO - Running main action method: run_tests 03:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:41:34 INFO - Python 2.7.3 03:41:34 INFO - Return code: 0 03:41:34 INFO - grabbing minidump binary from tooltool 03:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:34 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 0x1628160>, '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 0x1629060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16294f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:41:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:41:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:41:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:41:34 INFO - Return code: 0 03:41:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:41:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:41:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:41:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:41:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:41:35 INFO - Return code: 0 03:41:35 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/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 03:41:35 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/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 03:41:35 INFO - Using env: {'DISPLAY': ':0', 03:41:35 INFO - 'HOME': '/home/cltbld', 03:41:35 INFO - 'LANG': 'en_US.UTF-8', 03:41:35 INFO - 'LANGUAGE': 'en_US:en', 03:41:35 INFO - 'LOGNAME': 'cltbld', 03:41:35 INFO - 'MAIL': '/var/mail/cltbld', 03:41:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:41:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:35 INFO - 'MOZ_NO_REMOTE': '1', 03:41:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:41:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:35 INFO - 'NO_EM_RESTART': '1', 03:41:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:35 INFO - 'PWD': '/builds/slave/test', 03:41:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:41:35 INFO - 'SHELL': '/bin/bash', 03:41:35 INFO - 'SHLVL': '1', 03:41:35 INFO - 'TERM': 'linux', 03:41:35 INFO - 'TMOUT': '86400', 03:41:35 INFO - 'USER': 'cltbld', 03:41:35 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436', 03:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:35 INFO - '_': '/tools/buildbot/bin/python'} 03:41:35 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/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 03:41:36 INFO - mozversion application_buildid: 20160425062348 03:41:36 INFO - mozversion application_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 03:41:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:41:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:41:36 INFO - mozversion application_name: Firefox 03:41:36 INFO - mozversion application_remotingname: firefox-dev 03:41:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:36 INFO - mozversion application_vendor: Mozilla 03:41:36 INFO - mozversion application_version: 47.0a2 03:41:36 INFO - mozversion platform_buildid: 20160425062348 03:41:36 INFO - mozversion platform_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 03:41:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:36 INFO - mozversion platform_version: 47.0a2 03:41:36 INFO - using testdate: 1461753696 03:41:36 INFO - actual date: 1461753696 03:41:36 INFO - starting webserver on 'localhost:35204' 03:41:36 INFO - SUITE-START | Running 2 tests 03:41:36 INFO - TEST-START | dromaeo_css 03:41:36 INFO - operating with platform_type : linux_ 03:41:36 INFO - Initialising browser for dromaeo_css test... 03:41:36 INFO - TEST-INFO | started process 20127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeibN6m/profile http://localhost:35204/getInfo.html) 03:41:39 INFO - PROCESS | 20127 | 03:41:39 INFO - PROCESS | 20127 | (process:20202): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:41:40 INFO - PROCESS | 20127 | __metrics Screen width/height:1600/1200 03:41:40 INFO - PROCESS | 20127 | colorDepth:24 03:41:40 INFO - PROCESS | 20127 | Browser inner width/height: 1024/697 03:41:40 INFO - PROCESS | 20127 | __metrics 03:41:41 ERROR - PROCESS | 20127 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:41:42 INFO - TEST-INFO | 20127: exit 0 03:41:42 INFO - Browser initialized. 03:41:42 INFO - Running cycle 1/1 for dromaeo_css test... 03:41:42 INFO - TEST-INFO | started process 20254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeibN6m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:44 INFO - PROCESS | 20254 | 03:41:44 INFO - PROCESS | 20254 | (process:20325): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:41:54 INFO - PROCESS | 20254 | RSS: Main: 151535616 03:41:54 INFO - PROCESS | 20254 | 03:42:43 INFO - PROCESS | 20254 | 1461753763958 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:44:52 INFO - PROCESS | 20254 | Cycle 1(1): loaded http://localhost:35204/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35204/tests/dromaeo/cssquery-ext.html) 03:44:53 INFO - PROCESS | 20254 | RSS: Main: 154906624 03:44:53 INFO - PROCESS | 20254 | 03:47:55 INFO - PROCESS | 20254 | Cycle 1(1): loaded http://localhost:35204/tests/dromaeo/cssquery-ext.html (next: http://localhost:35204/tests/dromaeo/cssquery-jquery.html) 03:47:55 INFO - PROCESS | 20254 | RSS: Main: 153919488 03:47:55 INFO - PROCESS | 20254 | 03:50:57 INFO - PROCESS | 20254 | Cycle 1(1): loaded http://localhost:35204/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35204/tests/dromaeo/cssquery-mootools.html) 03:50:58 INFO - PROCESS | 20254 | RSS: Main: 153141248 03:50:58 INFO - PROCESS | 20254 | 03:53:59 INFO - PROCESS | 20254 | Cycle 1(1): loaded http://localhost:35204/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35204/tests/dromaeo/cssquery-prototype.html) 03:54:00 INFO - PROCESS | 20254 | RSS: Main: 152567808 03:54:00 INFO - PROCESS | 20254 | 03:57:02 INFO - PROCESS | 20254 | Cycle 1(1): loaded http://localhost:35204/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35204/tests/dromaeo/cssquery-yui.html) 03:57:03 INFO - PROCESS | 20254 | RSS: Main: 153346048 03:57:03 INFO - PROCESS | 20254 | 04:00:05 INFO - PROCESS | 20254 | Cycle 1(1): loaded http://localhost:35204/tests/dromaeo/cssquery-yui.html (next: http://localhost:35204/tests/dromaeo/cssquery-dojo.html) 04:00:05 INFO - PROCESS | 20254 | RSS: Main: 155209728 04:00:05 INFO - PROCESS | 20254 | 04:00:05 INFO - PROCESS | 20254 | __start_tp_report 04:00:05 INFO - PROCESS | 20254 | _x_x_mozilla_page_load 04:00:05 INFO - PROCESS | 20254 | _x_x_mozilla_page_load_details 04:00:05 INFO - PROCESS | 20254 | |i|pagename|runs| 04:00:05 INFO - PROCESS | 20254 | |0;dojo.html;3349.346877358915;3390.118569172016;3420.401429749796;3450.1374656335915;3455.01532063362;5587.9999999999945;5593.049181639121;5596.636218645795;5624.409437009112;5643.040683083876;5572.916406253909;5596.048671725806;5605.663660180382;5642.351129620095;5654.519365853897;5093.541581257686;5134.1528647773075;5136.075506408845;5178.378594568639;5187.221916712486;5056.418511871145;5190;5221.425643179247;5241.5020573045695;5248.580113590903;5171.7672704728375;5177;5239.318888544484;5239.633225674204;5253.422123566424;5124.103281925667;5170.767315470813;5202.193659982709;5205.609579281569;5240.68555886648;4920;5040.697558146523;5084;5167.250748641426;5186.403563590197;5287.841364759063;5307.575393968512;5349.037173308803;5376;5378.058839703036;6000.519958403361;6009.75960961561;6043.697815109227;6046;6068.605540639845;5809.331926828427;6015.789447369321;6068.848278793022;6076.270847498285;6116.724747386378;5673.177389278573;5689.943100568983;5691.800786972478;5698.458646428583;5729.828105156852;6174.44430001302;6204.875902481925;6209.627422354673;6218.720157592828;6220.844478888064;5762.279715035621;5916.349201587822;5922.289325280908;5932.911006334908;5959.5828292020005;6042.667653279024;6060.303065147476;6062.696865156725;6074.605150665281;6096.055111457731;5955.34491205967;5980.102984552352;5987.491063259585;6004.459598636056;6045.78839740607;5852.297724273115;5999.940000599938;6040.244969378828;6073.908891366633;6112.694365281718;4570.542945705402;4576.954230457719;4577.107464044546;4581.931271030937;4599.747013914267;4139.0480189555965;4142.565030671796;4144.8134833932545;4154.937675934863;4159.480064991876;5577.860553486195;5739.16782066598;5815.88368232633;5833.416658334133;5851.414858514199;6001.909971350433;6037.849053773691;6109.938900611026;6118;6120.721420533258;5561.249231353796;5748.425157484218;5808.6224395414165;5817.38917413674;5835.562332825055;5127.820526281562;5141.203113517411;5198.454162312978;5247.2653828464045;5297.576193904479;6218.537754694385;6219.689015549205;6228.5017198624;6239.313675495692;6242.656653883989;6021.036634138517;6047.941610218106;6059.909101363395;6063.848403789941;6076.483498902466;5983.640981540947;6179.887620228223;6216.844578885383;6300.9684951574945;6301.905471418024;5918.348981611933;5951.523878089829;5980.312264089512;6011.489023433057;6040.244969378828;5895.351511333664;6130.080487926846;6137.938620613915;6139.662318572521;6143.32423433413;5866.941330586639;5934.258217722785;5959.22530071088;5980.102984552352;5988.640681559121;5954.285485741739;5985.102234664835;6008.849778755566;6018.398160183947;6020.277566692025;5586.804461843979;5694.800681976111;5845.912311315419;5852.970735146297;5861.648301101777;5898.203742494708;5914.852128696817;5928.733207005609;5948.762049518144;5961.672108034099;5795.072788353843;5797.362290148165;5804.912926306193;5821.970890145522;5831.562632802642 04:00:05 INFO - PROCESS | 20254 | |1;ext.html;510.53286243087575;571.8055861007257;574.3509833887706;601.7322291580247;613.9570230083893;37028;37869.24261514771;37896.24207515848;38121.42817857734;38128.42807357892;40359.79820100903;40475.79762101193;40887;40930.79534602323;40974.7951260244;8821.558922053904;8979.95510022449;9024.097590240955;9064.773380665503;9078.77303067422;8808.691695790649;8977.820443591125;9026.052264512231;9026.458412495238;9042.23141033013;9245.861312080324;9273.814523709521;9285.535723213847;9307.62769489223;9355.766105847375;9166.908330916673;9237.214836738885;9283.582238799236;9288.349815512916;9318.86021709675;9039.096090390974;9237.12247336502;9248.6300547978;9260.953695231481;9271.629134834599;41497.377539336936;41785.58214417847;41857.162856742696;41973.160536789095;41994.37008444876;3749.0065132739846;3855.4602355670227;3856.8071596420345;3890.6383062998807;4401.845935392278;31617.20956976071;31647.20881977946;31803.840980794947;31865.044048678577;31915.202119947186;3728.2170744143764;3760.7179461540222;3774.358359078963;3859.3053250415196;3873.0704630888667;301715.49142254365;302800;302951;303390;303510;54910.72544637331;55321.1701824473;67207.66396168085;69124.65437672779;69178.30821691819;60838.391616084155;60928.390716093156;61091.38908610946;61274.69362653158;61289.69355153196;17421.738673919903;17710.91144544269;17742.112894355232;17765.822341776417;17787;13529.052966292265;13552.796708049387;13607.931960340135;13670.248136352397;13705.177689338672;19864.801351986585;20469.488262793548;20509.58980820405;20539.8973005137;20570.794292057188;7544.396448284234;7822.245322245354;7829.843403132019;7852.921470785333;8025.157358477392;1064.0627488453426;1065.5684447798653;1075.6880504653564;1077.3105212663902;1099.9055939340408;28857.422851543273;29289.85962863714;29485.557716634266;29580.704192957794;30091.699083009327;1058.8505334171643;1084.2410312780928;1110.6334909479851;1134.9035331996872;1147;15049.849501505063;15220.891341298662;15343.61640958985;15366.769498457532;15704.29330680122;338123;345796;346147;347045;347438;55821.720891395285;56583.43416565864;56602;56654.15018774722;56726.43273567211;1454.978175327371;1478;1488.977665335021;1497.2663394936403;1514.3942423030876;29318.26704332409;30109.548356775103;30211.848940756034;30257.394852102396;30609.54085688672;48161.27758083562;48447.27329089996;48639;48738.756306218245;48888.511114888395;235760;237275;237682;317134;317641;33556.328873422884;33686.15784605405;33754.493682595275;34542.65457345395;35012.47481287834;39402.60597394104;40095.599044009185;40298;40365.79817100896;40764.79617601893;33873.3225335487;33968.15079623029;34282.48576271408;34545;34664.82667586646;33814;33958.49062264019;34263.82868085644;34604.82697586496;34627.826860865534;32419;34896;38078.42882356711;38376.42435363416;38950;31654.208644784063;32688.182795429355;33185.50221746627;34902;35103.12242193965;22679.773202268425;23261.18585849487;23394.883025584764;23655.52688946177;23711.64432533479 04:00:05 INFO - PROCESS | 20254 | |2;jquery.html;371.4298551723105;385.92860320840646;396.00235621401947;401.84930651005874;402.09729158040204;16803.327866885324;18366;18937.147828347723;19075.809241907577;19170.712439313404;18095.366662166827;18163.81836181641;18329.54176145597;18431.17059732312;18570.35003774868;5426.321709786267;5614.438556144394;5634.098544232924;5669.914951275734;5686.857828554278;4250.213710463574;5938.228030356047;6175.444210021097;6197.783077592285;6203.813885583417;5872.735726892279;6122.204113465244;6130;6138.7237574309265;6170.814875553718;6015.09773533969;6064.3935606439445;6132.78535251264;6139.785107521216;6147.231596050494;5096.3884333879805;5375.274337964363;5399.136138217867;5402.081646120169;5402.135658294694;13424.463021479129;13642.522511712043;13650;13701.725965480735;13775.311234438339;2311.872846993415;2317.9768202317928;2387.5583017141885;2853.315204350941;2867.1828528869382;10056.648017319432;10094.192464602815;10387.27289089764;10483.73790655232;12110.636680899499;1591.761235814637;1669.0820048973017;1718.1495159895806;1721.948341549743;1821.244183663778;60971;63622.36377636211;63718.68140659313;64361.67819160921;65282.34717652858;9581.233501319877;9974.700758977242;10144.644937427154;10222.591096356062;10239.48802559884;13768.449262029608;13873.028887977947;13911.165330080228;13917.443302267999;13922.443102275796;7501.2123727007875;7574.659140338698;7648.349890259279;7690.269424404784;7718.0738311401865;7451.2921272479025;7465.626718664045;7526.548407095483;7552.244775522404;7588.203238659971;4285.764282964405;4314.266574682311;4373.103513779667;4575.405197324327;4793.281007848781;1875.7655293088364;1974.8913809740602;1995.4313020789004;2061.412497438223;2074.4917495213767;893.584483215308;974.7660561465198;979.275336251169;1084.924055316136;1103.2222283290262;17658.1170941455;17789.288428462718;17792.822071779116;18126.72809907826;18536.721949170773;942.8632848236967;1002.1581871228203;1003.0721582536125;1021.300409219672;1043.7181960870673;9995.200383969264;10454.843177352346;10486.213533984981;10497.10774584169;10578.418186999788;431994;434183;434854;441736;444216;70839.6458017717;74039.62980185173;74099.62950185215;74472;75457.62271188608;1059.274397038016;1082.978340433187;1090.9290896091888;1092.0662833277433;1108.0913650806262;15903.602409939844;16020.439284624983;16282;16328.346866125223;16451.177441128137;33876.49185262174;34137.82931085329;34270.314593708485;34911.47632785561;35890.282194355445;49085.75457122691;49237.261441077695;49245;49266.02935882668;50086;8541;8575.785605359915;8594.398392112493;8751.299896008431;8814.382993190415;9447.811043779224;12051.51793928233;12677.17598356104;12872.871271287167;12968.092233543939;10784.245102842726;11026.558937642405;11173;11199.272047316897;11228.270162439416;11101.888981110085;11112;11207.215494915603;11499.655010349703;11583.710407239887;11599.188056835941;11657.533698652298;11676.88323116758;11817.290962542274;12123.030157587547;8323.126071762377;8385.916140838513;8438.324934005142;8458.492490450593;8646.178613031752;11337.376444295644;11533.88466115328;11540.134489913458;11573.7106572333;11717.472713727731 04:00:05 INFO - PROCESS | 20254 | |3;mootools.html;1573.2055312067407;1597.784299119619;1805.7742782152231;1897;1910.942671719849;8188.91811081889;8315.958420207899;8345.248927596514;8593.312534997202;8595.398322117455;8561.272291855184;8597.656093756243;8601.741947741577;8632.30941524678;8636.481811091324;2407.410184504799;2432.5378178146184;2433.4646377796857;2436.488337449138;2441.914532991346;2464.6179842124498;2467.802575793932;2510.535550923076;2516.0564788204424;2516.5973444248925;2324.198151637691;2372.9321805187647;2404.1224952892244;2405.1341517053847;2430.3924018995253;2409.0484258717706;2456.6437866509345;2464.1621848571394;2469.4196863737097;2479.417336925821;2446.5473887330722;2456.250843492734;2458.6434966929874;2462.8891699873548;2463.6427717980973;8631.482111073356;8677.479351238882;8691.043985161627;8709.564521773886;8710.695125670634;5121.564667003309;5212.556932660728;5252.36971563411;5255.316808814868;5298.761555729963;3402.6937575618313;3417.8803741869165;3448.2758620689683;3463.7229021678204;3468.0462872709954;1078.1644225725047;1130.8416821644976;1135.7217481717032;1141.9714507137305;1150.2868221702515;11468.426578671117;11530.538778448852;11553.711157221052;11603.6518904433;11638.06895448362;4421.093675796454;4505;4527.071950250257;4540.273556230987;4601.056783359403;9479.90520094804;9496.097870702271;9496.19282361007;9521.095495927875;9538.093881081286;5155.252488389163;5170.353705786777;5170.844874653766;5181.222816577543;5198.0643484173215;4092.7748973806133;4587.3348364486965;4594.609458196091;4628.60656844172;4796.112719146969;3673.3387990162028;3739.775613463201;3746.6440688134585;3769.7361184717356;3807.8096095195683;1088.434014312553;1158.901493373056;1165.056304393444;1168.9298642081503;1173.7828501727208;1444.3500424808879;1461.8245810502808;1464.2898194375719;1465.2746890289375;1496.124767011289;7886.171951945078;7934.444588878723;7976.920230797734;7994.2805147537;7997.320227780588;537.4652221040091;542.9348478182643;545.3946119807011;565.6069032022705;567.0643438326712;6072.635641861502;6073.574849760563;6110.663913484801;6127.172831667757;6188.659623720739;10406.323588966692;10542.209334299958;10584.153267738562;10735.302205356627;10763.623273185402;10354.482275886176;10479.738006549896;10539.94730026345;10562;10597.9470102649;8211.507309561446;8255.504669719716;8255.834883302421;8287.8342433151;8308.252257296872;7864.134945156143;7948.801279968047;7959.4030447715495;7959.641816118405;7975.003124609424;9310;9344.579493922654;9434.198093162158;9529.190018848198;9583.664571739955;9542;9560.474173920502;9630.47032413224;9632.32573719861;9779.559919803769;6327.841803954938;6753.358430949052;6964.025036494793;7307.41540676734;7372.705091796268;8088.029436467662;8093.959530202312;8112.22933821286;8138.552379618941;8202.138775428493;7135.607541585055;7316.670749816378;7346.853062938604;7428.182899881117;7496.100467943882;7260;7273.563586184846;7333.230010848784;7344.118705755343;7377.557346559223;7374;7380;7382.741604043833;7405.925940740523;7471.775846724607;6800.727970881109;6912.343327383891;6931.584104953719;6949.7567585134275;6959.130108736408;6912.205096413977;6956.304369563003;6963.1644202696;6965.199002114821;6978.895316570357 04:00:05 INFO - PROCESS | 20254 | |4;prototype.html;365.1965675513869;370.6849178198532;371.81223482141513;373.63943794238554;376.83419295509975;6383.968080159599;6398.872022559546;6429.453496452801;6436.581622194554;6476.255230648465;6328;6332.176817013782;6334.619922804635;6344.206974128234;6368.872622547547;4709.599684026862;4806.110869489138;4828.97585512072;4840.128776820171;4917.237828136645;4809.470958194595;4809.879753006167;4814.951850481485;4833.371661683994;4838.975805120969;4779.64152688548;4803.903921921559;4812.278158276252;4815.277708343759;4816.951830481703;4809;4819.686720363183;4824.276358546211;4829.710217386968;4830.782614782325;4228.471441069866;4230.78846057699;4233.1322078973735;4234.13200293939;4241.278982572939;5839.8540036499;5966.403359663999;5969.104634304846;6001.219841420631;6007.068904319837;5567.777288908439;5598.048331783607;5599.32808063035;5604.747786349624;5609.663420194802;6571.080048793173;6591.176102987127;6601.834954126185;6628;6633.071370008202;4654.883627909296;4656.697314674535;4659.673822832403;4664.55686709762;4665.440147182326;7000.929990700079;7040.04959330489;7047.43620510358;7097.787066388017;7109.8222544436285;4646.3495110684535;4846.176150054499;4846.975765121222;4847.079054979613;4848.684835485682;4876.8780780480065;4905.264210368473;4916.06594746997;4919.139150648693;4921.803127874917;5651.547876169897;5651.632643878134;5655.745491452894;5659.773609055592;5666.688332141772;6727.966360168168;6748.763793267212;6788.898166527506;6793.932060679429;6806.081179040865;1719.131838421589;1742.6863164630488;1748.2832038864005;1751.798543167552;1754.6226212423187;1119.7536541960756;1142.360278244186;1146.39241202163;1155.6995181252767;1166.7608140331213;6505.349465053457;6513.641749703717;6522.673866306761;6527.086207930894;6551.50863685216;6989.790306290819;7026.1217347831525;7037.859242815218;7038.507304488637;7049.224585295613;6268.780592679234;6366.236051673829;6517.804465866032;6538.934610653928;6584.308647591934;3784.9432258516144;3825.349690552557;3830.3296923038356;3835.0412396900774;3840.8655697050467;7256.238095000054;7277.090363704537;7294.8176295591975;7310.159331676925;7344.192138864721;7243.058402407759;7245.094363204599;7250.927490725026;7266.418686505067;7280.890786638205;7150.713971441188;7271.400291935765;7356.448266380043;7364.594947277951;7384.852302953911;6997.405220556309;7073.257307982588;7123.821904452223;7127.82180445493;7150.177729561167;6936.410405115622;6949.409300209539;6982.581045137308;7000.334968178015;7012.1935977363255;7302.780916572511;7363.963180184065;7367.300106489874;7368.189499154982;7373.152087510005;4986.077575648516;5005.049040682259;5048.368953880765;5050;5072.619553533574;6986.126734158231;6994.5803251805055;7001.264867189076;7028.226895041439;7056.823579410556;6824.658767061726;6827.590344579341;6837.179538455218;6841.555298905555;6842.076319696777;6832.316768323128;6834.487413444111;6842.8973565397555;6845.931540684729;6848.178218613798;6498.122753428227;6632.303608121078;6678.3989440950545;6679.966600166968;6683.13119294508;6872.828179295558;6888.862222755617;6916;6921.8961715575315;6924.065251191025;6685.866282674222;6704.731810727516;6717.1267735194115;6743.325667433218;6749.595024298558 04:00:05 INFO - PROCESS | 20254 | |5;yui.html;783.2911215350108;798.0981490915261;801.2468279816975;807.5719868469713;815.1563132158218;14256.073355231903;14437.711245775092;14502.202378869171;14555.126692398464;14571.781423278659;14941.701165976701;14954.700905981874;15020.098794072363;15060.6987860243;15081.472148474779;902.0753727429404;914.0767824497273;918.6325469812061;933.4166146158651;936.035883040466;928.0255731481951;928.9442633441981;932.6409332407004;935.4901578639658;936.4521754773466;956.8995255498177;963.5423173992333;968.6900191938582;969.5103972493881;971.0580736685404;956.2206801456825;956.4070276428658;957;959.165525992391;959.9232061435104;704.3555147040452;704.5385272646424;705.6718625838959;709.4005565297316;711.2176605733704;14604.269786510631;14692.338844752012;14748.70502589953;14755.26223688822;14762.261886905611;12085.697857553543;12168.878311216951;12253.632391028194;12281.140320177592;12527.874721252761;9859.556319965619;10002.399856008662;10069.949650251701;10127.64553240633;10145.188384929263;3112.3775244950875;3168.1287645897332;3210.4060748761553;3259.8859039933727;3333.8166400847945;45681.08637827225;46751;46846.76576617095;47124;47252.054958900975;8836.690715824916;8937.195652391316;8977.50623715689;9127.178553930178;9192.586333615003;18056.548586285448;18091.185896634684;18224.179911903997;18327.17527711256;18327.816721832613;6859.3140685932;6886.48351373649;7119.323664251888;7172.784816455411;7221.350078492961;4097.221527909687;4109.301418758759;4115.115250221217;4115.97942010294;4154.335306350969;3405.9659403406145;3413.8293085345636;3423.5378223939947;3435.9484607730906;3442.242706604593;588.8527868032992;591.6893630843841;600.5615900392738;603.7977277611961;610.8289678889918;720.8630360231539;726.3753172271842;728.9489735718555;735.7204262380261;744.3672878053611;8504;8638.395312328077;8703.912960870437;8809.911900881038;8881.467111973303;722.7470385365081;742.8440027594265;746.932776050158;759.5632511306021;762.9237076292326;3905.14086900887;4058.5941405859176;4062.30940740069;4064.898377540585;4171.520275168334;58084.12873806896;58538.41461585415;59252;59401.702991484766;59777;51373;52467.73766131145;53020.73489632527;53644.463555364724;53972.46027539753;47682.28476572854;48251.75874120677;48307.516924831005;48581;51666.96666066658;8714.433561818461;8782.077881822317;8798.956005219932;8877.778055548662;9036.683716069905;34453.483197752554;34936;35417.29165416729;35761.821190893876;36517.81741091277;39850.60149398469;42952.57047429611;44181.11637767291;45995.08009839852;46225.768871156775;11052.11583073336;11669.708257293296;11834.289942603471;11884.709058218365;11915.344656044;12305.077119215915;12425.815102679418;13165.012624053043;13369.799453008407;13396.598102056954;11132.443377831238;11232.3260604364;11667.183297169116;11899.524019039141;11906.880931190577;11815.232009919328;11867.347295898464;11893.643190704293;12121.878781212075;12200.694982625506;11198.552057917917;11363.715907102389;11404.714882128013;12104.697382565506;12175.086868485076;9798.51007449639;9933.65232216869;10098.242631802792;10171.7457063574;10286.639967601099;10101.949490252502;10565.313254638424;10581.418022008864;10624.937506249313;10671.46642667848 04:00:05 INFO - PROCESS | 20254 | __end_tp_report 04:00:05 INFO - PROCESS | 20254 | __start_cc_report 04:00:05 INFO - PROCESS | 20254 | _x_x_mozilla_cycle_collect,342 04:00:05 INFO - PROCESS | 20254 | __end_cc_report 04:00:05 INFO - PROCESS | 20254 | __startTimestamp1461754805526__endTimestamp 04:00:05 INFO - PROCESS | 20254 | 04:00:05 INFO - PROCESS | 20254 | ------- Summary: start ------- 04:00:05 INFO - PROCESS | 20254 | Number of tests: 6 04:00:05 INFO - PROCESS | 20254 | 04:00:05 INFO - PROCESS | 20254 | [#0] dojo.html Cycles:165 Average:5613.86 Median:5835.56 stddev:621.78 (10.7%) stddev-sans-first:597.77 04:00:05 INFO - PROCESS | 20254 | Values: 3349.3 3390.1 3420.4 3450.1 3455.0 5588.0 5593.0 5596.6 5624.4 5643.0 5572.9 5596.0 5605.7 5642.4 5654.5 5093.5 5134.2 5136.1 5178.4 5187.2 5056.4 5190.0 5221.4 5241.5 5248.6 5171.8 5177.0 5239.3 5239.6 5253.4 5124.1 5170.8 5202.2 5205.6 5240.7 4920.0 5040.7 5084.0 5167.3 5186.4 5287.8 5307.6 5349.0 5376.0 5378.1 6000.5 6009.8 6043.7 6046.0 6068.6 5809.3 6015.8 6068.8 6076.3 6116.7 5673.2 5689.9 5691.8 5698.5 5729.8 6174.4 6204.9 6209.6 6218.7 6220.8 5762.3 5916.3 5922.3 5932.9 5959.6 6042.7 6060.3 6062.7 6074.6 6096.1 5955.3 5980.1 5987.5 6004.5 6045.8 5852.3 5999.9 6040.2 6073.9 6112.7 4570.5 4577.0 4577.1 4581.9 4599.7 4139.0 4142.6 4144.8 4154.9 4159.5 5577.9 5739.2 5815.9 5833.4 5851.4 6001.9 6037.8 6109.9 6118.0 6120.7 5561.2 5748.4 5808.6 5817.4 5835.6 5127.8 5141.2 5198.5 5247.3 5297.6 6218.5 6219.7 6228.5 6239.3 6242.7 6021.0 6047.9 6059.9 6063.8 6076.5 5983.6 6179.9 6216.8 6301.0 6301.9 5918.3 5951.5 5980.3 6011.5 6040.2 5895.4 6130.1 6137.9 6139.7 6143.3 5866.9 5934.3 5959.2 5980.1 5988.6 5954.3 5985.1 6008.8 6018.4 6020.3 5586.8 5694.8 5845.9 5853.0 5861.6 5898.2 5914.9 5928.7 5948.8 5961.7 5795.1 5797.4 5804.9 5822.0 5831.6 04:00:05 INFO - PROCESS | 20254 | 04:00:05 INFO - PROCESS | 20254 | [#1] ext.html Cycles:180 Average:47962.03 Median:35057.80 stddev:80604.91 (229.9%) stddev-sans-first:80752.29 04:00:05 INFO - PROCESS | 20254 | Values: 510.5 571.8 574.4 601.7 614.0 37028.0 37869.2 37896.2 38121.4 38128.4 40359.8 40475.8 40887.0 40930.8 40974.8 8821.6 8980.0 9024.1 9064.8 9078.8 8808.7 8977.8 9026.1 9026.5 9042.2 9245.9 9273.8 9285.5 9307.6 9355.8 9166.9 9237.2 9283.6 9288.3 9318.9 9039.1 9237.1 9248.6 9261.0 9271.6 41497.4 41785.6 41857.2 41973.2 41994.4 3749.0 3855.5 3856.8 3890.6 4401.8 31617.2 31647.2 31803.8 31865.0 31915.2 3728.2 3760.7 3774.4 3859.3 3873.1 301715.5 302800.0 302951.0 303390.0 303510.0 54910.7 55321.2 67207.7 69124.7 69178.3 60838.4 60928.4 61091.4 61274.7 61289.7 17421.7 17710.9 17742.1 17765.8 17787.0 13529.1 13552.8 13607.9 13670.2 13705.2 19864.8 20469.5 20509.6 20539.9 20570.8 7544.4 7822.2 7829.8 7852.9 8025.2 1064.1 1065.6 1075.7 1077.3 1099.9 28857.4 29289.9 29485.6 29580.7 30091.7 1058.9 1084.2 1110.6 1134.9 1147.0 15049.8 15220.9 15343.6 15366.8 15704.3 338123.0 345796.0 346147.0 347045.0 347438.0 55821.7 56583.4 56602.0 56654.2 56726.4 1455.0 1478.0 1489.0 1497.3 1514.4 29318.3 30109.5 30211.8 30257.4 30609.5 48161.3 48447.3 48639.0 48738.8 48888.5 235760.0 237275.0 237682.0 317134.0 317641.0 33556.3 33686.2 33754.5 34542.7 35012.5 39402.6 40095.6 40298.0 40365.8 40764.8 33873.3 33968.2 34282.5 34545.0 34664.8 33814.0 33958.5 34263.8 34604.8 34627.8 32419.0 34896.0 38078.4 38376.4 38950.0 31654.2 32688.2 33185.5 34902.0 35103.1 22679.8 23261.2 23394.9 23655.5 23711.6 04:00:05 INFO - PROCESS | 20254 | 04:00:05 INFO - PROCESS | 20254 | [#2] jquery.html Cycles:180 Average:25593.14 Median:2860.25 stddev:71688.73 (2506.4%) stddev-sans-first:71864.82 04:00:05 INFO - PROCESS | 20254 | Values: 371.4 385.9 396.0 401.8 402.1 16803.3 18366.0 18937.1 19075.8 19170.7 18095.4 18163.8 18329.5 18431.2 18570.4 5426.3 5614.4 5634.1 5669.9 5686.9 4250.2 5938.2 6175.4 6197.8 6203.8 5872.7 6122.2 6130.0 6138.7 6170.8 6015.1 6064.4 6132.8 6139.8 6147.2 5096.4 5375.3 5399.1 5402.1 5402.1 13424.5 13642.5 13650.0 13701.7 13775.3 2311.9 2318.0 2387.6 2853.3 2867.2 10056.6 10094.2 10387.3 10483.7 12110.6 1591.8 1669.1 1718.1 1721.9 1821.2 60971.0 63622.4 63718.7 64361.7 65282.3 9581.2 9974.7 10144.6 10222.6 10239.5 13768.4 13873.0 13911.2 13917.4 13922.4 7501.2 7574.7 7648.3 7690.3 7718.1 7451.3 7465.6 7526.5 7552.2 7588.2 4285.8 4314.3 4373.1 4575.4 4793.3 1875.8 1974.9 1995.4 2061.4 2074.5 893.6 974.8 979.3 1084.9 1103.2 17658.1 17789.3 17792.8 18126.7 18536.7 942.9 1002.2 1003.1 1021.3 1043.7 9995.2 10454.8 10486.2 10497.1 10578.4 431994.0 434183.0 434854.0 441736.0 444216.0 70839.6 74039.6 74099.6 74472.0 75457.6 1059.3 1083.0 1090.9 1092.1 1108.1 15903.6 16020.4 16282.0 16328.3 16451.2 33876.5 34137.8 34270.3 34911.5 35890.3 49085.8 49237.3 49245.0 49266.0 50086.0 8541.0 8575.8 8594.4 8751.3 8814.4 9447.8 12051.5 12677.2 12872.9 12968.1 10784.2 11026.6 11173.0 11199.3 11228.3 11101.9 11112.0 11207.2 11499.7 11583.7 11599.2 11657.5 11676.9 11817.3 12123.0 8323.1 8385.9 8438.3 8458.5 8646.2 11337.4 11533.9 11540.1 11573.7 11717.5 04:00:05 INFO - PROCESS | 20254 | 04:00:05 INFO - PROCESS | 20254 | [#3] mootools.html Cycles:180 Average:5920.98 Median:540.20 stddev:3131.05 (579.6%) stddev-sans-first:3122.78 04:00:05 INFO - PROCESS | 20254 | Values: 1573.2 1597.8 1805.8 1897.0 1910.9 8188.9 8316.0 8345.2 8593.3 8595.4 8561.3 8597.7 8601.7 8632.3 8636.5 2407.4 2432.5 2433.5 2436.5 2441.9 2464.6 2467.8 2510.5 2516.1 2516.6 2324.2 2372.9 2404.1 2405.1 2430.4 2409.0 2456.6 2464.2 2469.4 2479.4 2446.5 2456.3 2458.6 2462.9 2463.6 8631.5 8677.5 8691.0 8709.6 8710.7 5121.6 5212.6 5252.4 5255.3 5298.8 3402.7 3417.9 3448.3 3463.7 3468.0 1078.2 1130.8 1135.7 1142.0 1150.3 11468.4 11530.5 11553.7 11603.7 11638.1 4421.1 4505.0 4527.1 4540.3 4601.1 9479.9 9496.1 9496.2 9521.1 9538.1 5155.3 5170.4 5170.8 5181.2 5198.1 4092.8 4587.3 4594.6 4628.6 4796.1 3673.3 3739.8 3746.6 3769.7 3807.8 1088.4 1158.9 1165.1 1168.9 1173.8 1444.4 1461.8 1464.3 1465.3 1496.1 7886.2 7934.4 7976.9 7994.3 7997.3 537.5 542.9 545.4 565.6 567.1 6072.6 6073.6 6110.7 6127.2 6188.7 10406.3 10542.2 10584.2 10735.3 10763.6 10354.5 10479.7 10539.9 10562.0 10597.9 8211.5 8255.5 8255.8 8287.8 8308.3 7864.1 7948.8 7959.4 7959.6 7975.0 9310.0 9344.6 9434.2 9529.2 9583.7 9542.0 9560.5 9630.5 9632.3 9779.6 6327.8 6753.4 6964.0 7307.4 7372.7 8088.0 8094.0 8112.2 8138.6 8202.1 7135.6 7316.7 7346.9 7428.2 7496.1 7260.0 7273.6 7333.2 7344.1 7377.6 7374.0 7380.0 7382.7 7405.9 7471.8 6800.7 6912.3 6931.6 6949.8 6959.1 6912.2 6956.3 6963.2 6965.2 6978.9 04:00:05 INFO - PROCESS | 20254 | 04:00:05 INFO - PROCESS | 20254 | [#4] prototype.html Cycles:180 Average:5684.72 Median:6456.42 stddev:1720.42 (26.6%) stddev-sans-first:1678.28 04:00:05 INFO - PROCESS | 20254 | Values: 365.2 370.7 371.8 373.6 376.8 6384.0 6398.9 6429.5 6436.6 6476.3 6328.0 6332.2 6334.6 6344.2 6368.9 4709.6 4806.1 4829.0 4840.1 4917.2 4809.5 4809.9 4815.0 4833.4 4839.0 4779.6 4803.9 4812.3 4815.3 4817.0 4809.0 4819.7 4824.3 4829.7 4830.8 4228.5 4230.8 4233.1 4234.1 4241.3 5839.9 5966.4 5969.1 6001.2 6007.1 5567.8 5598.0 5599.3 5604.7 5609.7 6571.1 6591.2 6601.8 6628.0 6633.1 4654.9 4656.7 4659.7 4664.6 4665.4 7000.9 7040.0 7047.4 7097.8 7109.8 4646.3 4846.2 4847.0 4847.1 4848.7 4876.9 4905.3 4916.1 4919.1 4921.8 5651.5 5651.6 5655.7 5659.8 5666.7 6728.0 6748.8 6788.9 6793.9 6806.1 1719.1 1742.7 1748.3 1751.8 1754.6 1119.8 1142.4 1146.4 1155.7 1166.8 6505.3 6513.6 6522.7 6527.1 6551.5 6989.8 7026.1 7037.9 7038.5 7049.2 6268.8 6366.2 6517.8 6538.9 6584.3 3784.9 3825.3 3830.3 3835.0 3840.9 7256.2 7277.1 7294.8 7310.2 7344.2 7243.1 7245.1 7250.9 7266.4 7280.9 7150.7 7271.4 7356.4 7364.6 7384.9 6997.4 7073.3 7123.8 7127.8 7150.2 6936.4 6949.4 6982.6 7000.3 7012.2 7302.8 7364.0 7367.3 7368.2 7373.2 4986.1 5005.0 5048.4 5050.0 5072.6 6986.1 6994.6 7001.3 7028.2 7056.8 6824.7 6827.6 6837.2 6841.6 6842.1 6832.3 6834.5 6842.9 6845.9 6848.2 6498.1 6632.3 6678.4 6680.0 6683.1 6872.8 6888.9 6916.0 6921.9 6924.1 6685.9 6704.7 6717.1 6743.3 6749.6 04:00:05 INFO - PROCESS | 20254 | 04:00:05 INFO - PROCESS | 20254 | [#5] yui.html Cycles:180 Average:14101.38 Median:45838.08 stddev:16196.73 (35.3%) stddev-sans-first:16211.28 04:00:05 INFO - PROCESS | 20254 | Values: 783.3 798.1 801.2 807.6 815.2 14256.1 14437.7 14502.2 14555.1 14571.8 14941.7 14954.7 15020.1 15060.7 15081.5 902.1 914.1 918.6 933.4 936.0 928.0 928.9 932.6 935.5 936.5 956.9 963.5 968.7 969.5 971.1 956.2 956.4 957.0 959.2 959.9 704.4 704.5 705.7 709.4 711.2 14604.3 14692.3 14748.7 14755.3 14762.3 12085.7 12168.9 12253.6 12281.1 12527.9 9859.6 10002.4 10069.9 10127.6 10145.2 3112.4 3168.1 3210.4 3259.9 3333.8 45681.1 46751.0 46846.8 47124.0 47252.1 8836.7 8937.2 8977.5 9127.2 9192.6 18056.5 18091.2 18224.2 18327.2 18327.8 6859.3 6886.5 7119.3 7172.8 7221.4 4097.2 4109.3 4115.1 4116.0 4154.3 3406.0 3413.8 3423.5 3435.9 3442.2 588.9 591.7 600.6 603.8 610.8 720.9 726.4 728.9 735.7 744.4 8504.0 8638.4 8703.9 8809.9 8881.5 722.7 742.8 746.9 759.6 762.9 3905.1 4058.6 4062.3 4064.9 4171.5 58084.1 58538.4 59252.0 59401.7 59777.0 51373.0 52467.7 53020.7 53644.5 53972.5 47682.3 48251.8 48307.5 48581.0 51667.0 8714.4 8782.1 8799.0 8877.8 9036.7 34453.5 34936.0 35417.3 35761.8 36517.8 39850.6 42952.6 44181.1 45995.1 46225.8 11052.1 11669.7 11834.3 11884.7 11915.3 12305.1 12425.8 13165.0 13369.8 13396.6 11132.4 11232.3 11667.2 11899.5 11906.9 11815.2 11867.3 11893.6 12121.9 12200.7 11198.6 11363.7 11404.7 12104.7 12175.1 9798.5 9933.7 10098.2 10171.7 10286.6 10101.9 10565.3 10581.4 10624.9 10671.5 04:00:05 INFO - PROCESS | 20254 | -------- Summary: end -------- 04:00:05 INFO - PROCESS | 20254 | 04:00:06 INFO - TEST-INFO | 20254: exit 0 04:00:06 INFO - TEST-OK | dromaeo_css | took 1110063ms 04:00:06 INFO - TEST-START | kraken 04:00:06 INFO - operating with platform_type : linux_ 04:00:06 INFO - Initialising browser for kraken test... 04:00:06 INFO - TEST-INFO | started process 20497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr51dcn/profile http://localhost:35204/getInfo.html) 04:00:09 INFO - PROCESS | 20497 | 04:00:09 INFO - PROCESS | 20497 | (process:20573): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:00:10 INFO - PROCESS | 20497 | __metrics Screen width/height:1600/1200 04:00:10 INFO - PROCESS | 20497 | colorDepth:24 04:00:10 INFO - PROCESS | 20497 | Browser inner width/height: 1024/697 04:00:10 INFO - PROCESS | 20497 | __metrics 04:00:11 ERROR - PROCESS | 20497 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:00:12 INFO - TEST-INFO | 20497: exit 0 04:00:12 INFO - Browser initialized. 04:00:12 INFO - Running cycle 1/1 for kraken test... 04:00:12 INFO - TEST-INFO | started process 20624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr51dcn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:14 INFO - PROCESS | 20624 | 04:00:14 INFO - PROCESS | 20624 | (process:20692): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:00:24 INFO - PROCESS | 20624 | RSS: Main: 152047616 04:00:24 INFO - PROCESS | 20624 | 04:00:26 INFO - PROCESS | 20624 | Cycle 1(1): loaded http://localhost:35204/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35204/tests/kraken/driver.html?testName=audio-beat-detection) 04:00:27 INFO - PROCESS | 20624 | RSS: Main: 155701248 04:00:27 INFO - PROCESS | 20624 | 04:00:29 INFO - PROCESS | 20624 | Cycle 1(1): loaded http://localhost:35204/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35204/tests/kraken/driver.html?testName=audio-dft) 04:00:30 INFO - PROCESS | 20624 | RSS: Main: 155836416 04:00:30 INFO - PROCESS | 20624 | 04:00:33 INFO - PROCESS | 20624 | Cycle 1(1): loaded http://localhost:35204/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35204/tests/kraken/driver.html?testName=audio-fft) 04:00:34 INFO - PROCESS | 20624 | RSS: Main: 156401664 04:00:34 INFO - PROCESS | 20624 | 04:00:36 INFO - PROCESS | 20624 | Cycle 1(1): loaded http://localhost:35204/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35204/tests/kraken/driver.html?testName=audio-oscillator) 04:00:36 INFO - PROCESS | 20624 | RSS: Main: 156598272 04:00:36 INFO - PROCESS | 20624 | 04:00:38 INFO - PROCESS | 20624 | Cycle 1(1): loaded http://localhost:35204/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35204/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:00:39 INFO - PROCESS | 20624 | RSS: Main: 156450816 04:00:39 INFO - PROCESS | 20624 | 04:00:42 INFO - PROCESS | 20624 | Cycle 1(1): loaded http://localhost:35204/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35204/tests/kraken/driver.html?testName=imaging-darkroom) 04:00:43 INFO - PROCESS | 20624 | RSS: Main: 156766208 04:00:43 INFO - PROCESS | 20624 | 04:00:46 INFO - PROCESS | 20624 | Cycle 1(1): loaded http://localhost:35204/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35204/tests/kraken/driver.html?testName=imaging-desaturate) 04:00:47 INFO - PROCESS | 20624 | RSS: Main: 156184576 04:00:47 INFO - PROCESS | 20624 | 04:00:49 INFO - PROCESS | 20624 | Cycle 1(1): loaded http://localhost:35204/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35204/tests/kraken/driver.html?testName=json-parse-financial) 04:00:50 INFO - PROCESS | 20624 | RSS: Main: 157347840 04:00:50 INFO - PROCESS | 20624 | 04:00:52 INFO - PROCESS | 20624 | Cycle 1(1): loaded http://localhost:35204/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35204/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:00:52 INFO - PROCESS | 20624 | RSS: Main: 157310976 04:00:52 INFO - PROCESS | 20624 | 04:00:54 INFO - PROCESS | 20624 | Cycle 1(1): loaded http://localhost:35204/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35204/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:00:55 INFO - PROCESS | 20624 | RSS: Main: 158060544 04:00:55 INFO - PROCESS | 20624 | 04:00:57 INFO - PROCESS | 20624 | Cycle 1(1): loaded http://localhost:35204/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35204/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:00:57 INFO - PROCESS | 20624 | RSS: Main: 157499392 04:00:57 INFO - PROCESS | 20624 | 04:01:00 INFO - PROCESS | 20624 | Cycle 1(1): loaded http://localhost:35204/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:01:00 INFO - PROCESS | 20624 | RSS: Main: 157908992 04:01:00 INFO - PROCESS | 20624 | 04:01:03 INFO - PROCESS | 20624 | Cycle 1(1): loaded http://localhost:35204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:01:03 INFO - PROCESS | 20624 | RSS: Main: 157925376 04:01:03 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | Cycle 1(1): loaded http://localhost:35204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35204/tests/kraken/driver.html?testName=ai-astar) 04:01:05 INFO - PROCESS | 20624 | RSS: Main: 159653888 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | __start_tp_report 04:01:05 INFO - PROCESS | 20624 | _x_x_mozilla_page_load 04:01:05 INFO - PROCESS | 20624 | _x_x_mozilla_page_load_details 04:01:05 INFO - PROCESS | 20624 | |i|pagename|runs| 04:01:05 INFO - PROCESS | 20624 | |0;ai-astar;111;108;111;112;113;124;111;112;111;110 04:01:05 INFO - PROCESS | 20624 | |1;audio-beat-detection;154;128;156;169;130;159;151;130;175;128 04:01:05 INFO - PROCESS | 20624 | |2;audio-dft;163;169;162;162;162;164;163;166;165;163 04:01:05 INFO - PROCESS | 20624 | |3;audio-fft;76;76;74;163;73;81;73;75;171;76 04:01:05 INFO - PROCESS | 20624 | |4;audio-oscillator;94;95;142;92;93;93;143;93;93;149 04:01:05 INFO - PROCESS | 20624 | |5;imaging-gaussian-blur;118;118;117;117;118;117;118;118;117;118 04:01:05 INFO - PROCESS | 20624 | |6;imaging-darkroom;149;146;148;147;149;147;147;147;148;146 04:01:05 INFO - PROCESS | 20624 | |7;imaging-desaturate;97;97;97;96;97;96;96;95;95;96 04:01:05 INFO - PROCESS | 20624 | |8;json-parse-financial;59;62;62;59;60;62;62;64;57;57 04:01:05 INFO - PROCESS | 20624 | |9;json-stringify-tinderbox;63;65;64;64;64;66;64;64;63;64 04:01:05 INFO - PROCESS | 20624 | |10;stanford-crypto-aes;78;77;78;78;80;88;79;81;79;79 04:01:05 INFO - PROCESS | 20624 | |11;stanford-crypto-ccm;111;112;113;114;114;115;119;120;124;116 04:01:05 INFO - PROCESS | 20624 | |12;stanford-crypto-pbkdf2;139;149;145;147;147;143;147;145;146;138 04:01:05 INFO - PROCESS | 20624 | |13;stanford-crypto-sha256-iterative;66;69;68;65;69;66;67;67;75;66 04:01:05 INFO - PROCESS | 20624 | __end_tp_report 04:01:05 INFO - PROCESS | 20624 | __start_cc_report 04:01:05 INFO - PROCESS | 20624 | _x_x_mozilla_cycle_collect,835 04:01:05 INFO - PROCESS | 20624 | __end_cc_report 04:01:05 INFO - PROCESS | 20624 | __startTimestamp1461754865735__endTimestamp 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | ------- Summary: start ------- 04:01:05 INFO - PROCESS | 20624 | Number of tests: 14 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | [#0] ai-astar Cycles:10 Average:112.30 Median:111.50 stddev:4.32 (3.9%) stddev-sans-first:4.56 04:01:05 INFO - PROCESS | 20624 | Values: 111.0 108.0 111.0 112.0 113.0 124.0 111.0 112.0 111.0 110.0 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:155.00 stddev:17.79 (11.5%) stddev-sans-first:18.73 04:01:05 INFO - PROCESS | 20624 | Values: 154.0 128.0 156.0 169.0 130.0 159.0 151.0 130.0 175.0 128.0 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.23 (1.4%) stddev-sans-first:2.35 04:01:05 INFO - PROCESS | 20624 | Values: 163.0 169.0 162.0 162.0 162.0 164.0 163.0 166.0 165.0 163.0 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.50 stddev:38.69 (51.2%) stddev-sans-first:40.50 04:01:05 INFO - PROCESS | 20624 | Values: 76.0 76.0 74.0 163.0 73.0 81.0 73.0 75.0 171.0 76.0 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.00 stddev:24.90 (26.8%) stddev-sans-first:25.83 04:01:05 INFO - PROCESS | 20624 | Values: 94.0 95.0 142.0 92.0 93.0 93.0 143.0 93.0 93.0 149.0 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:01:05 INFO - PROCESS | 20624 | Values: 118.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 117.0 118.0 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:1.07 (0.7%) stddev-sans-first:0.97 04:01:05 INFO - PROCESS | 20624 | Values: 149.0 146.0 148.0 147.0 149.0 147.0 147.0 147.0 148.0 146.0 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.50 stddev:0.79 (0.8%) stddev-sans-first:0.78 04:01:05 INFO - PROCESS | 20624 | Values: 97.0 97.0 97.0 96.0 97.0 96.0 96.0 95.0 95.0 96.0 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | [#8] json-parse-financial Cycles:10 Average:60.40 Median:62.00 stddev:2.37 (3.8%) stddev-sans-first:2.46 04:01:05 INFO - PROCESS | 20624 | Values: 59.0 62.0 62.0 59.0 60.0 62.0 62.0 64.0 57.0 57.0 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.88 (1.4%) stddev-sans-first:0.83 04:01:05 INFO - PROCESS | 20624 | Values: 63.0 65.0 64.0 64.0 64.0 66.0 64.0 64.0 63.0 64.0 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.00 stddev:3.13 (4.0%) stddev-sans-first:3.26 04:01:05 INFO - PROCESS | 20624 | Values: 78.0 77.0 78.0 78.0 80.0 88.0 79.0 81.0 79.0 79.0 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:115.50 stddev:4.05 (3.5%) stddev-sans-first:3.91 04:01:05 INFO - PROCESS | 20624 | Values: 111.0 112.0 113.0 114.0 114.0 115.0 119.0 120.0 124.0 116.0 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:146.50 stddev:3.60 (2.5%) stddev-sans-first:3.19 04:01:05 INFO - PROCESS | 20624 | Values: 139.0 149.0 145.0 147.0 147.0 143.0 147.0 145.0 146.0 138.0 04:01:05 INFO - PROCESS | 20624 | 04:01:05 INFO - PROCESS | 20624 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:2.86 (4.2%) stddev-sans-first:2.96 04:01:05 INFO - PROCESS | 20624 | Values: 66.0 69.0 68.0 65.0 69.0 66.0 67.0 67.0 75.0 66.0 04:01:05 INFO - PROCESS | 20624 | -------- Summary: end -------- 04:01:05 INFO - PROCESS | 20624 | 04:01:06 INFO - TEST-INFO | 20624: exit 0 04:01:06 INFO - TEST-OK | kraken | took 60455ms 04:01:06 INFO - SUITE-END | took 1170s 04:01:06 INFO - Completed test suite (00:19:30) 04:01:06 INFO - javascript benchmark 04:01:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3349.346877358915, 3390.118569172016, 3420.401429749796, 3450.1374656335915, 3455.01532063362, 5587.9999999999945, 5593.049181639121, 5596.636218645795, 5624.409437009112, 5643.040683083876, 5572.916406253909, 5596.048671725806, 5605.663660180382, 5642.351129620095, 5654.519365853897, 5093.541581257686, 5134.1528647773075, 5136.075506408845, 5178.378594568639, 5187.221916712486, 5056.418511871145, 5190.0, 5221.425643179247, 5241.5020573045695, 5248.580113590903, 5171.7672704728375, 5177.0, 5239.318888544484, 5239.633225674204, 5253.422123566424, 5124.103281925667, 5170.767315470813, 5202.193659982709, 5205.609579281569, 5240.68555886648, 4920.0, 5040.697558146523, 5084.0, 5167.250748641426, 5186.403563590197, 5287.841364759063, 5307.575393968512, 5349.037173308803, 5376.0, 5378.058839703036, 6000.519958403361, 6009.75960961561, 6043.697815109227, 6046.0, 6068.605540639845, 5809.331926828427, 6015.789447369321, 6068.848278793022, 6076.270847498285, 6116.724747386378, 5673.177389278573, 5689.943100568983, 5691.800786972478, 5698.458646428583, 5729.828105156852, 6174.44430001302, 6204.875902481925, 6209.627422354673, 6218.720157592828, 6220.844478888064, 5762.279715035621, 5916.349201587822, 5922.289325280908, 5932.911006334908, 5959.5828292020005, 6042.667653279024, 6060.303065147476, 6062.696865156725, 6074.605150665281, 6096.055111457731, 5955.34491205967, 5980.102984552352, 5987.491063259585, 6004.459598636056, 6045.78839740607, 5852.297724273115, 5999.940000599938, 6040.244969378828, 6073.908891366633, 6112.694365281718, 4570.542945705402, 4576.954230457719, 4577.107464044546, 4581.931271030937, 4599.747013914267, 4139.0480189555965, 4142.565030671796, 4144.8134833932545, 4154.937675934863, 4159.480064991876, 5577.860553486195, 5739.16782066598, 5815.88368232633, 5833.416658334133, 5851.414858514199, 6001.909971350433, 6037.849053773691, 6109.938900611026, 6118.0, 6120.721420533258, 5561.249231353796, 5748.425157484218, 5808.6224395414165, 5817.38917413674, 5835.562332825055, 5127.820526281562, 5141.203113517411, 5198.454162312978, 5247.2653828464045, 5297.576193904479, 6218.537754694385, 6219.689015549205, 6228.5017198624, 6239.313675495692, 6242.656653883989, 6021.036634138517, 6047.941610218106, 6059.909101363395, 6063.848403789941, 6076.483498902466, 5983.640981540947, 6179.887620228223, 6216.844578885383, 6300.9684951574945, 6301.905471418024, 5918.348981611933, 5951.523878089829, 5980.312264089512, 6011.489023433057, 6040.244969378828, 5895.351511333664, 6130.080487926846, 6137.938620613915, 6139.662318572521, 6143.32423433413, 5866.941330586639, 5934.258217722785, 5959.22530071088, 5980.102984552352, 5988.640681559121, 5954.285485741739, 5985.102234664835, 6008.849778755566, 6018.398160183947, 6020.277566692025, 5586.804461843979, 5694.800681976111, 5845.912311315419, 5852.970735146297, 5861.648301101777, 5898.203742494708, 5914.852128696817, 5928.733207005609, 5948.762049518144, 5961.672108034099, 5795.072788353843, 5797.362290148165, 5804.912926306193, 5821.970890145522, 5831.562632802642], "unit": "score", "name": "dojo.html", "value": 5573.8029944343025}, {"lowerIsBetter": false, "replicates": [510.53286243087575, 571.8055861007257, 574.3509833887706, 601.7322291580247, 613.9570230083893, 37028.0, 37869.24261514771, 37896.24207515848, 38121.42817857734, 38128.42807357892, 40359.79820100903, 40475.79762101193, 40887.0, 40930.79534602323, 40974.7951260244, 8821.558922053904, 8979.95510022449, 9024.097590240955, 9064.773380665503, 9078.77303067422, 8808.691695790649, 8977.820443591125, 9026.052264512231, 9026.458412495238, 9042.23141033013, 9245.861312080324, 9273.814523709521, 9285.535723213847, 9307.62769489223, 9355.766105847375, 9166.908330916673, 9237.214836738885, 9283.582238799236, 9288.349815512916, 9318.86021709675, 9039.096090390974, 9237.12247336502, 9248.6300547978, 9260.953695231481, 9271.629134834599, 41497.377539336936, 41785.58214417847, 41857.162856742696, 41973.160536789095, 41994.37008444876, 3749.0065132739846, 3855.4602355670227, 3856.8071596420345, 3890.6383062998807, 4401.845935392278, 31617.20956976071, 31647.20881977946, 31803.840980794947, 31865.044048678577, 31915.202119947186, 3728.2170744143764, 3760.7179461540222, 3774.358359078963, 3859.3053250415196, 3873.0704630888667, 301715.49142254365, 302800.0, 302951.0, 303390.0, 303510.0, 54910.72544637331, 55321.1701824473, 67207.66396168085, 69124.65437672779, 69178.30821691819, 60838.391616084155, 60928.390716093156, 61091.38908610946, 61274.69362653158, 61289.69355153196, 17421.738673919903, 17710.91144544269, 17742.112894355232, 17765.822341776417, 17787.0, 13529.052966292265, 13552.796708049387, 13607.931960340135, 13670.248136352397, 13705.177689338672, 19864.801351986585, 20469.488262793548, 20509.58980820405, 20539.8973005137, 20570.794292057188, 7544.396448284234, 7822.245322245354, 7829.843403132019, 7852.921470785333, 8025.157358477392, 1064.0627488453426, 1065.5684447798653, 1075.6880504653564, 1077.3105212663902, 1099.9055939340408, 28857.422851543273, 29289.85962863714, 29485.557716634266, 29580.704192957794, 30091.699083009327, 1058.8505334171643, 1084.2410312780928, 1110.6334909479851, 1134.9035331996872, 1147.0, 15049.849501505063, 15220.891341298662, 15343.61640958985, 15366.769498457532, 15704.29330680122, 338123.0, 345796.0, 346147.0, 347045.0, 347438.0, 55821.720891395285, 56583.43416565864, 56602.0, 56654.15018774722, 56726.43273567211, 1454.978175327371, 1478.0, 1488.977665335021, 1497.2663394936403, 1514.3942423030876, 29318.26704332409, 30109.548356775103, 30211.848940756034, 30257.394852102396, 30609.54085688672, 48161.27758083562, 48447.27329089996, 48639.0, 48738.756306218245, 48888.511114888395, 235760.0, 237275.0, 237682.0, 317134.0, 317641.0, 33556.328873422884, 33686.15784605405, 33754.493682595275, 34542.65457345395, 35012.47481287834, 39402.60597394104, 40095.599044009185, 40298.0, 40365.79817100896, 40764.79617601893, 33873.3225335487, 33968.15079623029, 34282.48576271408, 34545.0, 34664.82667586646, 33814.0, 33958.49062264019, 34263.82868085644, 34604.82697586496, 34627.826860865534, 32419.0, 34896.0, 38078.42882356711, 38376.42435363416, 38950.0, 31654.208644784063, 32688.182795429355, 33185.50221746627, 34902.0, 35103.12242193965, 22679.773202268425, 23261.18585849487, 23394.883025584764, 23655.52688946177, 23711.64432533479], "unit": "score", "name": "ext.html", "value": 19148.06000889595}, {"lowerIsBetter": false, "replicates": [371.4298551723105, 385.92860320840646, 396.00235621401947, 401.84930651005874, 402.09729158040204, 16803.327866885324, 18366.0, 18937.147828347723, 19075.809241907577, 19170.712439313404, 18095.366662166827, 18163.81836181641, 18329.54176145597, 18431.17059732312, 18570.35003774868, 5426.321709786267, 5614.438556144394, 5634.098544232924, 5669.914951275734, 5686.857828554278, 4250.213710463574, 5938.228030356047, 6175.444210021097, 6197.783077592285, 6203.813885583417, 5872.735726892279, 6122.204113465244, 6130.0, 6138.7237574309265, 6170.814875553718, 6015.09773533969, 6064.3935606439445, 6132.78535251264, 6139.785107521216, 6147.231596050494, 5096.3884333879805, 5375.274337964363, 5399.136138217867, 5402.081646120169, 5402.135658294694, 13424.463021479129, 13642.522511712043, 13650.0, 13701.725965480735, 13775.311234438339, 2311.872846993415, 2317.9768202317928, 2387.5583017141885, 2853.315204350941, 2867.1828528869382, 10056.648017319432, 10094.192464602815, 10387.27289089764, 10483.73790655232, 12110.636680899499, 1591.761235814637, 1669.0820048973017, 1718.1495159895806, 1721.948341549743, 1821.244183663778, 60971.0, 63622.36377636211, 63718.68140659313, 64361.67819160921, 65282.34717652858, 9581.233501319877, 9974.700758977242, 10144.644937427154, 10222.591096356062, 10239.48802559884, 13768.449262029608, 13873.028887977947, 13911.165330080228, 13917.443302267999, 13922.443102275796, 7501.2123727007875, 7574.659140338698, 7648.349890259279, 7690.269424404784, 7718.0738311401865, 7451.2921272479025, 7465.626718664045, 7526.548407095483, 7552.244775522404, 7588.203238659971, 4285.764282964405, 4314.266574682311, 4373.103513779667, 4575.405197324327, 4793.281007848781, 1875.7655293088364, 1974.8913809740602, 1995.4313020789004, 2061.412497438223, 2074.4917495213767, 893.584483215308, 974.7660561465198, 979.275336251169, 1084.924055316136, 1103.2222283290262, 17658.1170941455, 17789.288428462718, 17792.822071779116, 18126.72809907826, 18536.721949170773, 942.8632848236967, 1002.1581871228203, 1003.0721582536125, 1021.300409219672, 1043.7181960870673, 9995.200383969264, 10454.843177352346, 10486.213533984981, 10497.10774584169, 10578.418186999788, 431994.0, 434183.0, 434854.0, 441736.0, 444216.0, 70839.6458017717, 74039.62980185173, 74099.62950185215, 74472.0, 75457.62271188608, 1059.274397038016, 1082.978340433187, 1090.9290896091888, 1092.0662833277433, 1108.0913650806262, 15903.602409939844, 16020.439284624983, 16282.0, 16328.346866125223, 16451.177441128137, 33876.49185262174, 34137.82931085329, 34270.314593708485, 34911.47632785561, 35890.282194355445, 49085.75457122691, 49237.261441077695, 49245.0, 49266.02935882668, 50086.0, 8541.0, 8575.785605359915, 8594.398392112493, 8751.299896008431, 8814.382993190415, 9447.811043779224, 12051.51793928233, 12677.17598356104, 12872.871271287167, 12968.092233543939, 10784.245102842726, 11026.558937642405, 11173.0, 11199.272047316897, 11228.270162439416, 11101.888981110085, 11112.0, 11207.215494915603, 11499.655010349703, 11583.710407239887, 11599.188056835941, 11657.533698652298, 11676.88323116758, 11817.290962542274, 12123.030157587547, 8323.126071762377, 8385.916140838513, 8438.324934005142, 8458.492490450593, 8646.178613031752, 11337.376444295644, 11533.88466115328, 11540.134489913458, 11573.7106572333, 11717.472713727731], "unit": "score", "name": "jquery.html", "value": 8699.880631269167}, {"lowerIsBetter": false, "replicates": [1573.2055312067407, 1597.784299119619, 1805.7742782152231, 1897.0, 1910.942671719849, 8188.91811081889, 8315.958420207899, 8345.248927596514, 8593.312534997202, 8595.398322117455, 8561.272291855184, 8597.656093756243, 8601.741947741577, 8632.30941524678, 8636.481811091324, 2407.410184504799, 2432.5378178146184, 2433.4646377796857, 2436.488337449138, 2441.914532991346, 2464.6179842124498, 2467.802575793932, 2510.535550923076, 2516.0564788204424, 2516.5973444248925, 2324.198151637691, 2372.9321805187647, 2404.1224952892244, 2405.1341517053847, 2430.3924018995253, 2409.0484258717706, 2456.6437866509345, 2464.1621848571394, 2469.4196863737097, 2479.417336925821, 2446.5473887330722, 2456.250843492734, 2458.6434966929874, 2462.8891699873548, 2463.6427717980973, 8631.482111073356, 8677.479351238882, 8691.043985161627, 8709.564521773886, 8710.695125670634, 5121.564667003309, 5212.556932660728, 5252.36971563411, 5255.316808814868, 5298.761555729963, 3402.6937575618313, 3417.8803741869165, 3448.2758620689683, 3463.7229021678204, 3468.0462872709954, 1078.1644225725047, 1130.8416821644976, 1135.7217481717032, 1141.9714507137305, 1150.2868221702515, 11468.426578671117, 11530.538778448852, 11553.711157221052, 11603.6518904433, 11638.06895448362, 4421.093675796454, 4505.0, 4527.071950250257, 4540.273556230987, 4601.056783359403, 9479.90520094804, 9496.097870702271, 9496.19282361007, 9521.095495927875, 9538.093881081286, 5155.252488389163, 5170.353705786777, 5170.844874653766, 5181.222816577543, 5198.0643484173215, 4092.7748973806133, 4587.3348364486965, 4594.609458196091, 4628.60656844172, 4796.112719146969, 3673.3387990162028, 3739.775613463201, 3746.6440688134585, 3769.7361184717356, 3807.8096095195683, 1088.434014312553, 1158.901493373056, 1165.056304393444, 1168.9298642081503, 1173.7828501727208, 1444.3500424808879, 1461.8245810502808, 1464.2898194375719, 1465.2746890289375, 1496.124767011289, 7886.171951945078, 7934.444588878723, 7976.920230797734, 7994.2805147537, 7997.320227780588, 537.4652221040091, 542.9348478182643, 545.3946119807011, 565.6069032022705, 567.0643438326712, 6072.635641861502, 6073.574849760563, 6110.663913484801, 6127.172831667757, 6188.659623720739, 10406.323588966692, 10542.209334299958, 10584.153267738562, 10735.302205356627, 10763.623273185402, 10354.482275886176, 10479.738006549896, 10539.94730026345, 10562.0, 10597.9470102649, 8211.507309561446, 8255.504669719716, 8255.834883302421, 8287.8342433151, 8308.252257296872, 7864.134945156143, 7948.801279968047, 7959.4030447715495, 7959.641816118405, 7975.003124609424, 9310.0, 9344.579493922654, 9434.198093162158, 9529.190018848198, 9583.664571739955, 9542.0, 9560.474173920502, 9630.47032413224, 9632.32573719861, 9779.559919803769, 6327.841803954938, 6753.358430949052, 6964.025036494793, 7307.41540676734, 7372.705091796268, 8088.029436467662, 8093.959530202312, 8112.22933821286, 8138.552379618941, 8202.138775428493, 7135.607541585055, 7316.670749816378, 7346.853062938604, 7428.182899881117, 7496.100467943882, 7260.0, 7273.563586184846, 7333.230010848784, 7344.118705755343, 7377.557346559223, 7374.0, 7380.0, 7382.741604043833, 7405.925940740523, 7471.775846724607, 6800.727970881109, 6912.343327383891, 6931.584104953719, 6949.7567585134275, 6959.130108736408, 6912.205096413977, 6956.304369563003, 6963.1644202696, 6965.199002114821, 6978.895316570357], "unit": "score", "name": "mootools.html", "value": 4775.721015819673}, {"lowerIsBetter": false, "replicates": [365.1965675513869, 370.6849178198532, 371.81223482141513, 373.63943794238554, 376.83419295509975, 6383.968080159599, 6398.872022559546, 6429.453496452801, 6436.581622194554, 6476.255230648465, 6328.0, 6332.176817013782, 6334.619922804635, 6344.206974128234, 6368.872622547547, 4709.599684026862, 4806.110869489138, 4828.97585512072, 4840.128776820171, 4917.237828136645, 4809.470958194595, 4809.879753006167, 4814.951850481485, 4833.371661683994, 4838.975805120969, 4779.64152688548, 4803.903921921559, 4812.278158276252, 4815.277708343759, 4816.951830481703, 4809.0, 4819.686720363183, 4824.276358546211, 4829.710217386968, 4830.782614782325, 4228.471441069866, 4230.78846057699, 4233.1322078973735, 4234.13200293939, 4241.278982572939, 5839.8540036499, 5966.403359663999, 5969.104634304846, 6001.219841420631, 6007.068904319837, 5567.777288908439, 5598.048331783607, 5599.32808063035, 5604.747786349624, 5609.663420194802, 6571.080048793173, 6591.176102987127, 6601.834954126185, 6628.0, 6633.071370008202, 4654.883627909296, 4656.697314674535, 4659.673822832403, 4664.55686709762, 4665.440147182326, 7000.929990700079, 7040.04959330489, 7047.43620510358, 7097.787066388017, 7109.8222544436285, 4646.3495110684535, 4846.176150054499, 4846.975765121222, 4847.079054979613, 4848.684835485682, 4876.8780780480065, 4905.264210368473, 4916.06594746997, 4919.139150648693, 4921.803127874917, 5651.547876169897, 5651.632643878134, 5655.745491452894, 5659.773609055592, 5666.688332141772, 6727.966360168168, 6748.763793267212, 6788.898166527506, 6793.932060679429, 6806.081179040865, 1719.131838421589, 1742.6863164630488, 1748.2832038864005, 1751.798543167552, 1754.6226212423187, 1119.7536541960756, 1142.360278244186, 1146.39241202163, 1155.6995181252767, 1166.7608140331213, 6505.349465053457, 6513.641749703717, 6522.673866306761, 6527.086207930894, 6551.50863685216, 6989.790306290819, 7026.1217347831525, 7037.859242815218, 7038.507304488637, 7049.224585295613, 6268.780592679234, 6366.236051673829, 6517.804465866032, 6538.934610653928, 6584.308647591934, 3784.9432258516144, 3825.349690552557, 3830.3296923038356, 3835.0412396900774, 3840.8655697050467, 7256.238095000054, 7277.090363704537, 7294.8176295591975, 7310.159331676925, 7344.192138864721, 7243.058402407759, 7245.094363204599, 7250.927490725026, 7266.418686505067, 7280.890786638205, 7150.713971441188, 7271.400291935765, 7356.448266380043, 7364.594947277951, 7384.852302953911, 6997.405220556309, 7073.257307982588, 7123.821904452223, 7127.82180445493, 7150.177729561167, 6936.410405115622, 6949.409300209539, 6982.581045137308, 7000.334968178015, 7012.1935977363255, 7302.780916572511, 7363.963180184065, 7367.300106489874, 7368.189499154982, 7373.152087510005, 4986.077575648516, 5005.049040682259, 5048.368953880765, 5050.0, 5072.619553533574, 6986.126734158231, 6994.5803251805055, 7001.264867189076, 7028.226895041439, 7056.823579410556, 6824.658767061726, 6827.590344579341, 6837.179538455218, 6841.555298905555, 6842.076319696777, 6832.316768323128, 6834.487413444111, 6842.8973565397555, 6845.931540684729, 6848.178218613798, 6498.122753428227, 6632.303608121078, 6678.3989440950545, 6679.966600166968, 6683.13119294508, 6872.828179295558, 6888.862222755617, 6916.0, 6921.8961715575315, 6924.065251191025, 6685.866282674222, 6704.731810727516, 6717.1267735194115, 6743.325667433218, 6749.595024298558], "unit": "score", "name": "prototype.html", "value": 5130.023050600821}, {"lowerIsBetter": false, "replicates": [783.2911215350108, 798.0981490915261, 801.2468279816975, 807.5719868469713, 815.1563132158218, 14256.073355231903, 14437.711245775092, 14502.202378869171, 14555.126692398464, 14571.781423278659, 14941.701165976701, 14954.700905981874, 15020.098794072363, 15060.6987860243, 15081.472148474779, 902.0753727429404, 914.0767824497273, 918.6325469812061, 933.4166146158651, 936.035883040466, 928.0255731481951, 928.9442633441981, 932.6409332407004, 935.4901578639658, 936.4521754773466, 956.8995255498177, 963.5423173992333, 968.6900191938582, 969.5103972493881, 971.0580736685404, 956.2206801456825, 956.4070276428658, 957.0, 959.165525992391, 959.9232061435104, 704.3555147040452, 704.5385272646424, 705.6718625838959, 709.4005565297316, 711.2176605733704, 14604.269786510631, 14692.338844752012, 14748.70502589953, 14755.26223688822, 14762.261886905611, 12085.697857553543, 12168.878311216951, 12253.632391028194, 12281.140320177592, 12527.874721252761, 9859.556319965619, 10002.399856008662, 10069.949650251701, 10127.64553240633, 10145.188384929263, 3112.3775244950875, 3168.1287645897332, 3210.4060748761553, 3259.8859039933727, 3333.8166400847945, 45681.08637827225, 46751.0, 46846.76576617095, 47124.0, 47252.054958900975, 8836.690715824916, 8937.195652391316, 8977.50623715689, 9127.178553930178, 9192.586333615003, 18056.548586285448, 18091.185896634684, 18224.179911903997, 18327.17527711256, 18327.816721832613, 6859.3140685932, 6886.48351373649, 7119.323664251888, 7172.784816455411, 7221.350078492961, 4097.221527909687, 4109.301418758759, 4115.115250221217, 4115.97942010294, 4154.335306350969, 3405.9659403406145, 3413.8293085345636, 3423.5378223939947, 3435.9484607730906, 3442.242706604593, 588.8527868032992, 591.6893630843841, 600.5615900392738, 603.7977277611961, 610.8289678889918, 720.8630360231539, 726.3753172271842, 728.9489735718555, 735.7204262380261, 744.3672878053611, 8504.0, 8638.395312328077, 8703.912960870437, 8809.911900881038, 8881.467111973303, 722.7470385365081, 742.8440027594265, 746.932776050158, 759.5632511306021, 762.9237076292326, 3905.14086900887, 4058.5941405859176, 4062.30940740069, 4064.898377540585, 4171.520275168334, 58084.12873806896, 58538.41461585415, 59252.0, 59401.702991484766, 59777.0, 51373.0, 52467.73766131145, 53020.73489632527, 53644.463555364724, 53972.46027539753, 47682.28476572854, 48251.75874120677, 48307.516924831005, 48581.0, 51666.96666066658, 8714.433561818461, 8782.077881822317, 8798.956005219932, 8877.778055548662, 9036.683716069905, 34453.483197752554, 34936.0, 35417.29165416729, 35761.821190893876, 36517.81741091277, 39850.60149398469, 42952.57047429611, 44181.11637767291, 45995.08009839852, 46225.768871156775, 11052.11583073336, 11669.708257293296, 11834.289942603471, 11884.709058218365, 11915.344656044, 12305.077119215915, 12425.815102679418, 13165.012624053043, 13369.799453008407, 13396.598102056954, 11132.443377831238, 11232.3260604364, 11667.183297169116, 11899.524019039141, 11906.880931190577, 11815.232009919328, 11867.347295898464, 11893.643190704293, 12121.878781212075, 12200.694982625506, 11198.552057917917, 11363.715907102389, 11404.714882128013, 12104.697382565506, 12175.086868485076, 9798.51007449639, 9933.65232216869, 10098.242631802792, 10171.7457063574, 10286.639967601099, 10101.949490252502, 10565.313254638424, 10581.418022008864, 10624.937506249313, 10671.46642667848], "unit": "score", "name": "yui.html", "value": 6571.552437866502}], "name": "dromaeo_css", "value": 7285.204388063397}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 111.0, 112.0, 113.0, 124.0, 111.0, 112.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [154.0, 128.0, 156.0, 169.0, 130.0, 159.0, 151.0, 130.0, 175.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [163.0, 169.0, 162.0, 162.0, 162.0, 164.0, 163.0, 166.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 74.0, 163.0, 73.0, 81.0, 73.0, 75.0, 171.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.8}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 142.0, 92.0, 93.0, 93.0, 143.0, 93.0, 93.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.6}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 148.0, 147.0, 149.0, 147.0, 147.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [59.0, 62.0, 62.0, 59.0, 60.0, 62.0, 62.0, 64.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.4}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 64.0, 64.0, 64.0, 66.0, 64.0, 64.0, 63.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 78.0, 78.0, 80.0, 88.0, 79.0, 81.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [111.0, 112.0, 113.0, 114.0, 114.0, 115.0, 119.0, 120.0, 124.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.8}, {"lowerIsBetter": true, "replicates": [139.0, 149.0, 145.0, 147.0, 147.0, 143.0, 147.0, 145.0, 146.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 68.0, 65.0, 69.0, 66.0, 67.0, 67.0, 75.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1520.3}]} 04:01:06 INFO - Return code: 0 04:01:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:01:07 ERROR - # TBPL SUCCESS # 04:01:07 INFO - Running post-action listener: _resource_record_post_action 04:01:07 INFO - Running post-run listener: _resource_record_post_run 04:01:08 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 498470912; Read time: 208; Write time: 465480 04:01:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 251387904; Read time: 0; Write time: 291984 04:01:08 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 247083008; Read time: 208; Write time: 173496 04:01:08 INFO - Running post-run listener: _upload_blobber_files 04:01:08 INFO - Blob upload gear active. 04:01:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:01:08 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 04:01:08 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'] 04:01:08 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 04:01:08 INFO - (blobuploader) - INFO - Open directory for files ... 04:01:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:01:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:01:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:09 INFO - (blobuploader) - INFO - Done attempting. 04:01:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:01:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:01:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:10 INFO - (blobuploader) - INFO - Done attempting. 04:01:10 INFO - (blobuploader) - INFO - Iteration through files over. 04:01:10 INFO - Return code: 0 04:01:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:01:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:01:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb4daaefd5395b1940b33a7fdc18d895a9dfe74bd4475cc82b1e50d5329541b423cbd42fa6ddec1b43b5d7e50f11099db8ab15645ab95e63ed189bec45a2f16f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91c9b80534f778e293de5c0e57a6e13141304fe0803e3f4554c9dec0ffe71612c7f2b52b99a2bbe9a6db4996fc1eb738fa1e8052f0aa855478ff08813606b2bf"} 04:01:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:01:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:01:10 INFO - Contents: 04:01:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb4daaefd5395b1940b33a7fdc18d895a9dfe74bd4475cc82b1e50d5329541b423cbd42fa6ddec1b43b5d7e50f11099db8ab15645ab95e63ed189bec45a2f16f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91c9b80534f778e293de5c0e57a6e13141304fe0803e3f4554c9dec0ffe71612c7f2b52b99a2bbe9a6db4996fc1eb738fa1e8052f0aa855478ff08813606b2bf"} 04:01:10 INFO - Running post-run listener: copy_logs_to_upload_dir 04:01:10 INFO - Copying logs to upload dir... 04:01:10 INFO - mkdir: /builds/slave/test/build/upload/logs 04:01:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.009187 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-04-27 04:01:10.114230) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:01:10.118077) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436 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/cb4daaefd5395b1940b33a7fdc18d895a9dfe74bd4475cc82b1e50d5329541b423cbd42fa6ddec1b43b5d7e50f11099db8ab15645ab95e63ed189bec45a2f16f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91c9b80534f778e293de5c0e57a6e13141304fe0803e3f4554c9dec0ffe71612c7f2b52b99a2bbe9a6db4996fc1eb738fa1e8052f0aa855478ff08813606b2bf"} build_url:https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011206 build_url: 'https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/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/cb4daaefd5395b1940b33a7fdc18d895a9dfe74bd4475cc82b1e50d5329541b423cbd42fa6ddec1b43b5d7e50f11099db8ab15645ab95e63ed189bec45a2f16f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91c9b80534f778e293de5c0e57a6e13141304fe0803e3f4554c9dec0ffe71612c7f2b52b99a2bbe9a6db4996fc1eb738fa1e8052f0aa855478ff08813606b2bf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:01:10.147723) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:01:10.148514) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461750447.163178-582390436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004357 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:01:10.231290) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:01:10.232066) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:01:10.232742) ========= ========= Total master_lag: 0.23 =========