builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1463308277.84 results: success (0) buildid: 20160515004019 builduid: 642a012a63264eaa81a12f0a5a7a60eb revision: f00f9e754ce71fc5efa3e4334afea5cf6ad6c215 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:17.838436) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:17.838989) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:17.839318) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:17.958553) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:17.958926) ========= 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=574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-15 03:31:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 225M=0s 2016-05-15 03:31:18 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114755 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.127694) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.128035) ========= 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=574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013853 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.193159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.196680) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f00f9e754ce71fc5efa3e4334afea5cf6ad6c215 --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 f00f9e754ce71fc5efa3e4334afea5cf6ad6c215 --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=574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-15 03:31:18,667 truncating revision to first 12 chars 2016-05-15 03:31:18,667 Setting DEBUG logging. 2016-05-15 03:31:18,667 attempt 1/10 2016-05-15 03:31:18,667 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f00f9e754ce7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-15 03:31:19,029 unpacking tar archive at: mozilla-aurora-f00f9e754ce7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628038 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.858472) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.858814) ========= script_repo_revision: f00f9e754ce71fc5efa3e4334afea5cf6ad6c215 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.859205) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.859477) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.870477) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-15 03:31:18.870898) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:19 INFO - MultiFileLogger online at 20160515 03:31:19 in /builds/slave/test 03:31:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:31:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:19 INFO - {'append_to_log': False, 03:31:19 INFO - 'base_work_dir': '/builds/slave/test', 03:31:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:31:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:19 INFO - 'branch': 'Mozilla-Aurora', 03:31:19 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:19 INFO - 'config_files': ('talos/linux_config.py',), 03:31:19 INFO - 'default_actions': ('clobber', 03:31:19 INFO - 'read-buildbot-config', 03:31:19 INFO - 'download-and-extract', 03:31:19 INFO - 'populate-webroot', 03:31:19 INFO - 'create-virtualenv', 03:31:19 INFO - 'install', 03:31:19 INFO - 'run-tests'), 03:31:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:19 INFO - 'download_minidump_stackwalk': True, 03:31:19 INFO - 'download_symbols': 'ondemand', 03:31:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:19 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:19 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:19 INFO - 'installer_path': 'installer.exe', 03:31:19 INFO - 'log_level': 'info', 03:31:19 INFO - 'log_name': 'talos', 03:31:19 INFO - 'log_to_console': True, 03:31:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:19 INFO - 'opt_config_files': (), 03:31:19 INFO - 'pip_index': False, 03:31:19 INFO - 'sps_profile': False, 03:31:19 INFO - 'sps_profile_interval': 0, 03:31:19 INFO - 'suite': 'dromaeojs', 03:31:19 INFO - 'system_bits': '32', 03:31:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:19 INFO - 'title': 'talos-linux64-ix-044', 03:31:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:19 INFO - 'use_talos_json': True, 03:31:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:19 INFO - 'work_dir': 'build'} 03:31:19 INFO - ##### 03:31:19 INFO - ##### Running clobber step. 03:31:19 INFO - ##### 03:31:19 INFO - Running pre-action listener: _resource_record_pre_action 03:31:19 INFO - Running main action method: clobber 03:31:19 INFO - rmtree: /builds/slave/test/build 03:31:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:19 INFO - Running post-action listener: _resource_record_post_action 03:31:19 INFO - ##### 03:31:19 INFO - ##### Running read-buildbot-config step. 03:31:19 INFO - ##### 03:31:19 INFO - Running pre-action listener: _resource_record_pre_action 03:31:19 INFO - Running main action method: read_buildbot_config 03:31:19 INFO - Using buildbot properties: 03:31:19 INFO - { 03:31:19 INFO - "project": "", 03:31:19 INFO - "product": "firefox", 03:31:19 INFO - "script_repo_revision": "production", 03:31:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:31:19 INFO - "repository": "", 03:31:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:31:19 INFO - "buildid": "20160515004019", 03:31:19 INFO - "stage_platform": "linux64-pgo", 03:31:19 INFO - "basedir": "/builds/slave/test", 03:31:19 INFO - "nightly_build": "True", 03:31:19 INFO - "buildnumber": 234, 03:31:19 INFO - "slavename": "talos-linux64-ix-044", 03:31:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:31:19 INFO - "platform": "ubuntu64_hw", 03:31:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:31:19 INFO - "branch": "mozilla-aurora", 03:31:19 INFO - "repo_path": "releases/mozilla-aurora", 03:31:19 INFO - "revision": "f00f9e754ce71fc5efa3e4334afea5cf6ad6c215", 03:31:19 INFO - "pgo_build": "True", 03:31:19 INFO - "builduid": "642a012a63264eaa81a12f0a5a7a60eb", 03:31:19 INFO - "slavebuilddir": "test" 03:31:19 INFO - } 03:31:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:31:19 INFO - Running post-action listener: _resource_record_post_action 03:31:19 INFO - ##### 03:31:19 INFO - ##### Running download-and-extract step. 03:31:19 INFO - ##### 03:31:19 INFO - Running pre-action listener: _resource_record_pre_action 03:31:19 INFO - Running main action method: download_and_extract 03:31:19 INFO - mkdir: /builds/slave/test/build/tests 03:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:19 INFO - https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:31:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:31:23 INFO - Downloaded 1361 bytes. 03:31:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:23 INFO - Using the following test package requirements: 03:31:23 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:23 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:23 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:31:23 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'jsshell-linux-x86_64.zip'], 03:31:23 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:23 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:23 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:31:23 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:31:23 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:23 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:23 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:23 INFO - https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:31:25 INFO - Downloaded 23813292 bytes. 03:31:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:31:26 INFO - Return code: 0 03:31:26 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:26 INFO - https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:31:27 INFO - Downloaded 23813292 bytes. 03:31:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:31:28 INFO - Return code: 0 03:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:28 INFO - https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:31:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:31:29 INFO - Downloaded 10840145 bytes. 03:31:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:31:30 INFO - Return code: 0 03:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:30 INFO - https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:31:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:31:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:31:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:31:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:31:34 INFO - Downloaded 62706158 bytes. 03:31:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:31:34 INFO - mkdir: /builds/slave/test/properties 03:31:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:34 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:34 INFO - Contents: 03:31:34 INFO - build_url:https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:31:34 INFO - Running post-action listener: _resource_record_post_action 03:31:34 INFO - Running post-action listener: set_extra_try_arguments 03:31:34 INFO - ##### 03:31:34 INFO - ##### Running populate-webroot step. 03:31:34 INFO - ##### 03:31:34 INFO - Running pre-action listener: _resource_record_pre_action 03:31:34 INFO - Running main action method: populate_webroot 03:31:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:34 INFO - '--tppagecycles', 03:31:34 INFO - '7'], 03:31:34 INFO - 'tests': ['tsvgm']}}, 03:31:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:31:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:31:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['damp', 'tps']}, 03:31:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'tests': ['damp', 'tps']}, 03:31:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['dromaeo_dom']}, 03:31:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['a11yr', 03:31:34 INFO - 'ts_paint', 03:31:34 INFO - 'tpaint', 03:31:34 INFO - 'sessionrestore', 03:31:34 INFO - 'sessionrestore_no_auto_restore', 03:31:34 INFO - 'tabpaint']}, 03:31:34 INFO - 'other-e10s': {'tests': ['a11yr', 03:31:34 INFO - 'ts_paint', 03:31:34 INFO - 'tpaint', 03:31:34 INFO - 'sessionrestore', 03:31:34 INFO - 'sessionrestore_no_auto_restore', 03:31:34 INFO - 'tabpaint']}, 03:31:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:31:34 INFO - 'ts_paint', 03:31:34 INFO - 'tpaint', 03:31:34 INFO - 'sessionrestore', 03:31:34 INFO - 'sessionrestore_no_auto_restore', 03:31:34 INFO - 'tabpaint']}, 03:31:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:31:34 INFO - 'ts_paint', 03:31:34 INFO - 'tpaint', 03:31:34 INFO - 'sessionrestore', 03:31:34 INFO - 'sessionrestore_no_auto_restore', 03:31:34 INFO - 'tabpaint']}, 03:31:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['a11yr', 03:31:34 INFO - 'ts_paint', 03:31:34 INFO - 'tpaint', 03:31:34 INFO - 'sessionrestore', 03:31:34 INFO - 'sessionrestore_no_auto_restore', 03:31:34 INFO - 'tabpaint']}, 03:31:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['a11yr', 03:31:34 INFO - 'ts_paint', 03:31:34 INFO - 'tpaint', 03:31:34 INFO - 'sessionrestore', 03:31:34 INFO - 'sessionrestore_no_auto_restore', 03:31:34 INFO - 'tabpaint']}, 03:31:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['tsvgx', 03:31:34 INFO - 'tsvgr_opacity', 03:31:34 INFO - 'tart', 03:31:34 INFO - 'tscrollx', 03:31:34 INFO - 'cart']}, 03:31:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:31:34 INFO - 'tsvgr_opacity', 03:31:34 INFO - 'tart', 03:31:34 INFO - 'tscrollx', 03:31:34 INFO - 'cart']}, 03:31:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['tp5o']}, 03:31:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'tests': ['tp5o']}, 03:31:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'talos_options': ['--disable-e10s', 03:31:34 INFO - '--xperf_path', 03:31:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:34 INFO - 'tests': ['tp5n']}, 03:31:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'talos_options': ['--xperf_path', 03:31:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:34 INFO - 'tests': ['tp5n']}}, 03:31:34 INFO - 'talos.zip': {'path': '', 03:31:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:34 INFO - Running post-action listener: _resource_record_post_action 03:31:34 INFO - ##### 03:31:34 INFO - ##### Running create-virtualenv step. 03:31:34 INFO - ##### 03:31:34 INFO - Running pre-action listener: _resource_record_pre_action 03:31:34 INFO - Running main action method: create_virtualenv 03:31:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:34 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:31:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:34 INFO - Using real prefix '/usr' 03:31:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:35 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:37 INFO - Installing pip.................done. 03:31:37 INFO - Return code: 0 03:31:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31:37 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:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:37 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:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:37 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 0x7f1cc8ff8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1410>, '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 0x10b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b27a0>, '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': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', '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:31:37 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:31:37 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:31:37 INFO - Using env: {'DISPLAY': ':0', 03:31:37 INFO - 'HOME': '/home/cltbld', 03:31:37 INFO - 'LANG': 'en_US.UTF-8', 03:31:37 INFO - 'LANGUAGE': 'en_US:en', 03:31:37 INFO - 'LOGNAME': 'cltbld', 03:31:37 INFO - 'MAIL': '/var/mail/cltbld', 03:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:37 INFO - 'MOZ_NO_REMOTE': '1', 03:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:37 INFO - 'NO_EM_RESTART': '1', 03:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:37 INFO - 'PWD': '/builds/slave/test', 03:31:37 INFO - 'SHELL': '/bin/bash', 03:31:37 INFO - 'SHLVL': '1', 03:31:37 INFO - 'TERM': 'linux', 03:31:37 INFO - 'TMOUT': '86400', 03:31:37 INFO - 'USER': 'cltbld', 03:31:37 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', 03:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:37 INFO - '_': '/tools/buildbot/bin/python'} 03:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:37 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:31:37 INFO - Cleaning up... 03:31:37 INFO - Return code: 0 03:31:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:31:37 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:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:37 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:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:37 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 0x7f1cc8ff8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1410>, '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 0x10b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b27a0>, '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': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', '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:31:37 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:31:37 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:31:37 INFO - Using env: {'DISPLAY': ':0', 03:31:37 INFO - 'HOME': '/home/cltbld', 03:31:37 INFO - 'LANG': 'en_US.UTF-8', 03:31:37 INFO - 'LANGUAGE': 'en_US:en', 03:31:37 INFO - 'LOGNAME': 'cltbld', 03:31:37 INFO - 'MAIL': '/var/mail/cltbld', 03:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:37 INFO - 'MOZ_NO_REMOTE': '1', 03:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:37 INFO - 'NO_EM_RESTART': '1', 03:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:37 INFO - 'PWD': '/builds/slave/test', 03:31:37 INFO - 'SHELL': '/bin/bash', 03:31:37 INFO - 'SHLVL': '1', 03:31:37 INFO - 'TERM': 'linux', 03:31:37 INFO - 'TMOUT': '86400', 03:31:37 INFO - 'USER': 'cltbld', 03:31:37 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', 03:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:37 INFO - '_': '/tools/buildbot/bin/python'} 03:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:37 INFO - Downloading/unpacking psutil>=0.7.1 03:31:37 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:31:37 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:31:37 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:31:37 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:31:37 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:31:37 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:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:40 INFO - Installing collected packages: psutil 03:31:40 INFO - Running setup.py install for psutil 03:31:40 INFO - building 'psutil._psutil_linux' extension 03:31:40 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:31:40 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:31:40 INFO - building 'psutil._psutil_posix' extension 03:31:40 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:31:40 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:31:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:40 INFO - Successfully installed psutil 03:31:40 INFO - Cleaning up... 03:31:40 INFO - Return code: 0 03:31:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:31: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:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1cc8ff8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1410>, '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 0x10b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b27a0>, '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': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', '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:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:31:40 INFO - Using env: {'DISPLAY': ':0', 03:31:40 INFO - 'HOME': '/home/cltbld', 03:31:40 INFO - 'LANG': 'en_US.UTF-8', 03:31:40 INFO - 'LANGUAGE': 'en_US:en', 03:31:40 INFO - 'LOGNAME': 'cltbld', 03:31:40 INFO - 'MAIL': '/var/mail/cltbld', 03:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:40 INFO - 'MOZ_NO_REMOTE': '1', 03:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:40 INFO - 'NO_EM_RESTART': '1', 03:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:40 INFO - 'PWD': '/builds/slave/test', 03:31:40 INFO - 'SHELL': '/bin/bash', 03:31:40 INFO - 'SHLVL': '1', 03:31:40 INFO - 'TERM': 'linux', 03:31:40 INFO - 'TMOUT': '86400', 03:31:40 INFO - 'USER': 'cltbld', 03:31:40 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', 03:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:40 INFO - '_': '/tools/buildbot/bin/python'} 03:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:31:40 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:31:40 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:31:40 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:31:40 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:31:40 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:31:40 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:31:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:42 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:31:42 INFO - Installing collected packages: mozsystemmonitor 03:31:42 INFO - Running setup.py install for mozsystemmonitor 03:31:42 INFO - Successfully installed mozsystemmonitor 03:31:42 INFO - Cleaning up... 03:31:42 INFO - Return code: 0 03:31:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1cc8ff8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1410>, '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 0x10b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b27a0>, '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': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', '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:31:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:31:42 INFO - Using env: {'DISPLAY': ':0', 03:31:42 INFO - 'HOME': '/home/cltbld', 03:31:42 INFO - 'LANG': 'en_US.UTF-8', 03:31:42 INFO - 'LANGUAGE': 'en_US:en', 03:31:42 INFO - 'LOGNAME': 'cltbld', 03:31:42 INFO - 'MAIL': '/var/mail/cltbld', 03:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:42 INFO - 'MOZ_NO_REMOTE': '1', 03:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:42 INFO - 'NO_EM_RESTART': '1', 03:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:42 INFO - 'PWD': '/builds/slave/test', 03:31:42 INFO - 'SHELL': '/bin/bash', 03:31:42 INFO - 'SHLVL': '1', 03:31:42 INFO - 'TERM': 'linux', 03:31:42 INFO - 'TMOUT': '86400', 03:31:42 INFO - 'USER': 'cltbld', 03:31:42 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', 03:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:42 INFO - '_': '/tools/buildbot/bin/python'} 03:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:43 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:45 INFO - Downloading blobuploader-1.2.4.tar.gz 03:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:31:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:31:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:45 INFO - Downloading docopt-0.6.1.tar.gz 03:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:31:45 INFO - Installing collected packages: blobuploader, requests, docopt 03:31:45 INFO - Running setup.py install for blobuploader 03:31:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:31:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:31:45 INFO - Running setup.py install for requests 03:31:46 INFO - Running setup.py install for docopt 03:31:46 INFO - Successfully installed blobuploader requests docopt 03:31:46 INFO - Cleaning up... 03:31:46 INFO - Return code: 0 03:31:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1cc8ff8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1410>, '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 0x10b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b27a0>, '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': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', '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:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:31:46 INFO - Using env: {'DISPLAY': ':0', 03:31:46 INFO - 'HOME': '/home/cltbld', 03:31:46 INFO - 'LANG': 'en_US.UTF-8', 03:31:46 INFO - 'LANGUAGE': 'en_US:en', 03:31:46 INFO - 'LOGNAME': 'cltbld', 03:31:46 INFO - 'MAIL': '/var/mail/cltbld', 03:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:46 INFO - 'MOZ_NO_REMOTE': '1', 03:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:46 INFO - 'NO_EM_RESTART': '1', 03:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:46 INFO - 'PWD': '/builds/slave/test', 03:31:46 INFO - 'SHELL': '/bin/bash', 03:31:46 INFO - 'SHLVL': '1', 03:31:46 INFO - 'TERM': 'linux', 03:31:46 INFO - 'TMOUT': '86400', 03:31:46 INFO - 'USER': 'cltbld', 03:31:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', 03:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:46 INFO - '_': '/tools/buildbot/bin/python'} 03:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:46 INFO - Running setup.py (path:/tmp/pip-tRb4qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:46 INFO - Running setup.py (path:/tmp/pip-Fw5Whj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:46 INFO - Running setup.py (path:/tmp/pip-lBMs5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:46 INFO - Running setup.py (path:/tmp/pip-I0rK0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:46 INFO - Running setup.py (path:/tmp/pip-vsisUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:47 INFO - Running setup.py (path:/tmp/pip-pcZZAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:47 INFO - Running setup.py (path:/tmp/pip-6Ie0xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:47 INFO - Running setup.py (path:/tmp/pip-rID9u_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:47 INFO - Running setup.py (path:/tmp/pip-f7AiDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:47 INFO - Running setup.py (path:/tmp/pip-iXBOxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:47 INFO - Running setup.py (path:/tmp/pip-3bBPEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:47 INFO - Running setup.py (path:/tmp/pip-8GZz3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:47 INFO - Running setup.py (path:/tmp/pip-JoAkyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:47 INFO - Running setup.py (path:/tmp/pip-KPwTR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:47 INFO - Running setup.py (path:/tmp/pip-VaTFbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:47 INFO - Running setup.py (path:/tmp/pip-7ChXqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:47 INFO - Running setup.py (path:/tmp/pip-GRhRfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:47 INFO - Running setup.py install for manifestparser 03:31:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:47 INFO - Running setup.py install for mozcrash 03:31:48 INFO - Running setup.py install for mozdebug 03:31:48 INFO - Running setup.py install for mozdevice 03:31:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:31:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:48 INFO - Running setup.py install for mozfile 03:31:48 INFO - Running setup.py install for mozhttpd 03:31:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:48 INFO - Running setup.py install for mozinfo 03:31:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:48 INFO - Running setup.py install for mozInstall 03:31:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:48 INFO - Running setup.py install for mozleak 03:31:48 INFO - Running setup.py install for mozlog 03:31:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:48 INFO - Running setup.py install for moznetwork 03:31:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:48 INFO - Running setup.py install for mozprocess 03:31:49 INFO - Running setup.py install for mozprofile 03:31:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:49 INFO - Running setup.py install for mozrunner 03:31:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:49 INFO - Running setup.py install for mozscreenshot 03:31:49 INFO - Running setup.py install for moztest 03:31:49 INFO - Running setup.py install for mozversion 03:31:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:49 INFO - Cleaning up... 03:31:49 INFO - Return code: 0 03:31:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:49 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 0x7f1cc8ff8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1410>, '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 0x10b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b27a0>, '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': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', '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:31:49 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:31:49 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:31:49 INFO - Using env: {'DISPLAY': ':0', 03:31:49 INFO - 'HOME': '/home/cltbld', 03:31:49 INFO - 'LANG': 'en_US.UTF-8', 03:31:49 INFO - 'LANGUAGE': 'en_US:en', 03:31:49 INFO - 'LOGNAME': 'cltbld', 03:31:49 INFO - 'MAIL': '/var/mail/cltbld', 03:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:49 INFO - 'MOZ_NO_REMOTE': '1', 03:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:49 INFO - 'NO_EM_RESTART': '1', 03:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:49 INFO - 'PWD': '/builds/slave/test', 03:31:49 INFO - 'SHELL': '/bin/bash', 03:31:49 INFO - 'SHLVL': '1', 03:31:49 INFO - 'TERM': 'linux', 03:31:49 INFO - 'TMOUT': '86400', 03:31:49 INFO - 'USER': 'cltbld', 03:31:49 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', 03:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:49 INFO - '_': '/tools/buildbot/bin/python'} 03:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:49 INFO - Running setup.py (path:/tmp/pip-KpPOGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:49 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:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:49 INFO - Running setup.py (path:/tmp/pip-5Eb67Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:49 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:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:49 INFO - Running setup.py (path:/tmp/pip-mdMPaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:50 INFO - Running setup.py (path:/tmp/pip-4CB4_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:50 INFO - Running setup.py (path:/tmp/pip-eSxlxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:50 INFO - Running setup.py (path:/tmp/pip-LMOIJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:50 INFO - Running setup.py (path:/tmp/pip-WQz_xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:50 INFO - Running setup.py (path:/tmp/pip-p0ftWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:50 INFO - Running setup.py (path:/tmp/pip-ixmOc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:50 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:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:50 INFO - Running setup.py (path:/tmp/pip-7h2CMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:50 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:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:50 INFO - Running setup.py (path:/tmp/pip-kceLEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:50 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:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:50 INFO - Running setup.py (path:/tmp/pip-u1NBeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:50 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:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:50 INFO - Running setup.py (path:/tmp/pip-Uuic6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:50 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:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:50 INFO - Running setup.py (path:/tmp/pip-3vSVvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:50 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:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:50 INFO - Running setup.py (path:/tmp/pip-8URU3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:50 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:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:50 INFO - Running setup.py (path:/tmp/pip-Amtwkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:50 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:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:51 INFO - Running setup.py (path:/tmp/pip-WI79o1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:31:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:52 INFO - Downloading blessings-1.6.tar.gz 03:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:53 INFO - Installing collected packages: blessings 03:31:53 INFO - Running setup.py install for blessings 03:31:53 INFO - Successfully installed blessings 03:31:53 INFO - Cleaning up... 03:31:53 INFO - Return code: 0 03:31:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:53 INFO - Reading from file tmpfile_stdout 03:31:53 INFO - Current package versions: 03:31:53 INFO - argparse == 1.2.1 03:31:53 INFO - blessings == 1.6 03:31:53 INFO - blobuploader == 1.2.4 03:31:53 INFO - docopt == 0.6.1 03:31:53 INFO - manifestparser == 1.1 03:31:53 INFO - mozInstall == 1.12 03:31:53 INFO - mozcrash == 0.17 03:31:53 INFO - mozdebug == 0.1 03:31:53 INFO - mozdevice == 0.48 03:31:53 INFO - mozfile == 1.2 03:31:53 INFO - mozhttpd == 0.7 03:31:53 INFO - mozinfo == 0.9 03:31:53 INFO - mozleak == 0.1 03:31:53 INFO - mozlog == 3.1 03:31:53 INFO - moznetwork == 0.27 03:31:53 INFO - mozprocess == 0.22 03:31:53 INFO - mozprofile == 0.28 03:31:53 INFO - mozrunner == 6.11 03:31:53 INFO - mozscreenshot == 0.1 03:31:53 INFO - mozsystemmonitor == 0.0 03:31:53 INFO - moztest == 0.7 03:31:53 INFO - mozversion == 1.4 03:31:53 INFO - psutil == 3.1.1 03:31:53 INFO - requests == 1.2.3 03:31:53 INFO - wsgiref == 0.1.2 03:31:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1cc8ff8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1410>, '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 0x10b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b27a0>, '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': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', '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:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:31:53 INFO - Using env: {'DISPLAY': ':0', 03:31:53 INFO - 'HOME': '/home/cltbld', 03:31:53 INFO - 'LANG': 'en_US.UTF-8', 03:31:53 INFO - 'LANGUAGE': 'en_US:en', 03:31:53 INFO - 'LOGNAME': 'cltbld', 03:31:53 INFO - 'MAIL': '/var/mail/cltbld', 03:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:53 INFO - 'MOZ_NO_REMOTE': '1', 03:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:53 INFO - 'NO_EM_RESTART': '1', 03:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:53 INFO - 'PWD': '/builds/slave/test', 03:31:53 INFO - 'SHELL': '/bin/bash', 03:31:53 INFO - 'SHLVL': '1', 03:31:53 INFO - 'TERM': 'linux', 03:31:53 INFO - 'TMOUT': '86400', 03:31:53 INFO - 'USER': 'cltbld', 03:31:53 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', 03:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:53 INFO - '_': '/tools/buildbot/bin/python'} 03:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:53 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:31:53 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:31:53 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:31:53 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:31:53 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:31:53 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:31:53 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:31:53 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:31:53 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:31:53 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:31:53 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:31:53 INFO - Cleaning up... 03:31:53 INFO - Return code: 0 03:31:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:53 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 0x7f1cc8ff8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1410>, '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 0x10b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b27a0>, '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': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', '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:31:53 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:31:53 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:31:53 INFO - Using env: {'DISPLAY': ':0', 03:31:53 INFO - 'HOME': '/home/cltbld', 03:31:53 INFO - 'LANG': 'en_US.UTF-8', 03:31:53 INFO - 'LANGUAGE': 'en_US:en', 03:31:53 INFO - 'LOGNAME': 'cltbld', 03:31:53 INFO - 'MAIL': '/var/mail/cltbld', 03:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:53 INFO - 'MOZ_NO_REMOTE': '1', 03:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:53 INFO - 'NO_EM_RESTART': '1', 03:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:53 INFO - 'PWD': '/builds/slave/test', 03:31:53 INFO - 'SHELL': '/bin/bash', 03:31:53 INFO - 'SHLVL': '1', 03:31:53 INFO - 'TERM': 'linux', 03:31:53 INFO - 'TMOUT': '86400', 03:31:53 INFO - 'USER': 'cltbld', 03:31:53 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', 03:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:53 INFO - '_': '/tools/buildbot/bin/python'} 03:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:53 INFO - Downloading/unpacking jsonschema 03:31:53 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:31:53 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:31:53 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:31:53 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:31:53 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:31:53 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:31:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:55 INFO - Downloading/unpacking functools32 (from jsonschema) 03:31:55 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:31:55 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:31:55 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:31:55 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:31:55 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:31:55 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:31:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:55 INFO - warning: no files found matching '*.txt' 03:31:55 INFO - no previously-included directories found matching 'build' 03:31:55 INFO - no previously-included directories found matching 'dist' 03:31:55 INFO - no previously-included directories found matching '.git*' 03:31:55 INFO - Installing collected packages: jsonschema, functools32 03:31:56 INFO - Running setup.py install for functools32 03:31:56 INFO - warning: no files found matching '*.txt' 03:31:56 INFO - no previously-included directories found matching 'build' 03:31:56 INFO - no previously-included directories found matching 'dist' 03:31:56 INFO - no previously-included directories found matching '.git*' 03:31:56 INFO - Successfully installed jsonschema functools32 03:31:56 INFO - Cleaning up... 03:31:56 INFO - Return code: 0 03:31:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1cc8ff8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1410>, '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 0x10b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b27a0>, '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': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', '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:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:31:56 INFO - Using env: {'DISPLAY': ':0', 03:31:56 INFO - 'HOME': '/home/cltbld', 03:31:56 INFO - 'LANG': 'en_US.UTF-8', 03:31:56 INFO - 'LANGUAGE': 'en_US:en', 03:31:56 INFO - 'LOGNAME': 'cltbld', 03:31:56 INFO - 'MAIL': '/var/mail/cltbld', 03:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:56 INFO - 'MOZ_NO_REMOTE': '1', 03:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:56 INFO - 'NO_EM_RESTART': '1', 03:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:56 INFO - 'PWD': '/builds/slave/test', 03:31:56 INFO - 'SHELL': '/bin/bash', 03:31:56 INFO - 'SHLVL': '1', 03:31:56 INFO - 'TERM': 'linux', 03:31:56 INFO - 'TMOUT': '86400', 03:31:56 INFO - 'USER': 'cltbld', 03:31:56 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', 03:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:56 INFO - '_': '/tools/buildbot/bin/python'} 03:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:56 INFO - Downloading/unpacking flake8 03:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:31:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:31: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:31: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:31: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:31: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:31: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:31: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:31:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:31:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:31: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:31: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:31: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:31: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:31: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:31: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:31:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:31: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:31: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:31: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:31: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:31: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:31: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:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:31:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:58 INFO - no previously-included directories found matching 'docs/_build' 03:31:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:31:59 INFO - Running setup.py install for pep8 03:31:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:59 INFO - no previously-included directories found matching 'docs/_build' 03:31:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:31:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:31:59 INFO - Cleaning up... 03:31:59 INFO - Return code: 0 03:31:59 INFO - Running post-action listener: _resource_record_post_action 03:31:59 INFO - Running post-action listener: _start_resource_monitoring 03:31:59 INFO - Starting resource monitoring. 03:31:59 INFO - ##### 03:31:59 INFO - ##### Running install step. 03:31:59 INFO - ##### 03:31:59 INFO - Running pre-action listener: _resource_record_pre_action 03:31:59 INFO - Running main action method: install 03:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:59 INFO - Reading from file tmpfile_stdout 03:31:59 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:59 INFO - Reading from file tmpfile_stdout 03:31:59 INFO - Output received: 03:31:59 INFO - Usage: mozinstall [options] installer 03:31:59 INFO - Options: 03:31:59 INFO - -h, --help show this help message and exit 03:31:59 INFO - -d DEST, --destination=DEST 03:31:59 INFO - Directory to install application into. [default: 03:31:59 INFO - "/builds/slave/test"] 03:31:59 INFO - --app=APP Application being installed. [default: firefox] 03:31:59 INFO - mkdir: /builds/slave/test/build/application 03:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:32:15 INFO - Reading from file tmpfile_stdout 03:32:15 INFO - Output received: 03:32:15 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:15 INFO - Running post-action listener: _resource_record_post_action 03:32:15 INFO - ##### 03:32:15 INFO - ##### Running run-tests step. 03:32:15 INFO - ##### 03:32:15 INFO - Running pre-action listener: _resource_record_pre_action 03:32:15 INFO - Running main action method: run_tests 03:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:15 INFO - Python 2.7.3 03:32:15 INFO - Return code: 0 03:32:15 INFO - grabbing minidump binary from tooltool 03:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1410>, '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 0x10b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:32:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:32:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:15 INFO - Return code: 0 03:32:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:32:16 INFO - Return code: 0 03:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:32:16 INFO - Using env: {'DISPLAY': ':0', 03:32:16 INFO - 'HOME': '/home/cltbld', 03:32:16 INFO - 'LANG': 'en_US.UTF-8', 03:32:16 INFO - 'LANGUAGE': 'en_US:en', 03:32:16 INFO - 'LOGNAME': 'cltbld', 03:32:16 INFO - 'MAIL': '/var/mail/cltbld', 03:32:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:16 INFO - 'MOZ_NO_REMOTE': '1', 03:32:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:16 INFO - 'NO_EM_RESTART': '1', 03:32:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:16 INFO - 'PWD': '/builds/slave/test', 03:32:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:16 INFO - 'SHELL': '/bin/bash', 03:32:16 INFO - 'SHLVL': '1', 03:32:16 INFO - 'TERM': 'linux', 03:32:16 INFO - 'TMOUT': '86400', 03:32:16 INFO - 'USER': 'cltbld', 03:32:16 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718', 03:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:16 INFO - '_': '/tools/buildbot/bin/python'} 03:32:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:32:16 INFO - mozversion application_buildid: 20160515004019 03:32:16 INFO - mozversion application_changeset: f00f9e754ce71fc5efa3e4334afea5cf6ad6c215 03:32:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:32:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:16 INFO - mozversion application_name: Firefox 03:32:16 INFO - mozversion application_remotingname: firefox-dev 03:32:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:16 INFO - mozversion application_vendor: Mozilla 03:32:16 INFO - mozversion application_version: 48.0a2 03:32:16 INFO - mozversion platform_buildid: 20160515004019 03:32:16 INFO - mozversion platform_changeset: f00f9e754ce71fc5efa3e4334afea5cf6ad6c215 03:32:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:16 INFO - mozversion platform_version: 48.0a2 03:32:16 INFO - using testdate: 1463308336 03:32:16 INFO - actual date: 1463308336 03:32:16 INFO - starting webserver on 'localhost:39400' 03:32:16 INFO - SUITE-START | Running 2 tests 03:32:16 INFO - TEST-START | dromaeo_css 03:32:16 INFO - operating with platform_type : linux_ 03:32:16 INFO - Initialising browser for dromaeo_css test... 03:32:16 INFO - TEST-INFO | started process 5386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmd6cDD/profile http://localhost:39400/getInfo.html) 03:32:20 INFO - PROCESS | 5386 | __metrics Screen width/height:1600/1200 03:32:20 INFO - PROCESS | 5386 | colorDepth:24 03:32:20 INFO - PROCESS | 5386 | Browser inner width/height: 1024/697 03:32:20 INFO - PROCESS | 5386 | __metrics 03:32:21 ERROR - PROCESS | 5386 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:32:22 INFO - TEST-INFO | 5386: exit 0 03:32:22 INFO - Browser initialized. 03:32:22 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:22 INFO - TEST-INFO | started process 5479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmd6cDD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:34 INFO - PROCESS | 5479 | RSS: Main: 142000128 03:32:34 INFO - PROCESS | 5479 | 03:33:25 INFO - PROCESS | 5479 | 1463308405454 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:35:32 INFO - PROCESS | 5479 | Cycle 1(1): loaded http://localhost:39400/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39400/tests/dromaeo/cssquery-ext.html) 03:35:34 INFO - PROCESS | 5479 | RSS: Main: 254140416 03:35:34 INFO - PROCESS | 5479 | 03:38:36 INFO - PROCESS | 5479 | Cycle 1(1): loaded http://localhost:39400/tests/dromaeo/cssquery-ext.html (next: http://localhost:39400/tests/dromaeo/cssquery-jquery.html) 03:38:36 INFO - PROCESS | 5479 | RSS: Main: 220049408 03:38:36 INFO - PROCESS | 5479 | 03:41:38 INFO - PROCESS | 5479 | Cycle 1(1): loaded http://localhost:39400/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39400/tests/dromaeo/cssquery-mootools.html) 03:41:39 INFO - PROCESS | 5479 | RSS: Main: 219389952 03:41:39 INFO - PROCESS | 5479 | 03:44:41 INFO - PROCESS | 5479 | Cycle 1(1): loaded http://localhost:39400/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39400/tests/dromaeo/cssquery-prototype.html) 03:44:41 INFO - PROCESS | 5479 | RSS: Main: 214614016 03:44:41 INFO - PROCESS | 5479 | 03:47:44 INFO - PROCESS | 5479 | Cycle 1(1): loaded http://localhost:39400/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39400/tests/dromaeo/cssquery-yui.html) 03:47:44 INFO - PROCESS | 5479 | RSS: Main: 212295680 03:47:44 INFO - PROCESS | 5479 | 03:50:47 INFO - PROCESS | 5479 | Cycle 1(1): loaded http://localhost:39400/tests/dromaeo/cssquery-yui.html (next: http://localhost:39400/tests/dromaeo/cssquery-dojo.html) 03:50:47 INFO - PROCESS | 5479 | RSS: Main: 258433024 03:50:47 INFO - PROCESS | 5479 | 03:50:47 INFO - PROCESS | 5479 | __start_tp_report 03:50:47 INFO - PROCESS | 5479 | _x_x_mozilla_page_load 03:50:47 INFO - PROCESS | 5479 | _x_x_mozilla_page_load_details 03:50:47 INFO - PROCESS | 5479 | |i|pagename|runs| 03:50:47 INFO - PROCESS | 5479 | |0;dojo.html;3324.5345651608777;3385.1367901185195;3407.2844702612456;3414.539037229973;3424.7773894696843;5588.748506317215;5594.804181853636;5605.635633683808;5607.635503692257;5621.77512899484;5593.944060559394;5600.27196464459;5635.830925072254;5647.463490968362;5648.604597678164;4907.6073914086965;5113.769880355393;5147.7683504242395;5233.345831771028;5256.080185967459;5070.062038522867;5099.133147364957;5099.286099946011;5099.71951542665;5105.642605017651;5125.692458452486;5169.147090730025;5213.556847667953;5214.400343960437;5245.763940622662;5174.404943431516;5179.637425380225;5190.273361729361;5196.272521846944;5221.399539053001;4983.352164218629;5068.341115654978;5077.720725360104;5100;5142.177251639757;5416.647917885364;5450.781968721247;5455.236266922594;5474;5487.478689524489;5995.550333724988;5997.610155339889;6016.548758843061;6022.819315420545;6025.578209525291;5947.137665038588;5985.431384018511;6035.547333949971;6058.1518587397795;6063.54523410746;5496.615236933416;5543.085390910495;5548.91676624855;5552.555795536347;5557.360903496069;5891.911621325684;6041.486473649701;6042.546808989343;6048.516118710492;6053.273607167168;5892.941070589325;5951.4048595141;5957.702114894238;5965.284165900033;5982.192404025488;5984.102384642339;6009.969950150221;6010.609310394811;6018.097285407136;6030.095485677183;5780.335261444903;5906.793262235801;5991.041433370639;6004.789832355934;6010.188624535632;5974.4324289192455;5985.521158307325;5989.101634754822;5991.221141251609;6027.578069535178;4533.682642215079;4537.682362234678;4544.568266014723;4547.954520454819;4579.877929907194;3953.0512676957323;3960.663343615825;4069.5726948670554;4071.877843664695;4109.239790638741;5702.0591602385975;5726.570507211975;5728.255326807572;5729.1119876419225;5752.02215623345;6022.518198544106;6026.6986650667295;6029.457348838626;6032.6983650818165;6032.969835150796;5605.635633683797;5609.074502707008;5660;5661.830145095653;5669.489745922804;4955.281484184773;4993.675411098339;5000.39995200571;5003.574696150868;5026.29631851541;6216.875662486816;6227.501799856001;6254.468370188585;6254.6247225166635;6256.186695729526;5802.912956305743;5934.376890426443;6012.158297838394;6046.425589568984;6047.365026672312;6202.772194263163;6211.068339749074;6229.937700623117;6233.002719564848;6238.937610623836;5719.971400142973;5878.588498805214;5885.470307672159;5892.057270836645;5913.113033045078;6016.187814644967;6061.15143879866;6104.053871649901;6114.023656277781;6141.6007959482495;5821.446962538552;5866.911996319973;5867.354590994902;5867.442592953663;5869;5706.971465142814;5750.827475175752;5806.187133801187;5820.621659592113;5841.357450680337;5744.310682718101;5759.39526349744;5760.0783874579865;5760.308762948473;5792.942070579409;5854.970725146347;5858.619189752652;5871.089981052944;5881.794137205177;5889.322727886348;5568.415316391721;5654.123610840326;5678.858028549154;5756.165356023437;5784.363719990713 03:50:47 INFO - PROCESS | 5479 | |1;ext.html;668.5086461450834;669.3039239191241;673.589110642508;678.582671656931;750.997418446374;32494.67505324946;39994;40495;40876.38685419714;40886.59113408865;43132.35301470481;43627.34558981618;44163.55836441635;44178.779106104506;44192.779036104774;8421.15788421159;8866.379353445262;9056.366054376196;10520.000599943032;10735.892641073568;10547.789044219111;10705.304155229886;10707.411092389915;10708.089812365959;10713.678589642323;10684.839727404094;10769.676909692682;10789.082927951134;10789.40658263799;10806.243562950596;8523.105073967268;8718;10644.467776611138;10665.520051597698;10799.514021869034;10770.676879693621;10890;10899.782004359948;10905.18211134168;10905.454727263685;41583.792081039704;41913.16173676509;41987.37018944718;42276.577234227574;42403.15193696109;3703.129764505339;3707.961770704207;3867.7485963412287;3922.352811786052;4355.12897420514;34043.829780851185;34207.4868876967;34648.480272795925;35278.64721352805;35998.46002309967;4443.777811109464;4492.168948744493;4554.8861278467975;4563.977180114078;4645.419322584677;355732;356202;359579;360394;362660;41010.9747256321;68895.3110468899;69057.65471172713;69476.6526167366;69486.65256673786;37753.81123094367;37932.81033594815;38040;38273.23453530914;38467.42298865519;17614;17796.199171037333;17802.732959005625;17802.732959005625;17809.287628494974;13805.309734513234;15418.537443876701;15787.842121578868;15815;15824.92087539555;9404.717858464257;9446.811063778687;9459.810803783887;9520.571574279174;9542.761430964143;3670.541182352206;3713.9071523211596;3738.383166777451;3771.30230907283;3809.733318667722;1126.9887301127048;1204.8313236146946;1209.594785746767;1211.1279878487476;1241.720612862117;32842.50736238958;32936.3412731744;34315.82842085774;34404.82797585996;34451.4832277516;1179.9085845592792;1194.707296712311;1227.8096894981293;1244.9937750311371;1302.5636411801963;17799;17873.910630447026;17976.91011544934;18027.909860450614;18212.908935455238;516232;518733;521767;523311;523658;63566.36433635605;64330.356696432435;64389.03416448757;64396.356036439975;64471.35528644654;1478.719043381754;1493.2235237676348;1511.9773203401958;1535.9078455292718;1633.5099470158905;31439.84280078585;33022;33240.501392479615;33941;34075.82962085273;50729.746351268004;51117.23324150066;51205.23192152046;51205.231921521954;51221.48778512167;297889;299475;300266;301250;303166;28712.569311460764;49273;50196.24705629492;50805.49194508156;50975.49024509856;49142.26286605632;49353.75323123361;49401;50210.74894625504;50780.492195077575;39074.02314942149;40395.394069089576;40636.59363406446;40756.38865416962;41185.38221926614;42395.5760442404;43709.78145109254;43766;44033;44684.55315446804;46685.766571166925;47226.29160562663;47421;47877.28184077172;48011.519884800706;38166.80916595399;40882.1823563533;40964.79517602512;41434.171316572894;41469;30096.84951575228;30700.84649576827;31035.224119397197;31096.378072438878;31445 03:50:47 INFO - PROCESS | 5479 | |2;jquery.html;431.60508135056426;433.5989209980769;434.2877680603808;443.984460543881;449.8740352701243;18173.818261817378;18475.722864157047;18655.3470628528;19213;20172.293969711063;19247.326343577977;19521.21915123397;20247.898760506214;20249.696254556195;20270.18919243232;5688.459596338362;5691.943080569204;5840.678762668052;5847.210626565402;5848.210491583645;5755.539556835464;5801.44886235809;5802.419758024185;5808.796692115777;5816.82549523515;5664.54683625309;5758.481736643701;5807.2160258365;5821.592488525805;5826.650400975955;5773.797917072903;5774.971125144369;5777.335606405233;5789.305283366002;5792.68140252286;5188.8183913563225;5213.5829133669595;5232.73836308183;5240.213967904807;5240.79036838526;22941.655875161887;22998.19506317271;23149.88425057881;23312.950917208596;23337.183198588136;2700.3114205877573;2732.6037724529833;2732.6584176977876;3015;3077.1691643256418;14454.85545144556;14787.40850365984;14820;14906.329215185342;15387.307571159325;2066.442060643633;2080.833533317331;2086.5931143427038;2099.0973881231066;2159.2442645074257;58261.417385826026;62736.37263627397;73766;73791.63104184499;81710.59144704299;11039.889601104047;11529.308241505369;11694.590689325832;11789.115816313812;11878.821817672742;13792.241426721626;16625.91687041581;16735.246913888903;16760;16765.580860478585;8582.570871456526;8618.482891026559;8656.78358041054;8736.12638736134;8757.605907734167;8431.915680843236;8445.831083378422;8452.915470845335;8544.40189186751;8802.91197088021;5048.242763585418;5051;5072.923906141411;5074.5940324774665;5161.974190129101;2046.1099421751585;2064.349729835097;2077.542940553076;2098.475381154711;2105.809698307066;1040.2198351236573;1042.4006196437078;1068.9091427228618;1111.0445017285128;1123.1239633086207;18803.81196188048;19152.521186970436;19208.327708530414;19492.415227543195;19636.90181549083;1073.6886302972207;1074.6023971130733;1090.9890901091046;1101.7631209290041;1155.283724091069;10669.893301067044;11110.500027498781;11123.944380278046;11257;11296.378699171624;383652.4904252877;387455;389991;532307;533320;77591.61204194056;82392.58803705942;84756.57621711976;85041.14958850456;86189;1109.4120116338354;1140.3898914081092;1148.9885101149048;1160.9303441793688;1171.2035815645272;16684.749728754323;16847.747283790508;17029.48911532656;17049.82950170532;17068;36928.81535592305;37023;40377.596224037385;40713.38929916113;42942;60725.39274607197;60894;61035.38964610475;61378.38621613727;61454.38545614487;8451.8732219018;8472.364572656952;8507.489550626982;8542.914570854213;8598.61306241233;9388.436693798394;13556.457741690221;13614.455421783414;13750.793738093736;13882.51411200603;12097.153199275966;12152.513899444277;12229.449674764835;12244.387780610756;12331.938340308241;11584.47869845842;11862.22895511789;11864.644060677849;11898.048156147313;12367.257964522158;11600.419979001184;11778.116641252112;11833;12157.69605759863;12186.086043546948;8671.523066231166;8705.956470217609;8730.388872778845;8814.633731771586;8904.688335908211;12001.339926304137;12583.93708031454;12606.55877044299;12618.55835045769;12875.291858947849 03:50:47 INFO - PROCESS | 5479 | |3;mootools.html;1387.8265216847894;1570.7094187575299;1574.5355120239533;1776.7512548243249;1894.0813705352894;8272.66909323627;8526.872096918543;8555.443896146746;8574.056853746082;8574.914250857497;8354.415190936637;8576.914230857705;8583.18459746323;8585.742427727162;8595.226429621332;2113.3448630924463;2152.461884528868;2386.152915714922;2387.665726798254;2412.0351859256352;2377.7741114594087;2388.593939030369;2403.399150212447;2404.1705611563984;2405.530921470314;2243.102758896438;2271.681964524968;2322.4077860145726;2334.9883250583725;2336.4509340305017;2076.8442366822474;2125.288028510443;2345.636426353918;2359.7994170495526;2408.638704194367;2390.115657206827;2412.8552286862846;2420.47959688666;2420.8305418620703;2421.8062554995736;8455.788605284855;8542.487450752975;8565.743027709179;8567.614457349435;8568.400211985163;5275.551578115865;5301.125314323132;5359.330083739533;5362.222477740745;5431.321084864392;3709.703223742094;3728.179800443898;3736.3834967230373;3775.7923314217705;3867.903302417462;1197.233770386953;1200.9219400738923;1211.9151659383847;1221.5663439479035;1266.4807428954084;12595.559155429608;12619.936900315439;12660.493580256778;12666.430010649543;12670.49318027287;4797.56821886032;4832.879178020507;4891.951080489221;4919.557239848431;4927.605791536668;10692.518836652369;10729.946350268356;10732.624358147428;10741.624043158452;10747.032767051003;5501.697406642593;5556.16657501378;5566.526845218202;5566.888662226733;5571.247881536022;4264.061906380592;4674.065186962621;4724.669273150916;4776.928346074812;4783.6651434399255;4146.813393397304;4153.771542565128;4220.092680073799;4250.128723611652;4281.336392859112;1346.1317450244537;1348.5886804524714;1351.1487762709626;1355.4510423278589;1375.77987521996;841.2638940926689;848.3298194426334;942.8868535775614;949.3070058857073;951.6050838901779;5920.733566989496;6187.783427580013;6200.720967556471;6208.751649933952;6245.437910587978;1007.2596641468515;1007.9496025198711;1033.8035773203067;1045.325764881647;1072.927072927073;4195.119025004783;4280.379344994958;4284.828606855754;4308.375285583573;4309.956900431018;10648.14814814813;10771;10910.563577456813;10914.672559823219;10915.945420273007;10369.325993810378;10949.671509854557;11126.332420054823;11131.499082541304;11152.16358773079;8245.093039765621;8340.29107525867;8380.664773409117;8436.873446898302;8448.535330556755;5885.852853678521;6044.304904935989;6076.574639775174;6100.969495152496;6182.69086545662;9500;9659.178969787366;9746.269029822934;9755.707328779865;9777.120059194707;9584.856227156459;9908.108270255712;10172.186225101826;10217.233707472118;10359.119474844421;7029.9648501757165;7247.746328878464;7385.446091543263;7455.329020388191;7561.281678240558;8067.959660201662;8069.112397636372;8075.596220189084;8076.313513351196;8094.757157285291;7134.46491513149;7225.458090643117;7243.818904527429;7297.963510182628;7310.853782924418;7114.679839407136;7180.820479488055;7290.927090729237;7757.612119393895;7871.33093687043;6807.251202367636;6830.863382732218;6846.246912839484;6847.691853866489;6859.862802743817;5296.602754793329;5326.680399176062;5435.483629055233;5558.333000040021;5655.745491452977;5446.346438427414;5546.639468434539;5639.689817060101;5656.43435656431;5692.7722891083895 03:50:47 INFO - PROCESS | 5479 | |4;prototype.html;334.1262598305432;359.7517712778183;365.50474107584205;367.42131143449063;369.3112345475685;6363.649999250045;6439.452646525039;6453.386928241815;6456.870862582751;6490.188726409199;6068.57519973602;6234.251889773233;6354.205724284465;6379.776707815227;6419;4893.7063776173545;4932.4081110266725;4933.087378834927;4934.654574179809;4941.036497882897;4917.4836642152595;4923.876903077434;4942.851714448572;4946.15915294399;4953.207486802113;4654.4647365553055;4724.063134115014;4744.739039352834;4789.161896668069;4858.46556878743;4833.371661683994;4835.879103022453;4858.975705121469;4861.708297502126;4868.78090485929;4267.743935363857;4268.9786551067045;4275.828966841323;4281.957180428187;4286.421333120051;6115.785947491817;6143.877122457526;6159.3224745277985;6159.568830181889;6166.722497487579;5734.627249228787;5740.196372507852;5741.397153298927;5750.108733146369;5750.281214848144;6579.374959378852;6791.592504449749;6793.864122717518;6807.353301436356;6818.897716534256;4697.647676424282;4711.387519622427;4715.95284047162;4722.952770472286;4724.834630787906;7050.259722729143;7111.217766045731;7133.678984445713;7134.32223938725;7151.2848715128075;4804.711717296974;4807.78364973577;4808.447028591757;4822.71063736177;4832.057748739033;4878.317035615017;4878.756062196876;4883.4139903211135;4885.5847252983185;4886.120498310267;5477.972610137003;5619.381867994517;5672.234248376499;5677.687727174963;5683.886322273532;6797.116374871235;6797.864042719118;6821.2155602106395;6822.249552549216;6841.247462779091;1678.6642671465756;1682.2850288627528;1686.9915650421915;1689.923953422099;1691.357284231984;1048.673428113437;1173.202222488699;1173.6420391780418;1182.5210789630214;1183.23681225609;6478.902816457757;6504;6515.837104072341;6612.537122401386;6619.5035372347265;6969.895451568231;6977.825554361181;6982.092327997328;6994.370506654425;6999.895001574981;6596.670166491656;6602.207735071726;6605.042268870987;6609.405153536205;6613.437857782046;3688.1517251032415;3724.5530536335814;3772.43413487979;3772.5472943246436;3775.0562359410146;7330.853382932311;7350.963245183847;7363.48455608113;7372.410207183412;7404.518706284074;7215.71137154508;7232.891506627405;7243.529170603894;7245.239249878792;7247.383972362408;7379.188289288281;7396.519226250277;7398.038255026812;7404.592747398837;7410.370118539984;6884.242733299233;7063.223045465097;7066.222715501393;7069.081019467436;7069.611171385417;6950.339717726808;6951.16586009682;6959.826004349932;6967.756128535477;6989.47578931572;7358;7364.3372096511575;7370;7379.2251813558805;7386.778396648109;4689.648276379217;4690.249560070372;4704.6236301096515;4706.8819031435305;4717.410323709536;6828.180618325832;7014.684339204646;7026.437884969088;7027.859442811217;7028.8945665814035;6820.556663817035;6853.657317134223;6854.588724676535;6858.657067146523;6876.106106206161;6855.794326170223;6906.689198986158;6918.411934985381;6920.757773477904;6922.861542769016;6658.700358483977;6680.3987641112535;6721.563098398588;6724.462043036643;6729.091572637827;6713.395794378529;6850.3149685033095;6856;6881.724731010904;6885.2770459101075;6432.710528026344;6600.702968366339;6606.141201643755;6728.125343705287;6740.12378390806 03:50:47 INFO - PROCESS | 5479 | |5;yui.html;917.2661870503596;921.1479381572044;927.5315965437455;930.0281206139588;936.3585943628613;15388.769168462482;15430.922845385758;15451.381944722198;15482.99360541564;15574.766378504331;14173.858261417383;14480.203588802611;14514.637134071654;14546.490872819428;15043.92478037611;913.0641092879802;914.2868562521244;917.8623206519009;919.6413398774483;920.7974245665943;918.7106061590611;920.052346083535;920.102899672817;920.5397301349325;923.9630414783401;951.2485136741966;955.9044095590455;956.0726095687172;956.2780101023717;956.8708224389723;952.0431965874286;954.1651055326589;955.1737746848995;955.5604421965904;955.5795450002047;697.7139372857155;701.9017337572744;702.0311969482133;702.2065066474902;702.2696395748416;14503.057301275488;14514.854851451455;14515.419383224764;14591.635209119857;14617.122972621677;12731.93634031824;12825.16636418639;12956.287404192766;12970.80543791844;13024.218546887218;11204.719882002933;11214.327140371604;11308.943455282753;11384.260023098472;11403.315801051964;3890.5525864525657;3981.203759248162;3984.7409918355506;4000.759954402716;4034.7780872052026;48181;48914.58481563113;55452.44547554554;63011.36988630101;63293;12106.636800895987;12206.32865192423;12267.938660306641;12301.261924284572;12309.753804923852;21798.89100554519;21859.234926777488;21872.562548748934;21874.89062554677;21926.232581859877;8995.100489950952;9250.444973301623;9286.582103805209;9345.672901448417;9396.201322887631;4851.708897466164;4950.925736113961;5025.924611130836;5051.520105589963;5068.543831055223;3681.834317455721;3736.1033351995325;3741.9438708419398;3743.494628225155;3746.83139258734;667.576089183372;676.2257215488238;689.9275576064541;694.7429451103023;711.975080872167;727.2146082231178;738.9593572353465;747.8653842308437;821.7370441458795;827.1315119125015;9205.815883682422;9565;9737.367071140354;9908.108270255712;10131.898681013243;649.9187601549806;665.4543274514948;673.0879658063352;679.0662838596929;790.4506368074249;4244.681648876347;4260.318349064135;4330.41539392178;4337.414449049401;4413.117376524708;57346;63033.36966630367;66057.66971165114;66597;66700.66649666817;52743.20885186725;53459.732701336245;53614.731926340115;53645.73177134089;56410.43589564134;49934.50065499371;50115.24827127596;50220;50677;51216.74391628018;10124.675842808638;10155.64455244063;10262.897371026493;10370.792584148425;10432;36924;38146.809265953496;38726.6127338723;38853.611463885;38965;44692.32961505515;48190.5180948186;48562;50329;50780;11375.658730238107;12438.129330946747;12592.174134750592;12776.872231277568;13030.54393096237;12933.676658083623;13034.413451394521;13734.93132534331;13858;14346.56960291193;13357.732845343233;13603.387847546686;13640.045196836127;14092.154470731788;14109.082909610843;13134;13528.526501572398;13816.378262978391;13862;13913.652158695708;12755.298458584866;13036.869631303565;13178.143420677625;13249.602511924657;14107.717845643236;11097.611583594535;11208.159388045766;11219;11228.887711122785;11466.598669046543;10677.199210059121;10844.24090313702;11021.118310534977;11050.944745276222;11091.778164436828 03:50:47 INFO - PROCESS | 5479 | __end_tp_report 03:50:47 INFO - PROCESS | 5479 | __start_cc_report 03:50:47 INFO - PROCESS | 5479 | _x_x_mozilla_cycle_collect,898 03:50:47 INFO - PROCESS | 5479 | __end_cc_report 03:50:47 INFO - PROCESS | 5479 | __startTimestamp1463309447349__endTimestamp 03:50:47 INFO - PROCESS | 5479 | 03:50:47 INFO - PROCESS | 5479 | ------- Summary: start ------- 03:50:47 INFO - PROCESS | 5479 | Number of tests: 6 03:50:47 INFO - PROCESS | 5479 | 03:50:47 INFO - PROCESS | 5479 | [#0] dojo.html Cycles:165 Average:5562.49 Median:5756.17 stddev:621.34 (10.8%) stddev-sans-first:597.93 03:50:47 INFO - PROCESS | 5479 | Values: 3324.5 3385.1 3407.3 3414.5 3424.8 5588.7 5594.8 5605.6 5607.6 5621.8 5593.9 5600.3 5635.8 5647.5 5648.6 4907.6 5113.8 5147.8 5233.3 5256.1 5070.1 5099.1 5099.3 5099.7 5105.6 5125.7 5169.1 5213.6 5214.4 5245.8 5174.4 5179.6 5190.3 5196.3 5221.4 4983.4 5068.3 5077.7 5100.0 5142.2 5416.6 5450.8 5455.2 5474.0 5487.5 5995.6 5997.6 6016.5 6022.8 6025.6 5947.1 5985.4 6035.5 6058.2 6063.5 5496.6 5543.1 5548.9 5552.6 5557.4 5891.9 6041.5 6042.5 6048.5 6053.3 5892.9 5951.4 5957.7 5965.3 5982.2 5984.1 6010.0 6010.6 6018.1 6030.1 5780.3 5906.8 5991.0 6004.8 6010.2 5974.4 5985.5 5989.1 5991.2 6027.6 4533.7 4537.7 4544.6 4548.0 4579.9 3953.1 3960.7 4069.6 4071.9 4109.2 5702.1 5726.6 5728.3 5729.1 5752.0 6022.5 6026.7 6029.5 6032.7 6033.0 5605.6 5609.1 5660.0 5661.8 5669.5 4955.3 4993.7 5000.4 5003.6 5026.3 6216.9 6227.5 6254.5 6254.6 6256.2 5802.9 5934.4 6012.2 6046.4 6047.4 6202.8 6211.1 6229.9 6233.0 6238.9 5720.0 5878.6 5885.5 5892.1 5913.1 6016.2 6061.2 6104.1 6114.0 6141.6 5821.4 5866.9 5867.4 5867.4 5869.0 5707.0 5750.8 5806.2 5820.6 5841.4 5744.3 5759.4 5760.1 5760.3 5792.9 5855.0 5858.6 5871.1 5881.8 5889.3 5568.4 5654.1 5678.9 5756.2 5784.4 03:50:47 INFO - PROCESS | 5479 | 03:50:47 INFO - PROCESS | 5479 | [#1] ext.html Cycles:180 Average:56988.21 Median:20924.87 stddev:106885.12 (510.8%) stddev-sans-first:107101.32 03:50:47 INFO - PROCESS | 5479 | Values: 668.5 669.3 673.6 678.6 751.0 32494.7 39994.0 40495.0 40876.4 40886.6 43132.4 43627.3 44163.6 44178.8 44192.8 8421.2 8866.4 9056.4 10520.0 10735.9 10547.8 10705.3 10707.4 10708.1 10713.7 10684.8 10769.7 10789.1 10789.4 10806.2 8523.1 8718.0 10644.5 10665.5 10799.5 10770.7 10890.0 10899.8 10905.2 10905.5 41583.8 41913.2 41987.4 42276.6 42403.2 3703.1 3708.0 3867.7 3922.4 4355.1 34043.8 34207.5 34648.5 35278.6 35998.5 4443.8 4492.2 4554.9 4564.0 4645.4 355732.0 356202.0 359579.0 360394.0 362660.0 41011.0 68895.3 69057.7 69476.7 69486.7 37753.8 37932.8 38040.0 38273.2 38467.4 17614.0 17796.2 17802.7 17802.7 17809.3 13805.3 15418.5 15787.8 15815.0 15824.9 9404.7 9446.8 9459.8 9520.6 9542.8 3670.5 3713.9 3738.4 3771.3 3809.7 1127.0 1204.8 1209.6 1211.1 1241.7 32842.5 32936.3 34315.8 34404.8 34451.5 1179.9 1194.7 1227.8 1245.0 1302.6 17799.0 17873.9 17976.9 18027.9 18212.9 516232.0 518733.0 521767.0 523311.0 523658.0 63566.4 64330.4 64389.0 64396.4 64471.4 1478.7 1493.2 1512.0 1535.9 1633.5 31439.8 33022.0 33240.5 33941.0 34075.8 50729.7 51117.2 51205.2 51205.2 51221.5 297889.0 299475.0 300266.0 301250.0 303166.0 28712.6 49273.0 50196.2 50805.5 50975.5 49142.3 49353.8 49401.0 50210.7 50780.5 39074.0 40395.4 40636.6 40756.4 41185.4 42395.6 43709.8 43766.0 44033.0 44684.6 46685.8 47226.3 47421.0 47877.3 48011.5 38166.8 40882.2 40964.8 41434.2 41469.0 30096.8 30700.8 31035.2 31096.4 31445.0 03:50:47 INFO - PROCESS | 5479 | 03:50:47 INFO - PROCESS | 5479 | [#2] jquery.html Cycles:180 Average:27535.87 Median:23074.04 stddev:74239.05 (321.7%) stddev-sans-first:74419.41 03:50:47 INFO - PROCESS | 5479 | Values: 431.6 433.6 434.3 444.0 449.9 18173.8 18475.7 18655.3 19213.0 20172.3 19247.3 19521.2 20247.9 20249.7 20270.2 5688.5 5691.9 5840.7 5847.2 5848.2 5755.5 5801.4 5802.4 5808.8 5816.8 5664.5 5758.5 5807.2 5821.6 5826.7 5773.8 5775.0 5777.3 5789.3 5792.7 5188.8 5213.6 5232.7 5240.2 5240.8 22941.7 22998.2 23149.9 23313.0 23337.2 2700.3 2732.6 2732.7 3015.0 3077.2 14454.9 14787.4 14820.0 14906.3 15387.3 2066.4 2080.8 2086.6 2099.1 2159.2 58261.4 62736.4 73766.0 73791.6 81710.6 11039.9 11529.3 11694.6 11789.1 11878.8 13792.2 16625.9 16735.2 16760.0 16765.6 8582.6 8618.5 8656.8 8736.1 8757.6 8431.9 8445.8 8452.9 8544.4 8802.9 5048.2 5051.0 5072.9 5074.6 5162.0 2046.1 2064.3 2077.5 2098.5 2105.8 1040.2 1042.4 1068.9 1111.0 1123.1 18803.8 19152.5 19208.3 19492.4 19636.9 1073.7 1074.6 1091.0 1101.8 1155.3 10669.9 11110.5 11123.9 11257.0 11296.4 383652.5 387455.0 389991.0 532307.0 533320.0 77591.6 82392.6 84756.6 85041.1 86189.0 1109.4 1140.4 1149.0 1160.9 1171.2 16684.7 16847.7 17029.5 17049.8 17068.0 36928.8 37023.0 40377.6 40713.4 42942.0 60725.4 60894.0 61035.4 61378.4 61454.4 8451.9 8472.4 8507.5 8542.9 8598.6 9388.4 13556.5 13614.5 13750.8 13882.5 12097.2 12152.5 12229.4 12244.4 12331.9 11584.5 11862.2 11864.6 11898.0 12367.3 11600.4 11778.1 11833.0 12157.7 12186.1 8671.5 8706.0 8730.4 8814.6 8904.7 12001.3 12583.9 12606.6 12618.6 12875.3 03:50:47 INFO - PROCESS | 5479 | 03:50:47 INFO - PROCESS | 5479 | [#3] mootools.html Cycles:180 Average:5820.02 Median:4905.75 stddev:3238.76 (66.0%) stddev-sans-first:3230.72 03:50:47 INFO - PROCESS | 5479 | Values: 1387.8 1570.7 1574.5 1776.8 1894.1 8272.7 8526.9 8555.4 8574.1 8574.9 8354.4 8576.9 8583.2 8585.7 8595.2 2113.3 2152.5 2386.2 2387.7 2412.0 2377.8 2388.6 2403.4 2404.2 2405.5 2243.1 2271.7 2322.4 2335.0 2336.5 2076.8 2125.3 2345.6 2359.8 2408.6 2390.1 2412.9 2420.5 2420.8 2421.8 8455.8 8542.5 8565.7 8567.6 8568.4 5275.6 5301.1 5359.3 5362.2 5431.3 3709.7 3728.2 3736.4 3775.8 3867.9 1197.2 1200.9 1211.9 1221.6 1266.5 12595.6 12619.9 12660.5 12666.4 12670.5 4797.6 4832.9 4892.0 4919.6 4927.6 10692.5 10729.9 10732.6 10741.6 10747.0 5501.7 5556.2 5566.5 5566.9 5571.2 4264.1 4674.1 4724.7 4776.9 4783.7 4146.8 4153.8 4220.1 4250.1 4281.3 1346.1 1348.6 1351.1 1355.5 1375.8 841.3 848.3 942.9 949.3 951.6 5920.7 6187.8 6200.7 6208.8 6245.4 1007.3 1007.9 1033.8 1045.3 1072.9 4195.1 4280.4 4284.8 4308.4 4310.0 10648.1 10771.0 10910.6 10914.7 10915.9 10369.3 10949.7 11126.3 11131.5 11152.2 8245.1 8340.3 8380.7 8436.9 8448.5 5885.9 6044.3 6076.6 6101.0 6182.7 9500.0 9659.2 9746.3 9755.7 9777.1 9584.9 9908.1 10172.2 10217.2 10359.1 7030.0 7247.7 7385.4 7455.3 7561.3 8068.0 8069.1 8075.6 8076.3 8094.8 7134.5 7225.5 7243.8 7298.0 7310.9 7114.7 7180.8 7290.9 7757.6 7871.3 6807.3 6830.9 6846.2 6847.7 6859.9 5296.6 5326.7 5435.5 5558.3 5655.7 5446.3 5546.6 5639.7 5656.4 5692.8 03:50:47 INFO - PROCESS | 5479 | 03:50:47 INFO - PROCESS | 5479 | [#4] prototype.html Cycles:180 Average:5698.62 Median:6484.55 stddev:1735.88 (26.8%) stddev-sans-first:1693.41 03:50:47 INFO - PROCESS | 5479 | Values: 334.1 359.8 365.5 367.4 369.3 6363.6 6439.5 6453.4 6456.9 6490.2 6068.6 6234.3 6354.2 6379.8 6419.0 4893.7 4932.4 4933.1 4934.7 4941.0 4917.5 4923.9 4942.9 4946.2 4953.2 4654.5 4724.1 4744.7 4789.2 4858.5 4833.4 4835.9 4859.0 4861.7 4868.8 4267.7 4269.0 4275.8 4282.0 4286.4 6115.8 6143.9 6159.3 6159.6 6166.7 5734.6 5740.2 5741.4 5750.1 5750.3 6579.4 6791.6 6793.9 6807.4 6818.9 4697.6 4711.4 4716.0 4723.0 4724.8 7050.3 7111.2 7133.7 7134.3 7151.3 4804.7 4807.8 4808.4 4822.7 4832.1 4878.3 4878.8 4883.4 4885.6 4886.1 5478.0 5619.4 5672.2 5677.7 5683.9 6797.1 6797.9 6821.2 6822.2 6841.2 1678.7 1682.3 1687.0 1689.9 1691.4 1048.7 1173.2 1173.6 1182.5 1183.2 6478.9 6504.0 6515.8 6612.5 6619.5 6969.9 6977.8 6982.1 6994.4 6999.9 6596.7 6602.2 6605.0 6609.4 6613.4 3688.2 3724.6 3772.4 3772.5 3775.1 7330.9 7351.0 7363.5 7372.4 7404.5 7215.7 7232.9 7243.5 7245.2 7247.4 7379.2 7396.5 7398.0 7404.6 7410.4 6884.2 7063.2 7066.2 7069.1 7069.6 6950.3 6951.2 6959.8 6967.8 6989.5 7358.0 7364.3 7370.0 7379.2 7386.8 4689.6 4690.2 4704.6 4706.9 4717.4 6828.2 7014.7 7026.4 7027.9 7028.9 6820.6 6853.7 6854.6 6858.7 6876.1 6855.8 6906.7 6918.4 6920.8 6922.9 6658.7 6680.4 6721.6 6724.5 6729.1 6713.4 6850.3 6856.0 6881.7 6885.3 6432.7 6600.7 6606.1 6728.1 6740.1 03:50:47 INFO - PROCESS | 5479 | 03:50:47 INFO - PROCESS | 5479 | [#5] yui.html Cycles:180 Average:15458.14 Median:4139.73 stddev:17549.95 (423.9%) stddev-sans-first:17565.21 03:50:47 INFO - PROCESS | 5479 | Values: 917.3 921.1 927.5 930.0 936.4 15388.8 15430.9 15451.4 15483.0 15574.8 14173.9 14480.2 14514.6 14546.5 15043.9 913.1 914.3 917.9 919.6 920.8 918.7 920.1 920.1 920.5 924.0 951.2 955.9 956.1 956.3 956.9 952.0 954.2 955.2 955.6 955.6 697.7 701.9 702.0 702.2 702.3 14503.1 14514.9 14515.4 14591.6 14617.1 12731.9 12825.2 12956.3 12970.8 13024.2 11204.7 11214.3 11308.9 11384.3 11403.3 3890.6 3981.2 3984.7 4000.8 4034.8 48181.0 48914.6 55452.4 63011.4 63293.0 12106.6 12206.3 12267.9 12301.3 12309.8 21798.9 21859.2 21872.6 21874.9 21926.2 8995.1 9250.4 9286.6 9345.7 9396.2 4851.7 4950.9 5025.9 5051.5 5068.5 3681.8 3736.1 3741.9 3743.5 3746.8 667.6 676.2 689.9 694.7 712.0 727.2 739.0 747.9 821.7 827.1 9205.8 9565.0 9737.4 9908.1 10131.9 649.9 665.5 673.1 679.1 790.5 4244.7 4260.3 4330.4 4337.4 4413.1 57346.0 63033.4 66057.7 66597.0 66700.7 52743.2 53459.7 53614.7 53645.7 56410.4 49934.5 50115.2 50220.0 50677.0 51216.7 10124.7 10155.6 10262.9 10370.8 10432.0 36924.0 38146.8 38726.6 38853.6 38965.0 44692.3 48190.5 48562.0 50329.0 50780.0 11375.7 12438.1 12592.2 12776.9 13030.5 12933.7 13034.4 13734.9 13858.0 14346.6 13357.7 13603.4 13640.0 14092.2 14109.1 13134.0 13528.5 13816.4 13862.0 13913.7 12755.3 13036.9 13178.1 13249.6 14107.7 11097.6 11208.2 11219.0 11228.9 11466.6 10677.2 10844.2 11021.1 11050.9 11091.8 03:50:47 INFO - PROCESS | 5479 | -------- Summary: end -------- 03:50:47 INFO - PROCESS | 5479 | 03:50:47 INFO - TEST-INFO | 5479: exit 0 03:50:48 INFO - TEST-OK | dromaeo_css | took 1111686ms 03:50:48 INFO - TEST-START | kraken 03:50:48 INFO - operating with platform_type : linux_ 03:50:48 INFO - Initialising browser for kraken test... 03:50:48 INFO - TEST-INFO | started process 5665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0ueB4h/profile http://localhost:39400/getInfo.html) 03:50:52 INFO - PROCESS | 5665 | __metrics Screen width/height:1600/1200 03:50:52 INFO - PROCESS | 5665 | colorDepth:24 03:50:52 INFO - PROCESS | 5665 | Browser inner width/height: 1024/697 03:50:52 INFO - PROCESS | 5665 | __metrics 03:50:53 ERROR - PROCESS | 5665 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:50:53 INFO - TEST-INFO | 5665: exit 0 03:50:53 INFO - Browser initialized. 03:50:53 INFO - Running cycle 1/1 for kraken test... 03:50:53 INFO - TEST-INFO | started process 5759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0ueB4h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:05 INFO - PROCESS | 5759 | RSS: Main: 141971456 03:51:05 INFO - PROCESS | 5759 | 03:51:08 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:39400/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39400/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:09 INFO - PROCESS | 5759 | RSS: Main: 196694016 03:51:09 INFO - PROCESS | 5759 | 03:51:11 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:39400/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39400/tests/kraken/driver.html?testName=audio-dft) 03:51:12 INFO - PROCESS | 5759 | RSS: Main: 182513664 03:51:12 INFO - PROCESS | 5759 | 03:51:15 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:39400/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39400/tests/kraken/driver.html?testName=audio-fft) 03:51:15 INFO - PROCESS | 5759 | RSS: Main: 273559552 03:51:15 INFO - PROCESS | 5759 | 03:51:17 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:39400/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39400/tests/kraken/driver.html?testName=audio-oscillator) 03:51:18 INFO - PROCESS | 5759 | RSS: Main: 178802688 03:51:18 INFO - PROCESS | 5759 | 03:51:20 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:39400/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39400/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:21 INFO - PROCESS | 5759 | RSS: Main: 178388992 03:51:21 INFO - PROCESS | 5759 | 03:51:24 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:39400/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39400/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:24 INFO - PROCESS | 5759 | RSS: Main: 212897792 03:51:24 INFO - PROCESS | 5759 | 03:51:28 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:39400/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39400/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:28 INFO - PROCESS | 5759 | RSS: Main: 212205568 03:51:28 INFO - PROCESS | 5759 | 03:51:31 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:39400/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39400/tests/kraken/driver.html?testName=json-parse-financial) 03:51:32 INFO - PROCESS | 5759 | RSS: Main: 213024768 03:51:32 INFO - PROCESS | 5759 | 03:51:33 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:39400/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39400/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:34 INFO - PROCESS | 5759 | RSS: Main: 193294336 03:51:34 INFO - PROCESS | 5759 | 03:51:35 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:39400/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39400/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:36 INFO - PROCESS | 5759 | RSS: Main: 194560000 03:51:36 INFO - PROCESS | 5759 | 03:51:38 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:39400/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39400/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:39 INFO - PROCESS | 5759 | RSS: Main: 212697088 03:51:39 INFO - PROCESS | 5759 | 03:51:41 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:39400/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:42 INFO - PROCESS | 5759 | RSS: Main: 214048768 03:51:42 INFO - PROCESS | 5759 | 03:51:44 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:39400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:45 INFO - PROCESS | 5759 | RSS: Main: 210186240 03:51:45 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:39400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39400/tests/kraken/driver.html?testName=ai-astar) 03:51:47 INFO - PROCESS | 5759 | RSS: Main: 274612224 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | __start_tp_report 03:51:47 INFO - PROCESS | 5759 | _x_x_mozilla_page_load 03:51:47 INFO - PROCESS | 5759 | _x_x_mozilla_page_load_details 03:51:47 INFO - PROCESS | 5759 | |i|pagename|runs| 03:51:47 INFO - PROCESS | 5759 | |0;ai-astar;110;111;110;111;110;111;106;110;110;110 03:51:47 INFO - PROCESS | 5759 | |1;audio-beat-detection;158;126;158;185;127;153;153;130;185;132 03:51:47 INFO - PROCESS | 5759 | |2;audio-dft;163;160;160;161;159;161;159;158;161;162 03:51:47 INFO - PROCESS | 5759 | |3;audio-fft;73;76;73;164;77;76;74;76;158;76 03:51:47 INFO - PROCESS | 5759 | |4;audio-oscillator;93;94;159;92;93;92;146;93;93;143 03:51:47 INFO - PROCESS | 5759 | |5;imaging-gaussian-blur;117;117;116;116;116;117;117;116;116;117 03:51:47 INFO - PROCESS | 5759 | |6;imaging-darkroom;145;145;146;146;145;145;146;145;145;145 03:51:47 INFO - PROCESS | 5759 | |7;imaging-desaturate;95;94;95;95;95;94;94;94;94;95 03:51:47 INFO - PROCESS | 5759 | |8;json-parse-financial;56;55;54;54;55;54;55;74;54;53 03:51:47 INFO - PROCESS | 5759 | |9;json-stringify-tinderbox;70;58;59;57;59;58;57;58;58;58 03:51:47 INFO - PROCESS | 5759 | |10;stanford-crypto-aes;74;72;74;72;74;74;74;75;74;74 03:51:47 INFO - PROCESS | 5759 | |11;stanford-crypto-ccm;117;125;117;112;114;113;116;121;150;129 03:51:47 INFO - PROCESS | 5759 | |12;stanford-crypto-pbkdf2;164;162;164;156;159;165;159;161;164;164 03:51:47 INFO - PROCESS | 5759 | |13;stanford-crypto-sha256-iterative;69;67;65;66;66;74;66;64;65;64 03:51:47 INFO - PROCESS | 5759 | __end_tp_report 03:51:47 INFO - PROCESS | 5759 | __start_cc_report 03:51:47 INFO - PROCESS | 5759 | _x_x_mozilla_cycle_collect,1583 03:51:47 INFO - PROCESS | 5759 | __end_cc_report 03:51:47 INFO - PROCESS | 5759 | __startTimestamp1463309507366__endTimestamp 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | ------- Summary: start ------- 03:51:47 INFO - PROCESS | 5759 | Number of tests: 14 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:1.45 (1.3%) stddev-sans-first:1.54 03:51:47 INFO - PROCESS | 5759 | Values: 110.0 111.0 110.0 111.0 110.0 111.0 106.0 110.0 110.0 110.0 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:155.50 stddev:22.16 (14.3%) stddev-sans-first:23.35 03:51:47 INFO - PROCESS | 5759 | Values: 158.0 126.0 158.0 185.0 127.0 153.0 153.0 130.0 185.0 132.0 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:1.51 (0.9%) stddev-sans-first:1.27 03:51:47 INFO - PROCESS | 5759 | Values: 163.0 160.0 160.0 161.0 159.0 161.0 159.0 158.0 161.0 162.0 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | [#3] audio-fft Cycles:10 Average:92.30 Median:76.00 stddev:36.26 (47.7%) stddev-sans-first:37.78 03:51:47 INFO - PROCESS | 5759 | Values: 73.0 76.0 73.0 164.0 77.0 76.0 74.0 76.0 158.0 76.0 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:93.00 stddev:27.58 (29.7%) stddev-sans-first:28.57 03:51:47 INFO - PROCESS | 5759 | Values: 93.0 94.0 159.0 92.0 93.0 92.0 146.0 93.0 93.0 143.0 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:51:47 INFO - PROCESS | 5759 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 03:51:47 INFO - PROCESS | 5759 | Values: 145.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 03:51:47 INFO - PROCESS | 5759 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 94.0 94.0 94.0 95.0 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:55.00 stddev:6.24 (11.3%) stddev-sans-first:6.62 03:51:47 INFO - PROCESS | 5759 | Values: 56.0 55.0 54.0 54.0 55.0 54.0 55.0 74.0 54.0 53.0 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:58.00 stddev:3.85 (6.6%) stddev-sans-first:0.71 03:51:47 INFO - PROCESS | 5759 | Values: 70.0 58.0 59.0 57.0 59.0 58.0 57.0 58.0 58.0 58.0 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:74.00 stddev:0.95 (1.3%) stddev-sans-first:1.00 03:51:47 INFO - PROCESS | 5759 | Values: 74.0 72.0 74.0 72.0 74.0 74.0 74.0 75.0 74.0 74.0 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:119.00 stddev:11.40 (9.6%) stddev-sans-first:11.98 03:51:47 INFO - PROCESS | 5759 | Values: 117.0 125.0 117.0 112.0 114.0 113.0 116.0 121.0 150.0 129.0 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:164.00 stddev:2.97 (1.8%) stddev-sans-first:3.05 03:51:47 INFO - PROCESS | 5759 | Values: 164.0 162.0 164.0 156.0 159.0 165.0 159.0 161.0 164.0 164.0 03:51:47 INFO - PROCESS | 5759 | 03:51:47 INFO - PROCESS | 5759 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.00 stddev:2.99 (4.5%) stddev-sans-first:3.04 03:51:47 INFO - PROCESS | 5759 | Values: 69.0 67.0 65.0 66.0 66.0 74.0 66.0 64.0 65.0 64.0 03:51:47 INFO - PROCESS | 5759 | -------- Summary: end -------- 03:51:47 INFO - PROCESS | 5759 | 03:51:48 INFO - TEST-INFO | 5759: exit 0 03:51:48 INFO - TEST-OK | kraken | took 60282ms 03:51:48 INFO - SUITE-END | took 1171s 03:51:48 INFO - Completed test suite (00:19:32) 03:51:48 INFO - javascript benchmark 03:51:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3324.5345651608777, 3385.1367901185195, 3407.2844702612456, 3414.539037229973, 3424.7773894696843, 5588.748506317215, 5594.804181853636, 5605.635633683808, 5607.635503692257, 5621.77512899484, 5593.944060559394, 5600.27196464459, 5635.830925072254, 5647.463490968362, 5648.604597678164, 4907.6073914086965, 5113.769880355393, 5147.7683504242395, 5233.345831771028, 5256.080185967459, 5070.062038522867, 5099.133147364957, 5099.286099946011, 5099.71951542665, 5105.642605017651, 5125.692458452486, 5169.147090730025, 5213.556847667953, 5214.400343960437, 5245.763940622662, 5174.404943431516, 5179.637425380225, 5190.273361729361, 5196.272521846944, 5221.399539053001, 4983.352164218629, 5068.341115654978, 5077.720725360104, 5100.0, 5142.177251639757, 5416.647917885364, 5450.781968721247, 5455.236266922594, 5474.0, 5487.478689524489, 5995.550333724988, 5997.610155339889, 6016.548758843061, 6022.819315420545, 6025.578209525291, 5947.137665038588, 5985.431384018511, 6035.547333949971, 6058.1518587397795, 6063.54523410746, 5496.615236933416, 5543.085390910495, 5548.91676624855, 5552.555795536347, 5557.360903496069, 5891.911621325684, 6041.486473649701, 6042.546808989343, 6048.516118710492, 6053.273607167168, 5892.941070589325, 5951.4048595141, 5957.702114894238, 5965.284165900033, 5982.192404025488, 5984.102384642339, 6009.969950150221, 6010.609310394811, 6018.097285407136, 6030.095485677183, 5780.335261444903, 5906.793262235801, 5991.041433370639, 6004.789832355934, 6010.188624535632, 5974.4324289192455, 5985.521158307325, 5989.101634754822, 5991.221141251609, 6027.578069535178, 4533.682642215079, 4537.682362234678, 4544.568266014723, 4547.954520454819, 4579.877929907194, 3953.0512676957323, 3960.663343615825, 4069.5726948670554, 4071.877843664695, 4109.239790638741, 5702.0591602385975, 5726.570507211975, 5728.255326807572, 5729.1119876419225, 5752.02215623345, 6022.518198544106, 6026.6986650667295, 6029.457348838626, 6032.6983650818165, 6032.969835150796, 5605.635633683797, 5609.074502707008, 5660.0, 5661.830145095653, 5669.489745922804, 4955.281484184773, 4993.675411098339, 5000.39995200571, 5003.574696150868, 5026.29631851541, 6216.875662486816, 6227.501799856001, 6254.468370188585, 6254.6247225166635, 6256.186695729526, 5802.912956305743, 5934.376890426443, 6012.158297838394, 6046.425589568984, 6047.365026672312, 6202.772194263163, 6211.068339749074, 6229.937700623117, 6233.002719564848, 6238.937610623836, 5719.971400142973, 5878.588498805214, 5885.470307672159, 5892.057270836645, 5913.113033045078, 6016.187814644967, 6061.15143879866, 6104.053871649901, 6114.023656277781, 6141.6007959482495, 5821.446962538552, 5866.911996319973, 5867.354590994902, 5867.442592953663, 5869.0, 5706.971465142814, 5750.827475175752, 5806.187133801187, 5820.621659592113, 5841.357450680337, 5744.310682718101, 5759.39526349744, 5760.0783874579865, 5760.308762948473, 5792.942070579409, 5854.970725146347, 5858.619189752652, 5871.089981052944, 5881.794137205177, 5889.322727886348, 5568.415316391721, 5654.123610840326, 5678.858028549154, 5756.165356023437, 5784.363719990713], "value": 5521.974251209889, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.5086461450834, 669.3039239191241, 673.589110642508, 678.582671656931, 750.997418446374, 32494.67505324946, 39994.0, 40495.0, 40876.38685419714, 40886.59113408865, 43132.35301470481, 43627.34558981618, 44163.55836441635, 44178.779106104506, 44192.779036104774, 8421.15788421159, 8866.379353445262, 9056.366054376196, 10520.000599943032, 10735.892641073568, 10547.789044219111, 10705.304155229886, 10707.411092389915, 10708.089812365959, 10713.678589642323, 10684.839727404094, 10769.676909692682, 10789.082927951134, 10789.40658263799, 10806.243562950596, 8523.105073967268, 8718.0, 10644.467776611138, 10665.520051597698, 10799.514021869034, 10770.676879693621, 10890.0, 10899.782004359948, 10905.18211134168, 10905.454727263685, 41583.792081039704, 41913.16173676509, 41987.37018944718, 42276.577234227574, 42403.15193696109, 3703.129764505339, 3707.961770704207, 3867.7485963412287, 3922.352811786052, 4355.12897420514, 34043.829780851185, 34207.4868876967, 34648.480272795925, 35278.64721352805, 35998.46002309967, 4443.777811109464, 4492.168948744493, 4554.8861278467975, 4563.977180114078, 4645.419322584677, 355732.0, 356202.0, 359579.0, 360394.0, 362660.0, 41010.9747256321, 68895.3110468899, 69057.65471172713, 69476.6526167366, 69486.65256673786, 37753.81123094367, 37932.81033594815, 38040.0, 38273.23453530914, 38467.42298865519, 17614.0, 17796.199171037333, 17802.732959005625, 17802.732959005625, 17809.287628494974, 13805.309734513234, 15418.537443876701, 15787.842121578868, 15815.0, 15824.92087539555, 9404.717858464257, 9446.811063778687, 9459.810803783887, 9520.571574279174, 9542.761430964143, 3670.541182352206, 3713.9071523211596, 3738.383166777451, 3771.30230907283, 3809.733318667722, 1126.9887301127048, 1204.8313236146946, 1209.594785746767, 1211.1279878487476, 1241.720612862117, 32842.50736238958, 32936.3412731744, 34315.82842085774, 34404.82797585996, 34451.4832277516, 1179.9085845592792, 1194.707296712311, 1227.8096894981293, 1244.9937750311371, 1302.5636411801963, 17799.0, 17873.910630447026, 17976.91011544934, 18027.909860450614, 18212.908935455238, 516232.0, 518733.0, 521767.0, 523311.0, 523658.0, 63566.36433635605, 64330.356696432435, 64389.03416448757, 64396.356036439975, 64471.35528644654, 1478.719043381754, 1493.2235237676348, 1511.9773203401958, 1535.9078455292718, 1633.5099470158905, 31439.84280078585, 33022.0, 33240.501392479615, 33941.0, 34075.82962085273, 50729.746351268004, 51117.23324150066, 51205.23192152046, 51205.231921521954, 51221.48778512167, 297889.0, 299475.0, 300266.0, 301250.0, 303166.0, 28712.569311460764, 49273.0, 50196.24705629492, 50805.49194508156, 50975.49024509856, 49142.26286605632, 49353.75323123361, 49401.0, 50210.74894625504, 50780.492195077575, 39074.02314942149, 40395.394069089576, 40636.59363406446, 40756.38865416962, 41185.38221926614, 42395.5760442404, 43709.78145109254, 43766.0, 44033.0, 44684.55315446804, 46685.766571166925, 47226.29160562663, 47421.0, 47877.28184077172, 48011.519884800706, 38166.80916595399, 40882.1823563533, 40964.79517602512, 41434.171316572894, 41469.0, 30096.84951575228, 30700.84649576827, 31035.224119397197, 31096.378072438878, 31445.0], "value": 20508.57297180224, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.60508135056426, 433.5989209980769, 434.2877680603808, 443.984460543881, 449.8740352701243, 18173.818261817378, 18475.722864157047, 18655.3470628528, 19213.0, 20172.293969711063, 19247.326343577977, 19521.21915123397, 20247.898760506214, 20249.696254556195, 20270.18919243232, 5688.459596338362, 5691.943080569204, 5840.678762668052, 5847.210626565402, 5848.210491583645, 5755.539556835464, 5801.44886235809, 5802.419758024185, 5808.796692115777, 5816.82549523515, 5664.54683625309, 5758.481736643701, 5807.2160258365, 5821.592488525805, 5826.650400975955, 5773.797917072903, 5774.971125144369, 5777.335606405233, 5789.305283366002, 5792.68140252286, 5188.8183913563225, 5213.5829133669595, 5232.73836308183, 5240.213967904807, 5240.79036838526, 22941.655875161887, 22998.19506317271, 23149.88425057881, 23312.950917208596, 23337.183198588136, 2700.3114205877573, 2732.6037724529833, 2732.6584176977876, 3015.0, 3077.1691643256418, 14454.85545144556, 14787.40850365984, 14820.0, 14906.329215185342, 15387.307571159325, 2066.442060643633, 2080.833533317331, 2086.5931143427038, 2099.0973881231066, 2159.2442645074257, 58261.417385826026, 62736.37263627397, 73766.0, 73791.63104184499, 81710.59144704299, 11039.889601104047, 11529.308241505369, 11694.590689325832, 11789.115816313812, 11878.821817672742, 13792.241426721626, 16625.91687041581, 16735.246913888903, 16760.0, 16765.580860478585, 8582.570871456526, 8618.482891026559, 8656.78358041054, 8736.12638736134, 8757.605907734167, 8431.915680843236, 8445.831083378422, 8452.915470845335, 8544.40189186751, 8802.91197088021, 5048.242763585418, 5051.0, 5072.923906141411, 5074.5940324774665, 5161.974190129101, 2046.1099421751585, 2064.349729835097, 2077.542940553076, 2098.475381154711, 2105.809698307066, 1040.2198351236573, 1042.4006196437078, 1068.9091427228618, 1111.0445017285128, 1123.1239633086207, 18803.81196188048, 19152.521186970436, 19208.327708530414, 19492.415227543195, 19636.90181549083, 1073.6886302972207, 1074.6023971130733, 1090.9890901091046, 1101.7631209290041, 1155.283724091069, 10669.893301067044, 11110.500027498781, 11123.944380278046, 11257.0, 11296.378699171624, 383652.4904252877, 387455.0, 389991.0, 532307.0, 533320.0, 77591.61204194056, 82392.58803705942, 84756.57621711976, 85041.14958850456, 86189.0, 1109.4120116338354, 1140.3898914081092, 1148.9885101149048, 1160.9303441793688, 1171.2035815645272, 16684.749728754323, 16847.747283790508, 17029.48911532656, 17049.82950170532, 17068.0, 36928.81535592305, 37023.0, 40377.596224037385, 40713.38929916113, 42942.0, 60725.39274607197, 60894.0, 61035.38964610475, 61378.38621613727, 61454.38545614487, 8451.8732219018, 8472.364572656952, 8507.489550626982, 8542.914570854213, 8598.61306241233, 9388.436693798394, 13556.457741690221, 13614.455421783414, 13750.793738093736, 13882.51411200603, 12097.153199275966, 12152.513899444277, 12229.449674764835, 12244.387780610756, 12331.938340308241, 11584.47869845842, 11862.22895511789, 11864.644060677849, 11898.048156147313, 12367.257964522158, 11600.419979001184, 11778.116641252112, 11833.0, 12157.69605759863, 12186.086043546948, 8671.523066231166, 8705.956470217609, 8730.388872778845, 8814.633731771586, 8904.688335908211, 12001.339926304137, 12583.93708031454, 12606.55877044299, 12618.55835045769, 12875.291858947849], "value": 9546.078186125054, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.8265216847894, 1570.7094187575299, 1574.5355120239533, 1776.7512548243249, 1894.0813705352894, 8272.66909323627, 8526.872096918543, 8555.443896146746, 8574.056853746082, 8574.914250857497, 8354.415190936637, 8576.914230857705, 8583.18459746323, 8585.742427727162, 8595.226429621332, 2113.3448630924463, 2152.461884528868, 2386.152915714922, 2387.665726798254, 2412.0351859256352, 2377.7741114594087, 2388.593939030369, 2403.399150212447, 2404.1705611563984, 2405.530921470314, 2243.102758896438, 2271.681964524968, 2322.4077860145726, 2334.9883250583725, 2336.4509340305017, 2076.8442366822474, 2125.288028510443, 2345.636426353918, 2359.7994170495526, 2408.638704194367, 2390.115657206827, 2412.8552286862846, 2420.47959688666, 2420.8305418620703, 2421.8062554995736, 8455.788605284855, 8542.487450752975, 8565.743027709179, 8567.614457349435, 8568.400211985163, 5275.551578115865, 5301.125314323132, 5359.330083739533, 5362.222477740745, 5431.321084864392, 3709.703223742094, 3728.179800443898, 3736.3834967230373, 3775.7923314217705, 3867.903302417462, 1197.233770386953, 1200.9219400738923, 1211.9151659383847, 1221.5663439479035, 1266.4807428954084, 12595.559155429608, 12619.936900315439, 12660.493580256778, 12666.430010649543, 12670.49318027287, 4797.56821886032, 4832.879178020507, 4891.951080489221, 4919.557239848431, 4927.605791536668, 10692.518836652369, 10729.946350268356, 10732.624358147428, 10741.624043158452, 10747.032767051003, 5501.697406642593, 5556.16657501378, 5566.526845218202, 5566.888662226733, 5571.247881536022, 4264.061906380592, 4674.065186962621, 4724.669273150916, 4776.928346074812, 4783.6651434399255, 4146.813393397304, 4153.771542565128, 4220.092680073799, 4250.128723611652, 4281.336392859112, 1346.1317450244537, 1348.5886804524714, 1351.1487762709626, 1355.4510423278589, 1375.77987521996, 841.2638940926689, 848.3298194426334, 942.8868535775614, 949.3070058857073, 951.6050838901779, 5920.733566989496, 6187.783427580013, 6200.720967556471, 6208.751649933952, 6245.437910587978, 1007.2596641468515, 1007.9496025198711, 1033.8035773203067, 1045.325764881647, 1072.927072927073, 4195.119025004783, 4280.379344994958, 4284.828606855754, 4308.375285583573, 4309.956900431018, 10648.14814814813, 10771.0, 10910.563577456813, 10914.672559823219, 10915.945420273007, 10369.325993810378, 10949.671509854557, 11126.332420054823, 11131.499082541304, 11152.16358773079, 8245.093039765621, 8340.29107525867, 8380.664773409117, 8436.873446898302, 8448.535330556755, 5885.852853678521, 6044.304904935989, 6076.574639775174, 6100.969495152496, 6182.69086545662, 9500.0, 9659.178969787366, 9746.269029822934, 9755.707328779865, 9777.120059194707, 9584.856227156459, 9908.108270255712, 10172.186225101826, 10217.233707472118, 10359.119474844421, 7029.9648501757165, 7247.746328878464, 7385.446091543263, 7455.329020388191, 7561.281678240558, 8067.959660201662, 8069.112397636372, 8075.596220189084, 8076.313513351196, 8094.757157285291, 7134.46491513149, 7225.458090643117, 7243.818904527429, 7297.963510182628, 7310.853782924418, 7114.679839407136, 7180.820479488055, 7290.927090729237, 7757.612119393895, 7871.33093687043, 6807.251202367636, 6830.863382732218, 6846.246912839484, 6847.691853866489, 6859.862802743817, 5296.602754793329, 5326.680399176062, 5435.483629055233, 5558.333000040021, 5655.745491452977, 5446.346438427414, 5546.639468434539, 5639.689817060101, 5656.43435656431, 5692.7722891083895], "value": 4703.859384750366, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.1262598305432, 359.7517712778183, 365.50474107584205, 367.42131143449063, 369.3112345475685, 6363.649999250045, 6439.452646525039, 6453.386928241815, 6456.870862582751, 6490.188726409199, 6068.57519973602, 6234.251889773233, 6354.205724284465, 6379.776707815227, 6419.0, 4893.7063776173545, 4932.4081110266725, 4933.087378834927, 4934.654574179809, 4941.036497882897, 4917.4836642152595, 4923.876903077434, 4942.851714448572, 4946.15915294399, 4953.207486802113, 4654.4647365553055, 4724.063134115014, 4744.739039352834, 4789.161896668069, 4858.46556878743, 4833.371661683994, 4835.879103022453, 4858.975705121469, 4861.708297502126, 4868.78090485929, 4267.743935363857, 4268.9786551067045, 4275.828966841323, 4281.957180428187, 4286.421333120051, 6115.785947491817, 6143.877122457526, 6159.3224745277985, 6159.568830181889, 6166.722497487579, 5734.627249228787, 5740.196372507852, 5741.397153298927, 5750.108733146369, 5750.281214848144, 6579.374959378852, 6791.592504449749, 6793.864122717518, 6807.353301436356, 6818.897716534256, 4697.647676424282, 4711.387519622427, 4715.95284047162, 4722.952770472286, 4724.834630787906, 7050.259722729143, 7111.217766045731, 7133.678984445713, 7134.32223938725, 7151.2848715128075, 4804.711717296974, 4807.78364973577, 4808.447028591757, 4822.71063736177, 4832.057748739033, 4878.317035615017, 4878.756062196876, 4883.4139903211135, 4885.5847252983185, 4886.120498310267, 5477.972610137003, 5619.381867994517, 5672.234248376499, 5677.687727174963, 5683.886322273532, 6797.116374871235, 6797.864042719118, 6821.2155602106395, 6822.249552549216, 6841.247462779091, 1678.6642671465756, 1682.2850288627528, 1686.9915650421915, 1689.923953422099, 1691.357284231984, 1048.673428113437, 1173.202222488699, 1173.6420391780418, 1182.5210789630214, 1183.23681225609, 6478.902816457757, 6504.0, 6515.837104072341, 6612.537122401386, 6619.5035372347265, 6969.895451568231, 6977.825554361181, 6982.092327997328, 6994.370506654425, 6999.895001574981, 6596.670166491656, 6602.207735071726, 6605.042268870987, 6609.405153536205, 6613.437857782046, 3688.1517251032415, 3724.5530536335814, 3772.43413487979, 3772.5472943246436, 3775.0562359410146, 7330.853382932311, 7350.963245183847, 7363.48455608113, 7372.410207183412, 7404.518706284074, 7215.71137154508, 7232.891506627405, 7243.529170603894, 7245.239249878792, 7247.383972362408, 7379.188289288281, 7396.519226250277, 7398.038255026812, 7404.592747398837, 7410.370118539984, 6884.242733299233, 7063.223045465097, 7066.222715501393, 7069.081019467436, 7069.611171385417, 6950.339717726808, 6951.16586009682, 6959.826004349932, 6967.756128535477, 6989.47578931572, 7358.0, 7364.3372096511575, 7370.0, 7379.2251813558805, 7386.778396648109, 4689.648276379217, 4690.249560070372, 4704.6236301096515, 4706.8819031435305, 4717.410323709536, 6828.180618325832, 7014.684339204646, 7026.437884969088, 7027.859442811217, 7028.8945665814035, 6820.556663817035, 6853.657317134223, 6854.588724676535, 6858.657067146523, 6876.106106206161, 6855.794326170223, 6906.689198986158, 6918.411934985381, 6920.757773477904, 6922.861542769016, 6658.700358483977, 6680.3987641112535, 6721.563098398588, 6724.462043036643, 6729.091572637827, 6713.395794378529, 6850.3149685033095, 6856.0, 6881.724731010904, 6885.2770459101075, 6432.710528026344, 6600.702968366339, 6606.141201643755, 6728.125343705287, 6740.12378390806], "value": 5132.4087106582065, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [917.2661870503596, 921.1479381572044, 927.5315965437455, 930.0281206139588, 936.3585943628613, 15388.769168462482, 15430.922845385758, 15451.381944722198, 15482.99360541564, 15574.766378504331, 14173.858261417383, 14480.203588802611, 14514.637134071654, 14546.490872819428, 15043.92478037611, 913.0641092879802, 914.2868562521244, 917.8623206519009, 919.6413398774483, 920.7974245665943, 918.7106061590611, 920.052346083535, 920.102899672817, 920.5397301349325, 923.9630414783401, 951.2485136741966, 955.9044095590455, 956.0726095687172, 956.2780101023717, 956.8708224389723, 952.0431965874286, 954.1651055326589, 955.1737746848995, 955.5604421965904, 955.5795450002047, 697.7139372857155, 701.9017337572744, 702.0311969482133, 702.2065066474902, 702.2696395748416, 14503.057301275488, 14514.854851451455, 14515.419383224764, 14591.635209119857, 14617.122972621677, 12731.93634031824, 12825.16636418639, 12956.287404192766, 12970.80543791844, 13024.218546887218, 11204.719882002933, 11214.327140371604, 11308.943455282753, 11384.260023098472, 11403.315801051964, 3890.5525864525657, 3981.203759248162, 3984.7409918355506, 4000.759954402716, 4034.7780872052026, 48181.0, 48914.58481563113, 55452.44547554554, 63011.36988630101, 63293.0, 12106.636800895987, 12206.32865192423, 12267.938660306641, 12301.261924284572, 12309.753804923852, 21798.89100554519, 21859.234926777488, 21872.562548748934, 21874.89062554677, 21926.232581859877, 8995.100489950952, 9250.444973301623, 9286.582103805209, 9345.672901448417, 9396.201322887631, 4851.708897466164, 4950.925736113961, 5025.924611130836, 5051.520105589963, 5068.543831055223, 3681.834317455721, 3736.1033351995325, 3741.9438708419398, 3743.494628225155, 3746.83139258734, 667.576089183372, 676.2257215488238, 689.9275576064541, 694.7429451103023, 711.975080872167, 727.2146082231178, 738.9593572353465, 747.8653842308437, 821.7370441458795, 827.1315119125015, 9205.815883682422, 9565.0, 9737.367071140354, 9908.108270255712, 10131.898681013243, 649.9187601549806, 665.4543274514948, 673.0879658063352, 679.0662838596929, 790.4506368074249, 4244.681648876347, 4260.318349064135, 4330.41539392178, 4337.414449049401, 4413.117376524708, 57346.0, 63033.36966630367, 66057.66971165114, 66597.0, 66700.66649666817, 52743.20885186725, 53459.732701336245, 53614.731926340115, 53645.73177134089, 56410.43589564134, 49934.50065499371, 50115.24827127596, 50220.0, 50677.0, 51216.74391628018, 10124.675842808638, 10155.64455244063, 10262.897371026493, 10370.792584148425, 10432.0, 36924.0, 38146.809265953496, 38726.6127338723, 38853.611463885, 38965.0, 44692.32961505515, 48190.5180948186, 48562.0, 50329.0, 50780.0, 11375.658730238107, 12438.129330946747, 12592.174134750592, 12776.872231277568, 13030.54393096237, 12933.676658083623, 13034.413451394521, 13734.93132534331, 13858.0, 14346.56960291193, 13357.732845343233, 13603.387847546686, 13640.045196836127, 14092.154470731788, 14109.082909610843, 13134.0, 13528.526501572398, 13816.378262978391, 13862.0, 13913.652158695708, 12755.298458584866, 13036.869631303565, 13178.143420677625, 13249.602511924657, 14107.717845643236, 11097.611583594535, 11208.159388045766, 11219.0, 11228.887711122785, 11466.598669046543, 10677.199210059121, 10844.24090313702, 11021.118310534977, 11050.944745276222, 11091.778164436828], "value": 7177.529317236125, "unit": "score"}], "name": "dromaeo_css", "value": 7564.390462072927, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 110.0, 111.0, 110.0, 111.0, 106.0, 110.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 158.0, 185.0, 127.0, 153.0, 153.0, 130.0, 185.0, 132.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 161.0, 159.0, 161.0, 159.0, 158.0, 161.0, 162.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 73.0, 164.0, 77.0, 76.0, 74.0, 76.0, 158.0, 76.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 159.0, 92.0, 93.0, 92.0, 146.0, 93.0, 93.0, 143.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 54.0, 55.0, 54.0, 55.0, 74.0, 54.0, 53.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 58.0, 59.0, 57.0, 59.0, 58.0, 57.0, 58.0, 58.0, 58.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 74.0, 72.0, 74.0, 74.0, 74.0, 75.0, 74.0, 74.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 125.0, 117.0, 112.0, 114.0, 113.0, 116.0, 121.0, 150.0, 129.0], "value": 121.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 156.0, 159.0, 165.0, 159.0, 161.0, 164.0, 164.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 65.0, 66.0, 66.0, 74.0, 66.0, 64.0, 65.0, 64.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1518.5, "alertThreshold": 2.0}]} 03:51:48 INFO - Return code: 0 03:51:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:51:48 ERROR - # TBPL SUCCESS # 03:51:48 INFO - Running post-action listener: _resource_record_post_action 03:51:48 INFO - Running post-run listener: _resource_record_post_run 03:51:49 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 770048; Write bytes: 261828608; Read time: 168; Write time: 162564 03:51:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13291520; Read time: 0; Write time: 4664 03:51:49 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 770048; Write bytes: 244396032; Read time: 168; Write time: 157328 03:51:49 INFO - Running post-run listener: _upload_blobber_files 03:51:49 INFO - Blob upload gear active. 03:51:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:51:50 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:51:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:51:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:51 INFO - (blobuploader) - INFO - Done attempting. 03:51:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:51:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:51:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:51 INFO - (blobuploader) - INFO - Done attempting. 03:51:51 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:51 INFO - Return code: 0 03:51:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33f3bc4ede92769daac5409b7cc191c4fd6538e55435a6c045ac1e494f8fa0d4c2fc015e3ad43d10748ab5b5db96899d2d8d77b941c701f0ebf40f61ed76d4a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7cbc0f9b7af238b877627f23649f9bd9a23020b49f36cb4635b393c5f05af3003c20066a67dbd9768482c93d8a6e4481c73fb5ebf816d61c537fdf5a0544ad00"} 03:51:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:51 INFO - Contents: 03:51:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33f3bc4ede92769daac5409b7cc191c4fd6538e55435a6c045ac1e494f8fa0d4c2fc015e3ad43d10748ab5b5db96899d2d8d77b941c701f0ebf40f61ed76d4a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7cbc0f9b7af238b877627f23649f9bd9a23020b49f36cb4635b393c5f05af3003c20066a67dbd9768482c93d8a6e4481c73fb5ebf816d61c537fdf5a0544ad00"} 03:51:51 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:51 INFO - Copying logs to upload dir... 03:51:51 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.517299 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-15 03:51:51.395318) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-15 03:51:51.398919) ========= 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=574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33f3bc4ede92769daac5409b7cc191c4fd6538e55435a6c045ac1e494f8fa0d4c2fc015e3ad43d10748ab5b5db96899d2d8d77b941c701f0ebf40f61ed76d4a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7cbc0f9b7af238b877627f23649f9bd9a23020b49f36cb4635b393c5f05af3003c20066a67dbd9768482c93d8a6e4481c73fb5ebf816d61c537fdf5a0544ad00"} build_url:https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011102 build_url: 'https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33f3bc4ede92769daac5409b7cc191c4fd6538e55435a6c045ac1e494f8fa0d4c2fc015e3ad43d10748ab5b5db96899d2d8d77b941c701f0ebf40f61ed76d4a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7cbc0f9b7af238b877627f23649f9bd9a23020b49f36cb4635b393c5f05af3003c20066a67dbd9768482c93d8a6e4481c73fb5ebf816d61c537fdf5a0544ad00"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-15 03:51:51.427476) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:51:51.427832) ========= 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=574dc5aafe09851ec43d388c000001b6-1463289730.908691-1848651718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004315 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:51:51.510640) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-15 03:51:51.511382) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-15 03:51:51.512058) ========= ========= Total master_lag: 0.24 =========