builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1461617095.83 results: success (0) buildid: 20160425103006 builduid: 1a87fa8d522747ab8b0da4138352f4b4 revision: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:44:55.834350) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:44:55.837912) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:44:55.838286) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:44:55.855455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:44:55.855847) ========= 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=33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 13:44:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-04-25 13:44:57 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:44:55.990674) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:44:55.991239) ========= 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=33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017908 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:44:56.044537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:44:56.044903) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0d6a91c76a9eddf2219caf028dea130f2d683ec2 --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 0d6a91c76a9eddf2219caf028dea130f2d683ec2 --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=33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 13:44:57,278 truncating revision to first 12 chars 2016-04-25 13:44:57,278 Setting DEBUG logging. 2016-04-25 13:44:57,278 attempt 1/10 2016-04-25 13:44:57,278 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0d6a91c76a9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 13:44:57,964 unpacking tar archive at: mozilla-aurora-0d6a91c76a9e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.949905 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:44:57.011637) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:44:57.012030) ========= script_repo_revision: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:44:57.012492) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:44:57.012799) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:44:57.025126) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-25 13:44:57.025503) ========= /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=33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:44:58 INFO - MultiFileLogger online at 20160425 13:44:58 in /builds/slave/test 13:44:58 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 13:44:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:44:58 INFO - {'append_to_log': False, 13:44:58 INFO - 'base_work_dir': '/builds/slave/test', 13:44:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:44:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:44:58 INFO - 'branch': 'Mozilla-Aurora', 13:44:58 INFO - 'buildbot_json_path': 'buildprops.json', 13:44:58 INFO - 'config_files': ('talos/linux_config.py',), 13:44:58 INFO - 'default_actions': ('clobber', 13:44:58 INFO - 'read-buildbot-config', 13:44:58 INFO - 'download-and-extract', 13:44:58 INFO - 'populate-webroot', 13:44:58 INFO - 'create-virtualenv', 13:44:58 INFO - 'install', 13:44:58 INFO - 'run-tests'), 13:44:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:44:58 INFO - 'download_minidump_stackwalk': True, 13:44:58 INFO - 'download_symbols': 'ondemand', 13:44:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:44:58 INFO - 'tooltool.py': '/tools/tooltool.py', 13:44:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:44:58 INFO - '/tools/misc-python/virtualenv.py')}, 13:44:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:44:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:44:58 INFO - 'installer_path': 'installer.exe', 13:44:58 INFO - 'log_level': 'info', 13:44:58 INFO - 'log_name': 'talos', 13:44:58 INFO - 'log_to_console': True, 13:44:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:44:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:44:58 INFO - 'opt_config_files': (), 13:44:58 INFO - 'pip_index': False, 13:44:58 INFO - 'sps_profile': False, 13:44:58 INFO - 'sps_profile_interval': 0, 13:44:58 INFO - 'suite': 'dromaeojs', 13:44:58 INFO - 'system_bits': '32', 13:44:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:44:58 INFO - 'title': 'talos-linux64-ix-063', 13:44:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:44:58 INFO - 'use_talos_json': True, 13:44:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:44:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:44:58 INFO - 'work_dir': 'build'} 13:44:58 INFO - ##### 13:44:58 INFO - ##### Running clobber step. 13:44:58 INFO - ##### 13:44:58 INFO - Running pre-action listener: _resource_record_pre_action 13:44:58 INFO - Running main action method: clobber 13:44:58 INFO - rmtree: /builds/slave/test/build 13:44:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:44:58 INFO - Running post-action listener: _resource_record_post_action 13:44:58 INFO - ##### 13:44:58 INFO - ##### Running read-buildbot-config step. 13:44:58 INFO - ##### 13:44:58 INFO - Running pre-action listener: _resource_record_pre_action 13:44:58 INFO - Running main action method: read_buildbot_config 13:44:58 INFO - Using buildbot properties: 13:44:58 INFO - { 13:44:58 INFO - "project": "", 13:44:58 INFO - "product": "firefox", 13:44:58 INFO - "script_repo_revision": "production", 13:44:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:44:58 INFO - "repository": "", 13:44:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:44:58 INFO - "buildid": "20160425103006", 13:44:58 INFO - "pgo_build": "True", 13:44:58 INFO - "basedir": "/builds/slave/test", 13:44:58 INFO - "buildnumber": 191, 13:44:58 INFO - "slavename": "talos-linux64-ix-063", 13:44:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:44:58 INFO - "platform": "ubuntu64_hw", 13:44:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:44:58 INFO - "branch": "mozilla-aurora", 13:44:58 INFO - "repo_path": "releases/mozilla-aurora", 13:44:58 INFO - "revision": "0d6a91c76a9eddf2219caf028dea130f2d683ec2", 13:44:58 INFO - "stage_platform": "linux64-pgo", 13:44:58 INFO - "builduid": "1a87fa8d522747ab8b0da4138352f4b4", 13:44:58 INFO - "slavebuilddir": "test" 13:44:58 INFO - } 13:44:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 13:44:58 INFO - Running post-action listener: _resource_record_post_action 13:44:58 INFO - ##### 13:44:58 INFO - ##### Running download-and-extract step. 13:44:58 INFO - ##### 13:44:58 INFO - Running pre-action listener: _resource_record_pre_action 13:44:58 INFO - Running main action method: download_and_extract 13:44:58 INFO - mkdir: /builds/slave/test/build/tests 13:44:58 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')]} 13:44:58 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:44:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:44:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:44:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:44:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:44:59 INFO - Downloaded 1361 bytes. 13:44:59 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:44:59 INFO - Using the following test package requirements: 13:44:59 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:44:59 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:44:59 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:44:59 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:59 INFO - u'jsshell-linux-x86_64.zip'], 13:44:59 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:44:59 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:44:59 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:44:59 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:44:59 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:44:59 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:44:59 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:44:59 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')]} 13:44:59 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:44:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:44:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:44:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:44:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:45:00 INFO - Downloaded 23819986 bytes. 13:45:00 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'] 13:45:00 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 13:45:01 INFO - Return code: 0 13:45:01 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 13:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:01 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:45:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:45:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:45:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:45:04 INFO - Downloaded 23819986 bytes. 13:45:04 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'] 13:45:04 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 13:45:05 INFO - Return code: 0 13:45:05 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')]} 13:45:05 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:45:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:45:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:45:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:45:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:45:06 INFO - Downloaded 10840145 bytes. 13:45:06 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'] 13:45:06 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 13:45:06 INFO - Return code: 0 13:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:06 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:45:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:45:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:45:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:45:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:45:09 INFO - Downloaded 62670906 bytes. 13:45:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:45:09 INFO - mkdir: /builds/slave/test/properties 13:45:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:45:09 INFO - Writing to file /builds/slave/test/properties/build_url 13:45:09 INFO - Contents: 13:45:09 INFO - build_url:https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:45:09 INFO - Running post-action listener: _resource_record_post_action 13:45:09 INFO - Running post-action listener: set_extra_try_arguments 13:45:09 INFO - ##### 13:45:09 INFO - ##### Running populate-webroot step. 13:45:09 INFO - ##### 13:45:09 INFO - Running pre-action listener: _resource_record_pre_action 13:45:09 INFO - Running main action method: populate_webroot 13:45:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:45:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:45:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:45:09 INFO - '--tppagecycles', 13:45:09 INFO - '7'], 13:45:09 INFO - 'tests': ['tsvgm']}}, 13:45:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:45:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:45:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:45:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:45:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:45:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:45:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:09 INFO - 'talos_options': ['--disable-e10s'], 13:45:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:09 INFO - 'talos_options': ['--disable-e10s'], 13:45:09 INFO - 'tests': ['damp', 'tps']}, 13:45:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:09 INFO - 'tests': ['damp', 'tps']}, 13:45:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:45:09 INFO - 'tests': ['dromaeo_dom']}, 13:45:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:45:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:45:09 INFO - 'tests': ['a11yr', 13:45:09 INFO - 'ts_paint', 13:45:09 INFO - 'tpaint', 13:45:09 INFO - 'sessionrestore', 13:45:09 INFO - 'sessionrestore_no_auto_restore', 13:45:09 INFO - 'tabpaint']}, 13:45:09 INFO - 'other-e10s': {'tests': ['a11yr', 13:45:09 INFO - 'ts_paint', 13:45:09 INFO - 'tpaint', 13:45:09 INFO - 'sessionrestore', 13:45:09 INFO - 'sessionrestore_no_auto_restore', 13:45:09 INFO - 'tabpaint']}, 13:45:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:45:09 INFO - 'ts_paint', 13:45:09 INFO - 'tpaint', 13:45:09 INFO - 'sessionrestore', 13:45:09 INFO - 'sessionrestore_no_auto_restore', 13:45:09 INFO - 'tabpaint']}, 13:45:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:45:09 INFO - 'ts_paint', 13:45:09 INFO - 'tpaint', 13:45:09 INFO - 'sessionrestore', 13:45:09 INFO - 'sessionrestore_no_auto_restore', 13:45:09 INFO - 'tabpaint']}, 13:45:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:45:09 INFO - 'tests': ['a11yr', 13:45:09 INFO - 'ts_paint', 13:45:09 INFO - 'tpaint', 13:45:09 INFO - 'sessionrestore', 13:45:09 INFO - 'sessionrestore_no_auto_restore', 13:45:09 INFO - 'tabpaint']}, 13:45:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:45:09 INFO - 'tests': ['a11yr', 13:45:09 INFO - 'ts_paint', 13:45:09 INFO - 'tpaint', 13:45:09 INFO - 'sessionrestore', 13:45:09 INFO - 'sessionrestore_no_auto_restore', 13:45:09 INFO - 'tabpaint']}, 13:45:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:45:09 INFO - 'tests': ['tsvgx', 13:45:09 INFO - 'tsvgr_opacity', 13:45:09 INFO - 'tart', 13:45:09 INFO - 'tscrollx', 13:45:09 INFO - 'cart']}, 13:45:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:45:09 INFO - 'tsvgr_opacity', 13:45:09 INFO - 'tart', 13:45:09 INFO - 'tscrollx', 13:45:09 INFO - 'cart']}, 13:45:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:09 INFO - 'talos_options': ['--disable-e10s'], 13:45:09 INFO - 'tests': ['tp5o']}, 13:45:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:09 INFO - 'tests': ['tp5o']}, 13:45:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:09 INFO - 'talos_options': ['--disable-e10s', 13:45:09 INFO - '--xperf_path', 13:45:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:09 INFO - 'tests': ['tp5n']}, 13:45:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:09 INFO - 'talos_options': ['--xperf_path', 13:45:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:09 INFO - 'tests': ['tp5n']}}, 13:45:09 INFO - 'talos.zip': {'path': '', 13:45:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:45:09 INFO - Running post-action listener: _resource_record_post_action 13:45:09 INFO - ##### 13:45:09 INFO - ##### Running create-virtualenv step. 13:45:09 INFO - ##### 13:45:09 INFO - Running pre-action listener: _resource_record_pre_action 13:45:09 INFO - Running main action method: create_virtualenv 13:45:09 INFO - Creating virtualenv /builds/slave/test/build/venv 13:45:09 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 13:45:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:45:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:45:10 INFO - Using real prefix '/usr' 13:45:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:45:10 INFO - Installing distribute.............................................................................................................................................................................................done. 13:45:12 INFO - Installing pip.................done. 13:45:12 INFO - Return code: 0 13:45:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:12 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 0x7fd05a9cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08410>, '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 0x1d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d097a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', '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 13:45:12 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 13:45:12 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 13:45:12 INFO - Using env: {'DISPLAY': ':0', 13:45:12 INFO - 'HOME': '/home/cltbld', 13:45:12 INFO - 'LANG': 'en_US.UTF-8', 13:45:12 INFO - 'LANGUAGE': 'en_US:en', 13:45:12 INFO - 'LOGNAME': 'cltbld', 13:45:12 INFO - 'MAIL': '/var/mail/cltbld', 13:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:12 INFO - 'MOZ_NO_REMOTE': '1', 13:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:12 INFO - 'NO_EM_RESTART': '1', 13:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:12 INFO - 'PWD': '/builds/slave/test', 13:45:12 INFO - 'SHELL': '/bin/bash', 13:45:12 INFO - 'SHLVL': '1', 13:45:12 INFO - 'TERM': 'linux', 13:45:12 INFO - 'TMOUT': '86400', 13:45:12 INFO - 'USER': 'cltbld', 13:45:12 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', 13:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:12 INFO - '_': '/tools/buildbot/bin/python'} 13:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:12 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 13:45:12 INFO - Cleaning up... 13:45:12 INFO - Return code: 0 13:45:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:12 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 0x7fd05a9cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08410>, '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 0x1d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d097a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', '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 13:45:12 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 13:45:12 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 13:45:12 INFO - Using env: {'DISPLAY': ':0', 13:45:12 INFO - 'HOME': '/home/cltbld', 13:45:12 INFO - 'LANG': 'en_US.UTF-8', 13:45:12 INFO - 'LANGUAGE': 'en_US:en', 13:45:12 INFO - 'LOGNAME': 'cltbld', 13:45:12 INFO - 'MAIL': '/var/mail/cltbld', 13:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:12 INFO - 'MOZ_NO_REMOTE': '1', 13:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:12 INFO - 'NO_EM_RESTART': '1', 13:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:12 INFO - 'PWD': '/builds/slave/test', 13:45:12 INFO - 'SHELL': '/bin/bash', 13:45:12 INFO - 'SHLVL': '1', 13:45:12 INFO - 'TERM': 'linux', 13:45:12 INFO - 'TMOUT': '86400', 13:45:12 INFO - 'USER': 'cltbld', 13:45:12 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', 13:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:12 INFO - '_': '/tools/buildbot/bin/python'} 13:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:12 INFO - Downloading/unpacking psutil>=0.7.1 13:45:12 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 13:45:12 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 13:45:12 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 13:45:12 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 13:45:12 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 13:45:12 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 13:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:45:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:15 INFO - Installing collected packages: psutil 13:45:15 INFO - Running setup.py install for psutil 13:45:15 INFO - building 'psutil._psutil_linux' extension 13:45:15 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 13:45:15 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 13:45:15 INFO - building 'psutil._psutil_posix' extension 13:45:15 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 13:45:15 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 13:45:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:15 INFO - Successfully installed psutil 13:45:15 INFO - Cleaning up... 13:45:15 INFO - Return code: 0 13:45:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:45: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')]} 13:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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')]} 13:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:15 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 0x7fd05a9cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08410>, '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 0x1d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d097a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', '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 13:45:15 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 13:45:15 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 13:45:15 INFO - Using env: {'DISPLAY': ':0', 13:45:15 INFO - 'HOME': '/home/cltbld', 13:45:15 INFO - 'LANG': 'en_US.UTF-8', 13:45:15 INFO - 'LANGUAGE': 'en_US:en', 13:45:15 INFO - 'LOGNAME': 'cltbld', 13:45:15 INFO - 'MAIL': '/var/mail/cltbld', 13:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:15 INFO - 'MOZ_NO_REMOTE': '1', 13:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:15 INFO - 'NO_EM_RESTART': '1', 13:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:15 INFO - 'PWD': '/builds/slave/test', 13:45:15 INFO - 'SHELL': '/bin/bash', 13:45:15 INFO - 'SHLVL': '1', 13:45:15 INFO - 'TERM': 'linux', 13:45:15 INFO - 'TMOUT': '86400', 13:45:15 INFO - 'USER': 'cltbld', 13:45:15 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', 13:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:15 INFO - '_': '/tools/buildbot/bin/python'} 13:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:45:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:45:17 INFO - Installing collected packages: mozsystemmonitor 13:45:17 INFO - Running setup.py install for mozsystemmonitor 13:45:17 INFO - Successfully installed mozsystemmonitor 13:45:17 INFO - Cleaning up... 13:45:17 INFO - Return code: 0 13:45:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:17 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 0x7fd05a9cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08410>, '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 0x1d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d097a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', '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 13:45:17 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 13:45:17 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 13:45:17 INFO - Using env: {'DISPLAY': ':0', 13:45:17 INFO - 'HOME': '/home/cltbld', 13:45:17 INFO - 'LANG': 'en_US.UTF-8', 13:45:17 INFO - 'LANGUAGE': 'en_US:en', 13:45:17 INFO - 'LOGNAME': 'cltbld', 13:45:17 INFO - 'MAIL': '/var/mail/cltbld', 13:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:17 INFO - 'MOZ_NO_REMOTE': '1', 13:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:17 INFO - 'NO_EM_RESTART': '1', 13:45:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:17 INFO - 'PWD': '/builds/slave/test', 13:45:17 INFO - 'SHELL': '/bin/bash', 13:45:17 INFO - 'SHLVL': '1', 13:45:17 INFO - 'TERM': 'linux', 13:45:17 INFO - 'TMOUT': '86400', 13:45:17 INFO - 'USER': 'cltbld', 13:45:17 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', 13:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:17 INFO - '_': '/tools/buildbot/bin/python'} 13:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:18 INFO - Downloading/unpacking blobuploader==1.2.4 13:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:19 INFO - Downloading blobuploader-1.2.4.tar.gz 13:45:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:45:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:45:20 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 13:45:20 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 13:45:20 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 13:45:20 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 13:45:20 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 13:45:20 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 13:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:45:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:45:20 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 13:45:20 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 13:45:20 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 13:45:20 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 13:45:20 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 13:45:20 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 13:45:20 INFO - Downloading docopt-0.6.1.tar.gz 13:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:45:20 INFO - Installing collected packages: blobuploader, requests, docopt 13:45:20 INFO - Running setup.py install for blobuploader 13:45:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:45:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:45:20 INFO - Running setup.py install for requests 13:45:21 INFO - Running setup.py install for docopt 13:45:21 INFO - Successfully installed blobuploader requests docopt 13:45:21 INFO - Cleaning up... 13:45:21 INFO - Return code: 0 13:45:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:21 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')]} 13:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:21 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')]} 13:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:21 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 0x7fd05a9cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08410>, '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 0x1d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d097a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', '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 13:45:21 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 13:45:21 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 13:45:21 INFO - Using env: {'DISPLAY': ':0', 13:45:21 INFO - 'HOME': '/home/cltbld', 13:45:21 INFO - 'LANG': 'en_US.UTF-8', 13:45:21 INFO - 'LANGUAGE': 'en_US:en', 13:45:21 INFO - 'LOGNAME': 'cltbld', 13:45:21 INFO - 'MAIL': '/var/mail/cltbld', 13:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:21 INFO - 'MOZ_NO_REMOTE': '1', 13:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:21 INFO - 'NO_EM_RESTART': '1', 13:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:21 INFO - 'PWD': '/builds/slave/test', 13:45:21 INFO - 'SHELL': '/bin/bash', 13:45:21 INFO - 'SHLVL': '1', 13:45:21 INFO - 'TERM': 'linux', 13:45:21 INFO - 'TMOUT': '86400', 13:45:21 INFO - 'USER': 'cltbld', 13:45:21 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', 13:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:21 INFO - '_': '/tools/buildbot/bin/python'} 13:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:45:21 INFO - Running setup.py (path:/tmp/pip-LKj5px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:45:21 INFO - Running setup.py (path:/tmp/pip-fyHW0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:45:21 INFO - Running setup.py (path:/tmp/pip-1GBYfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:45:21 INFO - Running setup.py (path:/tmp/pip-AfhTfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:45:21 INFO - Running setup.py (path:/tmp/pip-cIUs0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:45:21 INFO - Running setup.py (path:/tmp/pip-QEyZ_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:45:21 INFO - Running setup.py (path:/tmp/pip-t3BLeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:45:22 INFO - Running setup.py (path:/tmp/pip-4W6x41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:45:22 INFO - Running setup.py (path:/tmp/pip-PLpV_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:45:22 INFO - Running setup.py (path:/tmp/pip-6EOrgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:45:22 INFO - Running setup.py (path:/tmp/pip-V552XB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:45:22 INFO - Running setup.py (path:/tmp/pip-EzTa7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:45:22 INFO - Running setup.py (path:/tmp/pip-3aMg_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:45:22 INFO - Running setup.py (path:/tmp/pip-DJ9GLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:22 INFO - Running setup.py (path:/tmp/pip-5ozyzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:45:22 INFO - Running setup.py (path:/tmp/pip-vYaukl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:45:22 INFO - Running setup.py (path:/tmp/pip-RxT2t1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:45:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:45:22 INFO - Running setup.py install for manifestparser 13:45:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:45:22 INFO - Running setup.py install for mozcrash 13:45:22 INFO - Running setup.py install for mozdebug 13:45:23 INFO - Running setup.py install for mozdevice 13:45:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Running setup.py install for mozfile 13:45:23 INFO - Running setup.py install for mozhttpd 13:45:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Running setup.py install for mozinfo 13:45:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Running setup.py install for mozInstall 13:45:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Running setup.py install for mozleak 13:45:23 INFO - Running setup.py install for mozlog 13:45:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Running setup.py install for moznetwork 13:45:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Running setup.py install for mozprocess 13:45:24 INFO - Running setup.py install for mozprofile 13:45:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:45:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:45:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:45:24 INFO - Running setup.py install for mozrunner 13:45:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:45:24 INFO - Running setup.py install for mozscreenshot 13:45:24 INFO - Running setup.py install for moztest 13:45:24 INFO - Running setup.py install for mozversion 13:45:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:45:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:45:24 INFO - Cleaning up... 13:45:24 INFO - Return code: 0 13:45:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:24 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 0x7fd05a9cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08410>, '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 0x1d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d097a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', '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 13:45:24 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 13:45:24 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 13:45:24 INFO - Using env: {'DISPLAY': ':0', 13:45:24 INFO - 'HOME': '/home/cltbld', 13:45:24 INFO - 'LANG': 'en_US.UTF-8', 13:45:24 INFO - 'LANGUAGE': 'en_US:en', 13:45:24 INFO - 'LOGNAME': 'cltbld', 13:45:24 INFO - 'MAIL': '/var/mail/cltbld', 13:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:24 INFO - 'MOZ_NO_REMOTE': '1', 13:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:24 INFO - 'NO_EM_RESTART': '1', 13:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:24 INFO - 'PWD': '/builds/slave/test', 13:45:24 INFO - 'SHELL': '/bin/bash', 13:45:24 INFO - 'SHLVL': '1', 13:45:24 INFO - 'TERM': 'linux', 13:45:24 INFO - 'TMOUT': '86400', 13:45:24 INFO - 'USER': 'cltbld', 13:45:24 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', 13:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:24 INFO - '_': '/tools/buildbot/bin/python'} 13:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:45:24 INFO - Running setup.py (path:/tmp/pip-cmlEyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:45:24 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)) 13:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:45:24 INFO - Running setup.py (path:/tmp/pip-x48Evk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:45:24 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)) 13:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:45:24 INFO - Running setup.py (path:/tmp/pip-lFKfOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:45:24 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)) 13:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:45:25 INFO - Running setup.py (path:/tmp/pip-UrzjCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:45:25 INFO - Running setup.py (path:/tmp/pip-iMhf0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:45:25 INFO - Running setup.py (path:/tmp/pip-t2eW6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:45:25 INFO - Running setup.py (path:/tmp/pip-zE3hwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:45:25 INFO - Running setup.py (path:/tmp/pip-yHN9qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:45:25 INFO - Running setup.py (path:/tmp/pip-ZuFfro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:45:25 INFO - Running setup.py (path:/tmp/pip-lvnIGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:45:25 INFO - Running setup.py (path:/tmp/pip-1xa_JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:45:25 INFO - Running setup.py (path:/tmp/pip-1bxmhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:45:25 INFO - Running setup.py (path:/tmp/pip-_pt1aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:45:25 INFO - Running setup.py (path:/tmp/pip-fPxl1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:25 INFO - Running setup.py (path:/tmp/pip-H7zr5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:45:25 INFO - Running setup.py (path:/tmp/pip-N_3FgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:45:25 INFO - Running setup.py (path:/tmp/pip-qXUjwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:45:26 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)) 13:45:26 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)) 13:45:26 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)) 13:45:26 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)) 13:45:26 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)) 13:45:26 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)) 13:45:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:27 INFO - Downloading blessings-1.6.tar.gz 13:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:45:27 INFO - Installing collected packages: blessings 13:45:27 INFO - Running setup.py install for blessings 13:45:28 INFO - Successfully installed blessings 13:45:28 INFO - Cleaning up... 13:45:28 INFO - Return code: 0 13:45:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:45:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:28 INFO - Reading from file tmpfile_stdout 13:45:28 INFO - Current package versions: 13:45:28 INFO - argparse == 1.2.1 13:45:28 INFO - blessings == 1.6 13:45:28 INFO - blobuploader == 1.2.4 13:45:28 INFO - docopt == 0.6.1 13:45:28 INFO - manifestparser == 1.1 13:45:28 INFO - mozInstall == 1.12 13:45:28 INFO - mozcrash == 0.17 13:45:28 INFO - mozdebug == 0.1 13:45:28 INFO - mozdevice == 0.48 13:45:28 INFO - mozfile == 1.2 13:45:28 INFO - mozhttpd == 0.7 13:45:28 INFO - mozinfo == 0.9 13:45:28 INFO - mozleak == 0.1 13:45:28 INFO - mozlog == 3.1 13:45:28 INFO - moznetwork == 0.27 13:45:28 INFO - mozprocess == 0.22 13:45:28 INFO - mozprofile == 0.28 13:45:28 INFO - mozrunner == 6.11 13:45:28 INFO - mozscreenshot == 0.1 13:45:28 INFO - mozsystemmonitor == 0.0 13:45:28 INFO - moztest == 0.7 13:45:28 INFO - mozversion == 1.4 13:45:28 INFO - psutil == 3.1.1 13:45:28 INFO - requests == 1.2.3 13:45:28 INFO - wsgiref == 0.1.2 13:45:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45: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')]} 13:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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')]} 13:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:28 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 0x7fd05a9cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08410>, '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 0x1d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d097a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', '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 13:45:28 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 13:45:28 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 13:45:28 INFO - Using env: {'DISPLAY': ':0', 13:45:28 INFO - 'HOME': '/home/cltbld', 13:45:28 INFO - 'LANG': 'en_US.UTF-8', 13:45:28 INFO - 'LANGUAGE': 'en_US:en', 13:45:28 INFO - 'LOGNAME': 'cltbld', 13:45:28 INFO - 'MAIL': '/var/mail/cltbld', 13:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:28 INFO - 'MOZ_NO_REMOTE': '1', 13:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:28 INFO - 'NO_EM_RESTART': '1', 13:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:28 INFO - 'PWD': '/builds/slave/test', 13:45:28 INFO - 'SHELL': '/bin/bash', 13:45:28 INFO - 'SHLVL': '1', 13:45:28 INFO - 'TERM': 'linux', 13:45:28 INFO - 'TMOUT': '86400', 13:45:28 INFO - 'USER': 'cltbld', 13:45:28 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', 13:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:28 INFO - '_': '/tools/buildbot/bin/python'} 13:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:28 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)) 13:45:28 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)) 13:45:28 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)) 13:45:28 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)) 13:45:28 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)) 13:45:28 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)) 13:45:28 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)) 13:45:28 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)) 13:45:28 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)) 13:45:28 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)) 13:45:28 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)) 13:45:28 INFO - Cleaning up... 13:45:28 INFO - Return code: 0 13:45:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:45: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')]} 13:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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')]} 13:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd05a9cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08410>, '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 0x1d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d097a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', '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 13:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:45:28 INFO - Using env: {'DISPLAY': ':0', 13:45:28 INFO - 'HOME': '/home/cltbld', 13:45:28 INFO - 'LANG': 'en_US.UTF-8', 13:45:28 INFO - 'LANGUAGE': 'en_US:en', 13:45:28 INFO - 'LOGNAME': 'cltbld', 13:45:28 INFO - 'MAIL': '/var/mail/cltbld', 13:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:28 INFO - 'MOZ_NO_REMOTE': '1', 13:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:28 INFO - 'NO_EM_RESTART': '1', 13:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:28 INFO - 'PWD': '/builds/slave/test', 13:45:28 INFO - 'SHELL': '/bin/bash', 13:45:28 INFO - 'SHLVL': '1', 13:45:28 INFO - 'TERM': 'linux', 13:45:28 INFO - 'TMOUT': '86400', 13:45:28 INFO - 'USER': 'cltbld', 13:45:28 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', 13:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:28 INFO - '_': '/tools/buildbot/bin/python'} 13:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:28 INFO - Downloading/unpacking jsonschema 13:45:28 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 13:45:28 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 13:45:28 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 13:45:28 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 13:45:28 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 13:45:28 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 13:45:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:45:30 INFO - Downloading/unpacking functools32 (from jsonschema) 13:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:30 INFO - Downloading functools32-3.2.3-2.tar.gz 13:45:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:45:30 INFO - warning: no files found matching '*.txt' 13:45:30 INFO - no previously-included directories found matching 'build' 13:45:30 INFO - no previously-included directories found matching 'dist' 13:45:30 INFO - no previously-included directories found matching '.git*' 13:45:30 INFO - Installing collected packages: jsonschema, functools32 13:45:30 INFO - Running setup.py install for functools32 13:45:31 INFO - warning: no files found matching '*.txt' 13:45:31 INFO - no previously-included directories found matching 'build' 13:45:31 INFO - no previously-included directories found matching 'dist' 13:45:31 INFO - no previously-included directories found matching '.git*' 13:45:31 INFO - Successfully installed jsonschema functools32 13:45:31 INFO - Cleaning up... 13:45:31 INFO - Return code: 0 13:45:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:31 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 0x7fd05a9cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d08410>, '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 0x1d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d097a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', '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 13:45:31 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 13:45:31 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 13:45:31 INFO - Using env: {'DISPLAY': ':0', 13:45:31 INFO - 'HOME': '/home/cltbld', 13:45:31 INFO - 'LANG': 'en_US.UTF-8', 13:45:31 INFO - 'LANGUAGE': 'en_US:en', 13:45:31 INFO - 'LOGNAME': 'cltbld', 13:45:31 INFO - 'MAIL': '/var/mail/cltbld', 13:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:31 INFO - 'MOZ_NO_REMOTE': '1', 13:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:31 INFO - 'NO_EM_RESTART': '1', 13:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:31 INFO - 'PWD': '/builds/slave/test', 13:45:31 INFO - 'SHELL': '/bin/bash', 13:45:31 INFO - 'SHLVL': '1', 13:45:31 INFO - 'TERM': 'linux', 13:45:31 INFO - 'TMOUT': '86400', 13:45:31 INFO - 'USER': 'cltbld', 13:45:31 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', 13:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:31 INFO - '_': '/tools/buildbot/bin/python'} 13:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:31 INFO - Downloading/unpacking flake8 13:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:45:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:45:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:45:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:45:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:45:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:45:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:45:33 INFO - no previously-included directories found matching 'docs/_build' 13:45:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:45:33 INFO - Running setup.py install for pep8 13:45:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:45:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:45:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:45:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:45:34 INFO - no previously-included directories found matching 'docs/_build' 13:45:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:45:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:45:34 INFO - Cleaning up... 13:45:34 INFO - Return code: 0 13:45:34 INFO - Running post-action listener: _resource_record_post_action 13:45:34 INFO - Running post-action listener: _start_resource_monitoring 13:45:34 INFO - Starting resource monitoring. 13:45:34 INFO - ##### 13:45:34 INFO - ##### Running install step. 13:45:34 INFO - ##### 13:45:34 INFO - Running pre-action listener: _resource_record_pre_action 13:45:34 INFO - Running main action method: install 13:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:34 INFO - Reading from file tmpfile_stdout 13:45:34 INFO - Detecting whether we're running mozinstall >=1.0... 13:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:45:34 INFO - Reading from file tmpfile_stdout 13:45:34 INFO - Output received: 13:45:34 INFO - Usage: mozinstall [options] installer 13:45:34 INFO - Options: 13:45:34 INFO - -h, --help show this help message and exit 13:45:34 INFO - -d DEST, --destination=DEST 13:45:34 INFO - Directory to install application into. [default: 13:45:34 INFO - "/builds/slave/test"] 13:45:34 INFO - --app=APP Application being installed. [default: firefox] 13:45:34 INFO - mkdir: /builds/slave/test/build/application 13:45:34 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'] 13:45:34 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 13:45:50 INFO - Reading from file tmpfile_stdout 13:45:50 INFO - Output received: 13:45:50 INFO - /builds/slave/test/build/application/firefox/firefox 13:45:50 INFO - Running post-action listener: _resource_record_post_action 13:45:50 INFO - ##### 13:45:50 INFO - ##### Running run-tests step. 13:45:50 INFO - ##### 13:45:50 INFO - Running pre-action listener: _resource_record_pre_action 13:45:50 INFO - Running main action method: run_tests 13:45:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:45:50 INFO - Python 2.7.3 13:45:50 INFO - Return code: 0 13:45:50 INFO - grabbing minidump binary from tooltool 13:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:50 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 0x1d08410>, '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 0x1d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d097a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:45:50 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 13:45:50 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 13:45:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:45:50 INFO - Return code: 0 13:45:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:45:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:45:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:45:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:45:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:45:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:45:51 INFO - Return code: 0 13:45:51 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/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 13:45:51 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/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 13:45:51 INFO - Using env: {'DISPLAY': ':0', 13:45:51 INFO - 'HOME': '/home/cltbld', 13:45:51 INFO - 'LANG': 'en_US.UTF-8', 13:45:51 INFO - 'LANGUAGE': 'en_US:en', 13:45:51 INFO - 'LOGNAME': 'cltbld', 13:45:51 INFO - 'MAIL': '/var/mail/cltbld', 13:45:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:45:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:51 INFO - 'MOZ_NO_REMOTE': '1', 13:45:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:51 INFO - 'NO_EM_RESTART': '1', 13:45:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:51 INFO - 'PWD': '/builds/slave/test', 13:45:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:45:51 INFO - 'SHELL': '/bin/bash', 13:45:51 INFO - 'SHLVL': '1', 13:45:51 INFO - 'TERM': 'linux', 13:45:51 INFO - 'TMOUT': '86400', 13:45:51 INFO - 'USER': 'cltbld', 13:45:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500', 13:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:51 INFO - '_': '/tools/buildbot/bin/python'} 13:45:51 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/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 13:45:51 INFO - mozversion application_buildid: 20160425103006 13:45:51 INFO - mozversion application_changeset: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 13:45:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:45:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:45:51 INFO - mozversion application_name: Firefox 13:45:51 INFO - mozversion application_remotingname: firefox-dev 13:45:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:45:51 INFO - mozversion application_vendor: Mozilla 13:45:51 INFO - mozversion application_version: 48.0a2 13:45:51 INFO - mozversion platform_buildid: 20160425103006 13:45:51 INFO - mozversion platform_changeset: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 13:45:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:45:51 INFO - mozversion platform_version: 48.0a2 13:45:51 INFO - using testdate: 1461617151 13:45:51 INFO - actual date: 1461617151 13:45:51 INFO - starting webserver on 'localhost:47041' 13:45:51 INFO - SUITE-START | Running 2 tests 13:45:51 INFO - TEST-START | dromaeo_css 13:45:51 INFO - operating with platform_type : linux_ 13:45:51 INFO - Initialising browser for dromaeo_css test... 13:45:51 INFO - TEST-INFO | started process 21241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDGWByu/profile http://localhost:47041/getInfo.html) 13:45:55 INFO - PROCESS | 21241 | __metrics Screen width/height:1600/1200 13:45:55 INFO - PROCESS | 21241 | colorDepth:24 13:45:55 INFO - PROCESS | 21241 | Browser inner width/height: 1024/697 13:45:55 INFO - PROCESS | 21241 | __metrics 13:45:57 ERROR - PROCESS | 21241 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:45:57 INFO - TEST-INFO | 21241: exit 0 13:45:57 INFO - Browser initialized. 13:45:57 INFO - Running cycle 1/1 for dromaeo_css test... 13:45:57 INFO - TEST-INFO | started process 21334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDGWByu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:46:09 INFO - PROCESS | 21334 | RSS: Main: 142389248 13:46:09 INFO - PROCESS | 21334 | 13:47:00 INFO - PROCESS | 21334 | 1461617220763 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] 13:49:08 INFO - PROCESS | 21334 | Cycle 1(1): loaded http://localhost:47041/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47041/tests/dromaeo/cssquery-ext.html) 13:49:09 INFO - PROCESS | 21334 | RSS: Main: 252497920 13:49:09 INFO - PROCESS | 21334 | 13:52:11 INFO - PROCESS | 21334 | Cycle 1(1): loaded http://localhost:47041/tests/dromaeo/cssquery-ext.html (next: http://localhost:47041/tests/dromaeo/cssquery-jquery.html) 13:52:12 INFO - PROCESS | 21334 | RSS: Main: 221794304 13:52:12 INFO - PROCESS | 21334 | 13:55:14 INFO - PROCESS | 21334 | Cycle 1(1): loaded http://localhost:47041/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47041/tests/dromaeo/cssquery-mootools.html) 13:55:14 INFO - PROCESS | 21334 | RSS: Main: 226115584 13:55:14 INFO - PROCESS | 21334 | 13:58:16 INFO - PROCESS | 21334 | Cycle 1(1): loaded http://localhost:47041/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47041/tests/dromaeo/cssquery-prototype.html) 13:58:17 INFO - PROCESS | 21334 | RSS: Main: 220250112 13:58:17 INFO - PROCESS | 21334 | 14:01:19 INFO - PROCESS | 21334 | Cycle 1(1): loaded http://localhost:47041/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47041/tests/dromaeo/cssquery-yui.html) 14:01:20 INFO - PROCESS | 21334 | RSS: Main: 212008960 14:01:20 INFO - PROCESS | 21334 | 14:04:22 INFO - PROCESS | 21334 | Cycle 1(1): loaded http://localhost:47041/tests/dromaeo/cssquery-yui.html (next: http://localhost:47041/tests/dromaeo/cssquery-dojo.html) 14:04:23 INFO - PROCESS | 21334 | RSS: Main: 251363328 14:04:23 INFO - PROCESS | 21334 | 14:04:23 INFO - PROCESS | 21334 | __start_tp_report 14:04:23 INFO - PROCESS | 21334 | _x_x_mozilla_page_load 14:04:23 INFO - PROCESS | 21334 | _x_x_mozilla_page_load_details 14:04:23 INFO - PROCESS | 21334 | |i|pagename|runs| 14:04:23 INFO - PROCESS | 21334 | |0;dojo.html;3370.4438767603347;3404.37019151457;3430.1253180438985;3450.0684815099926;3481.338545676322;5626;5648.181013753004;5655.745491452884;5671.886562268752;5696.003199440097;5651.660900345983;5656.632318899268;5674.631148975313;5683.630564013336;5723.313202415706;4950.777215025315;5196.454372290912;5220.164773636219;5285.920711189336;5308.5487733542695;5095.133827249358;5115.616328775357;5120.052790233819;5125.103106956268;5125.103106956286;5128.820491282806;5132.666376685522;5177.042247184264;5192.688438693691;5200.895982080356;5209.505097015777;5310.654807437504;5317.149256119041;5320.441353657888;5356.250124982505;5048.697078175322;5058.924116138261;5135.871603209912;5213.817516386908;5215.035218484592;5538.335399752015;5557.472040156179;5592.496675299242;5598.972005139989;5603.551715862721;6012.849678758066;6016.548758843104;6028.246469191351;6029.125776762345;6032.879342413171;6041.486473649745;6073.908891366589;6088.208532890741;6092.299385570672;6113.050656958994;5574.219609254707;5621.353544342372;5622.184783206494;5623.325200975868;5654.434556544354;6067.764007036494;6107.755689772448;6113.554518421814;6115.357887421846;6125.785597504066;5925.466707996215;5996.580239383201;6012.128241404972;6023.66869822164;6037.034074548139;5970.701464926737;5991.640501569833;5993.041113421831;6004.759809607567;6004.849878753066;5822.650640961556;5943.673097979653;5953.642781433128;5961.672108034099;5976.223090998229;6037.15479832815;6038.698065096728;6044.637321760709;6062.878742425127;6081.969590152021;4575.771211439482;4578.839740609063;4579.656525760582;4586.908261834811;4600.470945841204;4006.759594424344;4048.959510404858;4107.424960505532;4114.6091121343425;4133.256013917464;5724.227229324071;5738.512226460798;5740.971295143581;5743.368229494752;5764.7117644117625;5996.4603185713495;6056.666883321372;6062.393760623902;6078.1186727924205;6078.240219972504;5649.0396632572565;5686.09022556389;5736.42635736423;5790.131480277992;5792.275965504312;5164.302819119446;5175.4824517548695;5193.169092945111;5196.636235463481;5199;6272.780452684134;6297.370262973757;6300.3699630037545;6303.495720342362;6306.369363063657;5893;6032.426919442646;6100;6126.448619624255;6136.631802091889;6310.7791227306825;6367.267764207176;6367.586106903036;6371.458426033653;6372.522060845363;5873.148393482836;6005.429484199169;6019.367966363468;6021.157038014769;6028.788992385245;6029.909551356821;6079.635221886701;6094.421030002142;6099.024156134997;6139.723712432862;5864.618799778001;5889.322727886177;5902.144189092472;5905.320888097924;5910.881782364415;5822.70886455684;5839.532837372915;5844.824655260349;5897.292324921037;5899.528037757055;5767.106098554731;5773.364929857628;5774.422557744192;5775.537956963517;5806.042003069446;5900.822975310747;5915.645061296336;5917.822465326047;5928.614640048383;5930.140129681258;5657.519110875457;5821.738021789114;5826.067829147316;5856.59003869725;5893.823185304448 14:04:23 INFO - PROCESS | 21334 | |1;ext.html;612.3142080869427;662.6057495790005;666.2105405094962;669.7957123077465;672.5628341577974;32777.18057048575;40780.38829417557;41544.79227603865;41614.79192604033;41698.791506042464;42502.14995700092;43340;43468.565314346844;43503;43506.347404788874;8308.916910830905;8487.490750554956;8871.556422178897;9135.68025119121;10441.42572158531;10521.526531306072;10719.678409647684;10719.785604287948;10720.463976801168;10727.731806704816;10588.682339529827;10824.134069274478;10825.945870270676;10828;10832.241743077988;8051.315638170762;8251.793705157419;10539.683809485728;10632.255742098056;10777.407242601654;10590.947045264724;10734.355938643628;10742.677719668345;10746.946265268702;10747.355158690425;40503.59496405028;41104.794476027426;41154;41179.382309265384;41305.38041929343;3675.3016926783826;3737.588865224823;3748.175401411685;3884.495015647976;4314.352847072964;34633.653663463294;34874;35251;35540.28919421597;35630.82184589087;4636.142313671948;4673.252279635276;4687.390639216914;4704.835330763441;4712.151812673717;246238;248183;248215;248630;248790;67629;68316.6584167086;68888;68994.31005689979;69022.30977690259;64031.6798416005;65421.34578654248;65436.67281663561;65624.34375656278;72859.27140728525;16651.333946642;16724.41464548759;16758.497245082668;16767.413140540022;16783.412580559867;11313.604023859125;11786.823197652042;12146.75706485883;12398.62804115878;12527.686807829878;20871.58256834855;21262.78737212608;21330.573388532142;21341.893290533448;21406.250781222894;7688.692452301957;7858.685652573948;7915;7981.64082616272;8048.557329346825;1057.360297020307;1074.435921141407;1105.2705214558353;1120.3781901044836;1148.6324376199536;33901.83049084788;34549;34680.826595866856;34780.30439391198;34811;1192.3144192089583;1251.9109818587413;1291.0510774580675;1299.7660421124287;1323.5963031275553;18317.81682183188;18479.907600461913;18550.536236594195;18551.628967420846;18648.813511864708;571301;574245;578631;579693;581090;63564;64149;64157.358426416075;64593.35406645967;64620;1462.997846475168;1469.9044562103643;1498.7227362937892;1566.8903176777517;1594.545554516957;30449;31209;31976.36047279088;32464.83767581147;33741.66258337385;49724;49910.251346230565;50247.246291306394;50345;50399.24401133913;311140;311640;312860;312879;313058;24013.639795403433;28259.15222543327;29000.854995724887;29011.419771604873;29099.709002910546;44286.77856610825;45330.54669453263;45699.31451028171;45835.77082114568;45882.31176532288;37043.814780925924;37866.432003520524;38320.23359532849;38879;39442.21115577615;40614.59385406227;41036.38445423261;41386;42659.36010959776;43142;43144.35283470813;44015.77992110019;44164;44297.55702443063;44304.778476107414;34332.31335373328;35884.820575896956;35893.641063590076;36154;38736.22527549489;26920.865395673678;27343.589846151925;27556.586651199847;27771.305717357227;27873 14:04:23 INFO - PROCESS | 21334 | |2;jquery.html;391.26637554585153;402.31807086987567;403.6891593473025;407.8478298805874;416.77285879195836;19002.99999999998;19456.610867782634;19840.503987400305;19873;19961.800381996174;16251.674966500663;16775.24511396987;16798.412055578057;18141.81858181418;18157.364492242774;5711.457411545907;5763.884722305552;5830.096335068071;5831;5832.1834943108;5664.801731939383;5722.284714410699;5754.798582049629;5795.768169273224;5845.85385365365;5612.803551875685;5763.9711801440935;5813.767449302023;5818.970905145468;5820.010598198316;5740.856478588027;5772.5670574706855;5778.768849246025;5789.65262084272;5797.652140871562;4910.631702622318;5144.922826157611;5175.301334319856;5175.741212939338;5187.662801917901;24171.274861754177;24352.512949740907;24864.3783905402;25100.121495747742;25113.497730045296;2313.5719891820067;2414.9637755433682;2474.270090323359;2576.7680908718116;2948.528235482334;9900.90099099007;9977.600895964226;10001.149902258318;10006.399616022989;12162.452689628988;1917.6068905874263;2020.1818263603263;2077.3248694174304;2117.9743629374407;2154.1060459909118;68454.65772671155;72690.9096363555;72749.27250727531;90960.54519727424;92403.53798230966;8976.115015846615;11059.336439813476;11143.108551316038;11151.721206969729;11248.26886252391;13210.141340812816;14641.633959151106;15378;15518.301676424588;15711.371545138296;7842.529448233125;7944.9205507945335;8138.959305203554;8215.09633940266;8244.54654993981;7384.2246564111065;7384.372328352043;7504.587247701429;7549.433792465587;7563.810904727426;4744.288356746516;4801.831935882297;4846.975765121152;4852.4662287148385;4871.074495845778;1933.574613585009;1971.083446197525;1975.259277770836;1975.4764987278095;1975.8715683480527;939.7180845746249;1042.5308611124872;1091.4433638844089;1119.3339962722168;1135.5911871726173;20036.599268014557;20038.795732469418;20252.392428227176;20388.28640997558;20606;1035.1253191053547;1049.8582691336724;1082.7726177502655;1111.6609434122508;1125.2123513540555;10685.679429617125;10897.83653245202;11221.326720396803;11254.49354779037;11317.320960742381;543363;545021;545985;551455;586326;99805;104779;105578;106472.46763766286;106966;1050.4432650695144;1074.398336931321;1074.9301295415773;1078.3475997021847;1079.6707004363586;17358.82641173572;17767.911160444633;17771.289148434436;17942.55143621368;18088;28054.579181312703;35764.46353304754;36432;40945;42534.5746542543;44968.55031449644;46558.30162547632;50180.74909625574;52140.739296303276;56186.43813561812;8510.214746062258;8534.74395768128;8649.264812491008;8729.214370706666;8810.207081362709;9124.5437728112;11799.351035692776;12212.511499540275;14051.508197213048;14098.929505352819;12097.153199276318;12234.571789987307;12279;12314.50741970347;12572.685682857636;11665.300081995107;11719;12072.370230018834;12160.513579457076;12249;9691.854622180532;11990.340531270864;12145.332006739714;12555.623331300076;12648.810267846175;8236.958815205886;8249;8277;8312.25189732927;8359.038710548364;8665.43674661145;12188.817167742314;12400.503979841065;12510.937445312715;12862 14:04:23 INFO - PROCESS | 21334 | |3;mootools.html;1358.246173373777;1541.3757428241559;1570.3561539768693;1751.3957684598818;1825.9726104108433;7649.732259370923;8366.163383661631;8481.491110533372;8536.530490823017;8561.700340488083;8287.83424331513;8460.78848028798;8480.279176270009;8486.066532681416;8488.320934325255;2134.125008746414;2346.9647955280598;2366.337425520853;2405.170216275391;2412.8069754419603;2400;2423.1761201191593;2425.8180636452335;2425.9272221833285;2427.4416884116663;2321.199186280739;2358.5636657218383;2366.2073205476186;2367.5028244068767;2368.111958015744;2106.2522804404443;2356.5522550715395;2430.3195105370523;2430.9392265193333;2432.1852179519883;2349.8237632177656;2355.6819829322994;2355.9528809423887;2367.5856725073045;2397.928062158138;8502.022267439263;8561.700340488116;8563.743087707378;8601.31189504838;8614.18165274298;4950.801967921278;5131.61512886535;5136.04983078128;5140.845774626767;5161.225816127611;3388.6611338866164;3433.1073920780777;3471.7916924984584;3498.8950331490096;3529.435290353557;1162.0935670177275;1163.6043745126613;1178.181164090957;1183.0949323767325;1183.911206659504;12139.210951288227;12171.391430428443;12184.81722774159;12192.51229950801;12196.329201893892;4651.5813576778255;4673.509281525391;4783.6651434399255;4784.904301914012;4788.1381351356395;10300.948495257475;10340.431276279876;10341.896581034243;10348.793024139626;10352.844707329396;4632.467266264355;5045.924311135336;5121.4878512149235;5122.8975420492125;5126.6923984561045;4443.2224360736745;4631.62946964242;4647.419072615923;4699.224627936353;4720.504347043579;4069.7761623111014;4086.836526538965;4120.443740095049;4154.210699966997;4157.355609880473;1302.433441452971;1303.3157592264138;1316.0984725462897;1317.5915466205506;1321.62333734887;949.8717673114041;953.3564843730454;1037.4138611684375;1074.6453670288786;1075.774087441646;6031.638101713911;6171.907421388682;6178.227721534809;6184.907226391608;6288.685565721696;434.86084452974745;443.82247101159794;444.73316010394154;448.9685721999494;458;4385.802638881258;4427.712198707074;4438.023634800404;4443.355713421536;4476.485204201494;10523.894761052445;10849.077828384517;10926.289791163548;10933.507992140372;10952.069074128789;10114.848277275847;10715.892841071489;10852.67441976742;10868.402237876835;10868.402237876835;7661.080670319486;7839.294463498312;7871.134175240719;7902.960485197652;7929.167437419103;6103.572749907464;6246.250449946036;6318.210223722035;6349.301576826638;6408.61548307103;9768.80462390734;9882.357646752938;9888.950555247178;9926.751831204278;10058;9897.158741506764;9992.950035249778;10438.739031524272;10464.686059418229;10534.209934254808;7026.367626913602;7603.467757256939;7669.769906902802;7762.301392874669;7847.686092556234;8269.751907442786;8275.875861862198;8324.29243514284;8350.290225330915;8358.87461688063;7613.6573854177805;7872.763817085496;7946.284834364935;7996.080450748006;8002.639881205243;7729.111152217342;7810.88283675734;7813.1796161402235;7930.444868859356;8020.558869262247;6834.2482326943;6890.724371025103;6909.689063992233;6924.480663950123;6931.514793964374;5366.275552800478;5430.456954304538;5453;5490.80782172622;5491.533219676372;5440.347158341025;5528.253685752533;5545.861353466195;5564.415736347787;5614.24207731951 14:04:23 INFO - PROCESS | 21334 | |4;prototype.html;326.77942388887493;334.30631439762493;338.1090825674347;338.7154789976419;341.99283111237406;5408.67547947123;5498.175273708941;5509.741006187464;5533.750981205845;5550.222968784364;5426.8914621707545;5445.537129344;5447.809326673567;5457.69982650955;5482.671039737618;4041.595840415964;4134.8139333729905;4226.45056142701;4251.744895306276;4256.616904478597;4222.134462435193;4248.150369926012;4248.936265956013;4254.808533615979;4255;4017.3773065174946;4174.478190226222;4203.747775133486;4232.449781528397;4240.194363071022;4081.8163182656854;4233.1956928183545;4245.893852653678;4246.617804397588;4253.298205796024;3724.478572999782;3724.491580909736;3745.3632882410056;3746.8572085513906;3759.887203383903;5285.709285989269;5286.524212820865;5317.468253174651;5319.249928800186;5332.626716129873;4535.501094879561;4761.381020467352;4763.95236047642;4766.52334766524;4802.135615589193;5630.930123276565;5642.689652069134;5647.661140331593;5658.830235092953;5683.460071293221;3987.641112299907;4017.27689015977;4017.337139372;4022.5374081980654;4032.4354590357375;5654.6041777075625;5895.322037965646;5901.734421951022;5908.586398952075;5943.55423343251;4072.5927407259037;4079.8980025499004;4112.444819949328;4114.753114813061;4121.1345617420075;4126.834926602963;4158.542560318362;4167.458230430086;4167.5832416758685;4185.497740271126;4566.908661826745;4738.360321356642;4802.519748025239;4806.951930480651;4846.466888642247;5677.643777832153;5688.40271771458;5714.514266287412;5775.653460792366;5782.942170578324;1560.3368568358403;1577.4478932373806;1578.1556867076058;1585.2549301828353;1585.4054729476447;1033.0805583031108;1076.9030787229187;1078.5577913055608;1081.3403823667556;1084.6258040975852;5962.731677074542;5993.610415323077;5994.820155395345;5999.310079340845;6003.489703375175;6074.908876366858;6245.75016999324;6248.5313601480075;6248.937510624926;6250.781222657185;5968.283805943314;5972.790952316735;5974.910376344358;5984.102384642251;5988.850278742979;3318.7930026532567;3321.368939901411;3348.7944340037566;3349.8995030149135;3352.2792599591203;5860.794872179454;6146.4775494082605;6152.261728592597;6169.167162433104;6527.54307198501;6024.457798798129;6081.959020489755;6105.96947015271;6119.510439164945;6124.203853499017;5825.417458254141;6097.512199024068;6101.816945491642;6163.7842675506145;6166.445019948226;5885.764569417347;5896.64620122794;5912.871366308212;5961.076033214858;5969.641821490724;5840.591158618856;5845.795397161079;5859.648421094748;5862.413758624274;5906.173135761082;5857.619254748428;6103.176071230505;6120.204373431426;6151.108089327112;6160.229971253593;4116.958830411658;4147.170565886895;4159.209750147463;4161.91676166481;4197.160567886373;5618.803341883015;5701.942980570308;5914.615549989409;5947.91078133837;5995.700214989146;5752.482276594959;5782.913256301074;5792.623479473821;5798.855028624318;5807.041838096667;5549.778008879761;5735.8566035849435;5797.652140871562;5798.478136967693;5799.739011744397;5596.524295434933;5636.915446268227;5646.435356464321;5672.780352224291;5680.176374425602;5731.541476681939;5810.970945145247;5818.418158184148;5819.563532734977;5834.18321434991;5372.227165035607;5661.2923384576925;5679.148127780866;5714.542836573148;5729.971350143389 14:04:23 INFO - PROCESS | 21334 | |5;yui.html;903.2999425445281;921.5806807902409;923.4090182283338;944.433339996002;950.3632566180659;15110.47113351033;15123.092614443141;15307.464238751645;15320.463783767571;15336.923315383421;14065.367058482367;14117.364718587662;14122.576322710309;14133.293335333243;14135.929320353409;726.1358982810452;860.5439117267858;893.3389291923994;896.1755185229572;899.5951821680237;860.5912191708951;871.2376670413388;873.9169778870997;876.1939016105167;876.8728534362514;936.7470782888616;937.779621788879;937.7843096087904;938.0197693410403;938.5635679409073;760.046142091677;891.3582220801045;919.8068405634858;921.212363429265;921.3642586615214;673.3939454490949;674.0596867369991;675.7668604331498;675.8411773233287;676.0974099577021;14411.351489183013;14487.71024579513;14529.055611385333;14537.200453975027;14582.927085364612;14495.202763847985;15131.243437828174;15177.392904283815;15208.771868421982;15235.847641523555;12215.389230538438;12409.379531023413;12482.937585312106;12562;12681.809772853414;4026.4765580474646;4057.7768222747736;4083.734557253769;4139.77231252281;4157.043879907638;51710.48289517094;53693.99999999961;58875.41124588742;59728.10407843886;59828.70085649544;11601.941990290163;11672.299662020307;11702.76594468106;11766.294022358687;11829.704257393634;19859.404217873485;20031.198752050048;20097.59804803896;20098.39704808858;20105.497362566053;8683.869741953877;8952.552372381355;8954.641814327484;9117.544122793834;9299.442033478013;5176.7152806596;5185.766640501187;5191.32512773337;5232.3459567554055;5323.30796996388;3622.8188590570367;3632.1282892105705;3668.1013151777984;3668.706503479715;3688.6126956669164;655.7967030220647;665.2449469851753;670.5909395268882;682.4710849091994;696.1819861662526;743.5427212264526;767.2021098057958;798.9850998731421;811.1726039439739;842.2546046748672;9554.808903822024;9674.661386851567;9904.55429505674;9940.652077177409;10082.596696132072;794.6026986506747;797.4513218299817;804.9919500804917;825.4551995682821;825.69449303758;4801.1117943180625;4811.254255590389;4858.489858564871;4930.457649658535;4936.851894443101;75969.62015189888;77157.22842771612;77709.61145194237;78004.60997695089;78877.60561197158;46466.303005454945;54129.72935135378;56090;62351.376486235466;67732;56453;57963.710181449664;59123;59865;60868.08697869447;8707.695230666895;8960.68637597681;8983;9056.909430905607;9146;37249.25501490009;38199.6180038196;38667;38669.806650966566;39009.41485877771;48935.26597100975;52438.47561524488;52979.47020529745;53152.73423632857;53252;10183.898161018591;10847.186461015297;11963.880361196625;11997.160198786001;12101.334426606621;13250.403731831899;13812.723745525234;14025.29873506341;14124.081934674214;14431.35058922372;13197.340132993504;13201.20792752438;13415.798763018367;14097.577072687836;14099.929500352433;12255.509779608716;12383.380830958236;12754.298513581842;13550.051496395157;14172.858271417153;12137.150399472306;13030.348482576022;13316.86683133195;13425.597232083053;13725.970552208424;10454.372737635462;10637.414942178255;10663.146948244277;10981.560737570728;11290.49192786343;10577.349926428535;10602.363858168535;10664.360138391721;10696.358218506915;10848.186386020921 14:04:23 INFO - PROCESS | 21334 | __end_tp_report 14:04:23 INFO - PROCESS | 21334 | __start_cc_report 14:04:23 INFO - PROCESS | 21334 | _x_x_mozilla_cycle_collect,860 14:04:23 INFO - PROCESS | 21334 | __end_cc_report 14:04:23 INFO - PROCESS | 21334 | __startTimestamp1461618263109__endTimestamp 14:04:23 INFO - PROCESS | 21334 | 14:04:23 INFO - PROCESS | 21334 | ------- Summary: start ------- 14:04:23 INFO - PROCESS | 21334 | Number of tests: 6 14:04:23 INFO - PROCESS | 21334 | 14:04:23 INFO - PROCESS | 21334 | [#0] dojo.html Cycles:165 Average:5621.11 Median:5822.65 stddev:622.56 (10.7%) stddev-sans-first:598.91 14:04:23 INFO - PROCESS | 21334 | Values: 3370.4 3404.4 3430.1 3450.1 3481.3 5626.0 5648.2 5655.7 5671.9 5696.0 5651.7 5656.6 5674.6 5683.6 5723.3 4950.8 5196.5 5220.2 5285.9 5308.5 5095.1 5115.6 5120.1 5125.1 5125.1 5128.8 5132.7 5177.0 5192.7 5200.9 5209.5 5310.7 5317.1 5320.4 5356.3 5048.7 5058.9 5135.9 5213.8 5215.0 5538.3 5557.5 5592.5 5599.0 5603.6 6012.8 6016.5 6028.2 6029.1 6032.9 6041.5 6073.9 6088.2 6092.3 6113.1 5574.2 5621.4 5622.2 5623.3 5654.4 6067.8 6107.8 6113.6 6115.4 6125.8 5925.5 5996.6 6012.1 6023.7 6037.0 5970.7 5991.6 5993.0 6004.8 6004.8 5822.7 5943.7 5953.6 5961.7 5976.2 6037.2 6038.7 6044.6 6062.9 6082.0 4575.8 4578.8 4579.7 4586.9 4600.5 4006.8 4049.0 4107.4 4114.6 4133.3 5724.2 5738.5 5741.0 5743.4 5764.7 5996.5 6056.7 6062.4 6078.1 6078.2 5649.0 5686.1 5736.4 5790.1 5792.3 5164.3 5175.5 5193.2 5196.6 5199.0 6272.8 6297.4 6300.4 6303.5 6306.4 5893.0 6032.4 6100.0 6126.4 6136.6 6310.8 6367.3 6367.6 6371.5 6372.5 5873.1 6005.4 6019.4 6021.2 6028.8 6029.9 6079.6 6094.4 6099.0 6139.7 5864.6 5889.3 5902.1 5905.3 5910.9 5822.7 5839.5 5844.8 5897.3 5899.5 5767.1 5773.4 5774.4 5775.5 5806.0 5900.8 5915.6 5917.8 5928.6 5930.1 5657.5 5821.7 5826.1 5856.6 5893.8 14:04:23 INFO - PROCESS | 21334 | 14:04:23 INFO - PROCESS | 21334 | [#1] ext.html Cycles:180 Average:55945.56 Median:35757.82 stddev:107745.78 (301.3%) stddev-sans-first:107967.94 14:04:23 INFO - PROCESS | 21334 | Values: 612.3 662.6 666.2 669.8 672.6 32777.2 40780.4 41544.8 41614.8 41698.8 42502.1 43340.0 43468.6 43503.0 43506.3 8308.9 8487.5 8871.6 9135.7 10441.4 10521.5 10719.7 10719.8 10720.5 10727.7 10588.7 10824.1 10825.9 10828.0 10832.2 8051.3 8251.8 10539.7 10632.3 10777.4 10590.9 10734.4 10742.7 10746.9 10747.4 40503.6 41104.8 41154.0 41179.4 41305.4 3675.3 3737.6 3748.2 3884.5 4314.4 34633.7 34874.0 35251.0 35540.3 35630.8 4636.1 4673.3 4687.4 4704.8 4712.2 246238.0 248183.0 248215.0 248630.0 248790.0 67629.0 68316.7 68888.0 68994.3 69022.3 64031.7 65421.3 65436.7 65624.3 72859.3 16651.3 16724.4 16758.5 16767.4 16783.4 11313.6 11786.8 12146.8 12398.6 12527.7 20871.6 21262.8 21330.6 21341.9 21406.3 7688.7 7858.7 7915.0 7981.6 8048.6 1057.4 1074.4 1105.3 1120.4 1148.6 33901.8 34549.0 34680.8 34780.3 34811.0 1192.3 1251.9 1291.1 1299.8 1323.6 18317.8 18479.9 18550.5 18551.6 18648.8 571301.0 574245.0 578631.0 579693.0 581090.0 63564.0 64149.0 64157.4 64593.4 64620.0 1463.0 1469.9 1498.7 1566.9 1594.5 30449.0 31209.0 31976.4 32464.8 33741.7 49724.0 49910.3 50247.2 50345.0 50399.2 311140.0 311640.0 312860.0 312879.0 313058.0 24013.6 28259.2 29000.9 29011.4 29099.7 44286.8 45330.5 45699.3 45835.8 45882.3 37043.8 37866.4 38320.2 38879.0 39442.2 40614.6 41036.4 41386.0 42659.4 43142.0 43144.4 44015.8 44164.0 44297.6 44304.8 34332.3 35884.8 35893.6 36154.0 38736.2 26920.9 27343.6 27556.6 27771.3 27873.0 14:04:23 INFO - PROCESS | 21334 | 14:04:23 INFO - PROCESS | 21334 | [#2] jquery.html Cycles:180 Average:30773.51 Median:13413.39 stddev:91332.14 (680.9%) stddev-sans-first:91559.86 14:04:23 INFO - PROCESS | 21334 | Values: 391.3 402.3 403.7 407.8 416.8 19003.0 19456.6 19840.5 19873.0 19961.8 16251.7 16775.2 16798.4 18141.8 18157.4 5711.5 5763.9 5830.1 5831.0 5832.2 5664.8 5722.3 5754.8 5795.8 5845.9 5612.8 5764.0 5813.8 5819.0 5820.0 5740.9 5772.6 5778.8 5789.7 5797.7 4910.6 5144.9 5175.3 5175.7 5187.7 24171.3 24352.5 24864.4 25100.1 25113.5 2313.6 2415.0 2474.3 2576.8 2948.5 9900.9 9977.6 10001.1 10006.4 12162.5 1917.6 2020.2 2077.3 2118.0 2154.1 68454.7 72690.9 72749.3 90960.5 92403.5 8976.1 11059.3 11143.1 11151.7 11248.3 13210.1 14641.6 15378.0 15518.3 15711.4 7842.5 7944.9 8139.0 8215.1 8244.5 7384.2 7384.4 7504.6 7549.4 7563.8 4744.3 4801.8 4847.0 4852.5 4871.1 1933.6 1971.1 1975.3 1975.5 1975.9 939.7 1042.5 1091.4 1119.3 1135.6 20036.6 20038.8 20252.4 20388.3 20606.0 1035.1 1049.9 1082.8 1111.7 1125.2 10685.7 10897.8 11221.3 11254.5 11317.3 543363.0 545021.0 545985.0 551455.0 586326.0 99805.0 104779.0 105578.0 106472.5 106966.0 1050.4 1074.4 1074.9 1078.3 1079.7 17358.8 17767.9 17771.3 17942.6 18088.0 28054.6 35764.5 36432.0 40945.0 42534.6 44968.6 46558.3 50180.7 52140.7 56186.4 8510.2 8534.7 8649.3 8729.2 8810.2 9124.5 11799.4 12212.5 14051.5 14098.9 12097.2 12234.6 12279.0 12314.5 12572.7 11665.3 11719.0 12072.4 12160.5 12249.0 9691.9 11990.3 12145.3 12555.6 12648.8 8237.0 8249.0 8277.0 8312.3 8359.0 8665.4 12188.8 12400.5 12510.9 12862.0 14:04:23 INFO - PROCESS | 21334 | 14:04:23 INFO - PROCESS | 21334 | [#3] mootools.html Cycles:180 Average:5784.46 Median:4649.50 stddev:3241.86 (69.7%) stddev-sans-first:3233.89 14:04:23 INFO - PROCESS | 21334 | Values: 1358.2 1541.4 1570.4 1751.4 1826.0 7649.7 8366.2 8481.5 8536.5 8561.7 8287.8 8460.8 8480.3 8486.1 8488.3 2134.1 2347.0 2366.3 2405.2 2412.8 2400.0 2423.2 2425.8 2425.9 2427.4 2321.2 2358.6 2366.2 2367.5 2368.1 2106.3 2356.6 2430.3 2430.9 2432.2 2349.8 2355.7 2356.0 2367.6 2397.9 8502.0 8561.7 8563.7 8601.3 8614.2 4950.8 5131.6 5136.0 5140.8 5161.2 3388.7 3433.1 3471.8 3498.9 3529.4 1162.1 1163.6 1178.2 1183.1 1183.9 12139.2 12171.4 12184.8 12192.5 12196.3 4651.6 4673.5 4783.7 4784.9 4788.1 10300.9 10340.4 10341.9 10348.8 10352.8 4632.5 5045.9 5121.5 5122.9 5126.7 4443.2 4631.6 4647.4 4699.2 4720.5 4069.8 4086.8 4120.4 4154.2 4157.4 1302.4 1303.3 1316.1 1317.6 1321.6 949.9 953.4 1037.4 1074.6 1075.8 6031.6 6171.9 6178.2 6184.9 6288.7 434.9 443.8 444.7 449.0 458.0 4385.8 4427.7 4438.0 4443.4 4476.5 10523.9 10849.1 10926.3 10933.5 10952.1 10114.8 10715.9 10852.7 10868.4 10868.4 7661.1 7839.3 7871.1 7903.0 7929.2 6103.6 6246.3 6318.2 6349.3 6408.6 9768.8 9882.4 9889.0 9926.8 10058.0 9897.2 9993.0 10438.7 10464.7 10534.2 7026.4 7603.5 7669.8 7762.3 7847.7 8269.8 8275.9 8324.3 8350.3 8358.9 7613.7 7872.8 7946.3 7996.1 8002.6 7729.1 7810.9 7813.2 7930.4 8020.6 6834.2 6890.7 6909.7 6924.5 6931.5 5366.3 5430.5 5453.0 5490.8 5491.5 5440.3 5528.3 5545.9 5564.4 5614.2 14:04:23 INFO - PROCESS | 21334 | 14:04:23 INFO - PROCESS | 21334 | [#4] prototype.html Cycles:180 Average:4864.22 Median:5550.00 stddev:1438.72 (25.9%) stddev-sans-first:1401.86 14:04:23 INFO - PROCESS | 21334 | Values: 326.8 334.3 338.1 338.7 342.0 5408.7 5498.2 5509.7 5533.8 5550.2 5426.9 5445.5 5447.8 5457.7 5482.7 4041.6 4134.8 4226.5 4251.7 4256.6 4222.1 4248.2 4248.9 4254.8 4255.0 4017.4 4174.5 4203.7 4232.4 4240.2 4081.8 4233.2 4245.9 4246.6 4253.3 3724.5 3724.5 3745.4 3746.9 3759.9 5285.7 5286.5 5317.5 5319.2 5332.6 4535.5 4761.4 4764.0 4766.5 4802.1 5630.9 5642.7 5647.7 5658.8 5683.5 3987.6 4017.3 4017.3 4022.5 4032.4 5654.6 5895.3 5901.7 5908.6 5943.6 4072.6 4079.9 4112.4 4114.8 4121.1 4126.8 4158.5 4167.5 4167.6 4185.5 4566.9 4738.4 4802.5 4807.0 4846.5 5677.6 5688.4 5714.5 5775.7 5782.9 1560.3 1577.4 1578.2 1585.3 1585.4 1033.1 1076.9 1078.6 1081.3 1084.6 5962.7 5993.6 5994.8 5999.3 6003.5 6074.9 6245.8 6248.5 6248.9 6250.8 5968.3 5972.8 5974.9 5984.1 5988.9 3318.8 3321.4 3348.8 3349.9 3352.3 5860.8 6146.5 6152.3 6169.2 6527.5 6024.5 6082.0 6106.0 6119.5 6124.2 5825.4 6097.5 6101.8 6163.8 6166.4 5885.8 5896.6 5912.9 5961.1 5969.6 5840.6 5845.8 5859.6 5862.4 5906.2 5857.6 6103.2 6120.2 6151.1 6160.2 4117.0 4147.2 4159.2 4161.9 4197.2 5618.8 5701.9 5914.6 5947.9 5995.7 5752.5 5782.9 5792.6 5798.9 5807.0 5549.8 5735.9 5797.7 5798.5 5799.7 5596.5 5636.9 5646.4 5672.8 5680.2 5731.5 5811.0 5818.4 5819.6 5834.2 5372.2 5661.3 5679.1 5714.5 5730.0 14:04:23 INFO - PROCESS | 21334 | 14:04:23 INFO - PROCESS | 21334 | [#5] yui.html Cycles:180 Average:16217.24 Median:26932.86 stddev:19615.75 (72.8%) stddev-sans-first:19637.07 14:04:23 INFO - PROCESS | 21334 | Values: 903.3 921.6 923.4 944.4 950.4 15110.5 15123.1 15307.5 15320.5 15336.9 14065.4 14117.4 14122.6 14133.3 14135.9 726.1 860.5 893.3 896.2 899.6 860.6 871.2 873.9 876.2 876.9 936.7 937.8 937.8 938.0 938.6 760.0 891.4 919.8 921.2 921.4 673.4 674.1 675.8 675.8 676.1 14411.4 14487.7 14529.1 14537.2 14582.9 14495.2 15131.2 15177.4 15208.8 15235.8 12215.4 12409.4 12482.9 12562.0 12681.8 4026.5 4057.8 4083.7 4139.8 4157.0 51710.5 53694.0 58875.4 59728.1 59828.7 11601.9 11672.3 11702.8 11766.3 11829.7 19859.4 20031.2 20097.6 20098.4 20105.5 8683.9 8952.6 8954.6 9117.5 9299.4 5176.7 5185.8 5191.3 5232.3 5323.3 3622.8 3632.1 3668.1 3668.7 3688.6 655.8 665.2 670.6 682.5 696.2 743.5 767.2 799.0 811.2 842.3 9554.8 9674.7 9904.6 9940.7 10082.6 794.6 797.5 805.0 825.5 825.7 4801.1 4811.3 4858.5 4930.5 4936.9 75969.6 77157.2 77709.6 78004.6 78877.6 46466.3 54129.7 56090.0 62351.4 67732.0 56453.0 57963.7 59123.0 59865.0 60868.1 8707.7 8960.7 8983.0 9056.9 9146.0 37249.3 38199.6 38667.0 38669.8 39009.4 48935.3 52438.5 52979.5 53152.7 53252.0 10183.9 10847.2 11963.9 11997.2 12101.3 13250.4 13812.7 14025.3 14124.1 14431.4 13197.3 13201.2 13415.8 14097.6 14099.9 12255.5 12383.4 12754.3 13550.1 14172.9 12137.2 13030.3 13316.9 13425.6 13726.0 10454.4 10637.4 10663.1 10981.6 11290.5 10577.3 10602.4 10664.4 10696.4 10848.2 14:04:23 INFO - PROCESS | 21334 | -------- Summary: end -------- 14:04:23 INFO - PROCESS | 21334 | 14:04:23 INFO - TEST-INFO | 21334: exit 0 14:04:23 INFO - TEST-OK | dromaeo_css | took 1112522ms 14:04:23 INFO - TEST-START | kraken 14:04:23 INFO - operating with platform_type : linux_ 14:04:23 INFO - Initialising browser for kraken test... 14:04:23 INFO - TEST-INFO | started process 21527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVMxGHM/profile http://localhost:47041/getInfo.html) 14:04:27 INFO - PROCESS | 21527 | __metrics Screen width/height:1600/1200 14:04:27 INFO - PROCESS | 21527 | colorDepth:24 14:04:27 INFO - PROCESS | 21527 | Browser inner width/height: 1024/697 14:04:27 INFO - PROCESS | 21527 | __metrics 14:04:29 ERROR - PROCESS | 21527 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:04:29 INFO - TEST-INFO | 21527: exit 0 14:04:29 INFO - Browser initialized. 14:04:29 INFO - Running cycle 1/1 for kraken test... 14:04:29 INFO - TEST-INFO | started process 21617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVMxGHM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:04:41 INFO - PROCESS | 21617 | RSS: Main: 142741504 14:04:41 INFO - PROCESS | 21617 | 14:04:44 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:47041/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47041/tests/kraken/driver.html?testName=audio-beat-detection) 14:04:44 INFO - PROCESS | 21617 | RSS: Main: 190251008 14:04:44 INFO - PROCESS | 21617 | 14:04:47 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:47041/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47041/tests/kraken/driver.html?testName=audio-dft) 14:04:48 INFO - PROCESS | 21617 | RSS: Main: 184627200 14:04:48 INFO - PROCESS | 21617 | 14:04:51 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:47041/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47041/tests/kraken/driver.html?testName=audio-fft) 14:04:51 INFO - PROCESS | 21617 | RSS: Main: 273559552 14:04:51 INFO - PROCESS | 21617 | 14:04:53 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:47041/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47041/tests/kraken/driver.html?testName=audio-oscillator) 14:04:54 INFO - PROCESS | 21617 | RSS: Main: 182177792 14:04:54 INFO - PROCESS | 21617 | 14:04:56 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:47041/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47041/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:04:57 INFO - PROCESS | 21617 | RSS: Main: 180928512 14:04:57 INFO - PROCESS | 21617 | 14:05:00 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:47041/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47041/tests/kraken/driver.html?testName=imaging-darkroom) 14:05:00 INFO - PROCESS | 21617 | RSS: Main: 216141824 14:05:00 INFO - PROCESS | 21617 | 14:05:04 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:47041/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47041/tests/kraken/driver.html?testName=imaging-desaturate) 14:05:04 INFO - PROCESS | 21617 | RSS: Main: 215855104 14:05:04 INFO - PROCESS | 21617 | 14:05:07 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:47041/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47041/tests/kraken/driver.html?testName=json-parse-financial) 14:05:07 INFO - PROCESS | 21617 | RSS: Main: 215494656 14:05:07 INFO - PROCESS | 21617 | 14:05:09 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:47041/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47041/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:05:10 INFO - PROCESS | 21617 | RSS: Main: 197103616 14:05:10 INFO - PROCESS | 21617 | 14:05:11 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:47041/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47041/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:05:12 INFO - PROCESS | 21617 | RSS: Main: 197967872 14:05:12 INFO - PROCESS | 21617 | 14:05:14 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:47041/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47041/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:05:15 INFO - PROCESS | 21617 | RSS: Main: 208027648 14:05:15 INFO - PROCESS | 21617 | 14:05:17 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:47041/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47041/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:05:18 INFO - PROCESS | 21617 | RSS: Main: 215285760 14:05:18 INFO - PROCESS | 21617 | 14:05:20 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:47041/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47041/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:05:21 INFO - PROCESS | 21617 | RSS: Main: 210538496 14:05:21 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | Cycle 1(1): loaded http://localhost:47041/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47041/tests/kraken/driver.html?testName=ai-astar) 14:05:23 INFO - PROCESS | 21617 | RSS: Main: 274608128 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | __start_tp_report 14:05:23 INFO - PROCESS | 21617 | _x_x_mozilla_page_load 14:05:23 INFO - PROCESS | 21617 | _x_x_mozilla_page_load_details 14:05:23 INFO - PROCESS | 21617 | |i|pagename|runs| 14:05:23 INFO - PROCESS | 21617 | |0;ai-astar;110;112;107;111;110;111;99;110;110;109 14:05:23 INFO - PROCESS | 21617 | |1;audio-beat-detection;151;129;154;177;134;154;161;136;183;127 14:05:23 INFO - PROCESS | 21617 | |2;audio-dft;163;160;163;161;162;162;162;165;160;160 14:05:23 INFO - PROCESS | 21617 | |3;audio-fft;76;76;76;171;77;73;74;75;163;74 14:05:23 INFO - PROCESS | 21617 | |4;audio-oscillator;92;93;148;93;94;93;158;91;93;147 14:05:23 INFO - PROCESS | 21617 | |5;imaging-gaussian-blur;117;117;117;117;117;119;117;117;116;117 14:05:23 INFO - PROCESS | 21617 | |6;imaging-darkroom;146;146;146;145;147;145;145;146;146;146 14:05:23 INFO - PROCESS | 21617 | |7;imaging-desaturate;95;95;95;94;95;94;95;94;95;94 14:05:23 INFO - PROCESS | 21617 | |8;json-parse-financial;61;63;62;63;63;64;62;84;62;60 14:05:23 INFO - PROCESS | 21617 | |9;json-stringify-tinderbox;57;58;58;58;58;65;58;58;58;58 14:05:23 INFO - PROCESS | 21617 | |10;stanford-crypto-aes;72;72;72;79;80;73;83;75;74;74 14:05:23 INFO - PROCESS | 21617 | |11;stanford-crypto-ccm;126;118;117;118;119;116;127;120;166;121 14:05:23 INFO - PROCESS | 21617 | |12;stanford-crypto-pbkdf2;164;158;156;156;158;162;157;158;157;160 14:05:23 INFO - PROCESS | 21617 | |13;stanford-crypto-sha256-iterative;66;66;68;65;66;65;66;66;66;65 14:05:23 INFO - PROCESS | 21617 | __end_tp_report 14:05:23 INFO - PROCESS | 21617 | __start_cc_report 14:05:23 INFO - PROCESS | 21617 | _x_x_mozilla_cycle_collect,1581 14:05:23 INFO - PROCESS | 21617 | __end_cc_report 14:05:23 INFO - PROCESS | 21617 | __startTimestamp1461618323417__endTimestamp 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | ------- Summary: start ------- 14:05:23 INFO - PROCESS | 21617 | Number of tests: 14 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.50 stddev:3.73 (3.4%) stddev-sans-first:3.93 14:05:23 INFO - PROCESS | 21617 | Values: 110.0 112.0 107.0 111.0 110.0 111.0 99.0 110.0 110.0 109.0 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:154.00 stddev:19.41 (12.6%) stddev-sans-first:20.59 14:05:23 INFO - PROCESS | 21617 | Values: 151.0 129.0 154.0 177.0 134.0 154.0 161.0 136.0 183.0 127.0 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.62 (1.0%) stddev-sans-first:1.66 14:05:23 INFO - PROCESS | 21617 | Values: 163.0 160.0 163.0 161.0 162.0 162.0 162.0 165.0 160.0 160.0 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.50 stddev:38.80 (51.4%) stddev-sans-first:40.64 14:05:23 INFO - PROCESS | 21617 | Values: 76.0 76.0 76.0 171.0 77.0 73.0 74.0 75.0 163.0 74.0 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:93.00 stddev:28.31 (30.4%) stddev-sans-first:29.25 14:05:23 INFO - PROCESS | 21617 | Values: 92.0 93.0 148.0 93.0 94.0 93.0 158.0 91.0 93.0 147.0 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 14:05:23 INFO - PROCESS | 21617 | Values: 117.0 117.0 117.0 117.0 117.0 119.0 117.0 117.0 116.0 117.0 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 14:05:23 INFO - PROCESS | 21617 | Values: 146.0 146.0 146.0 145.0 147.0 145.0 145.0 146.0 146.0 146.0 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:05:23 INFO - PROCESS | 21617 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:63.00 stddev:6.98 (11.1%) stddev-sans-first:7.29 14:05:23 INFO - PROCESS | 21617 | Values: 61.0 63.0 62.0 63.0 63.0 64.0 62.0 84.0 62.0 60.0 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:58.00 stddev:2.27 (3.9%) stddev-sans-first:2.33 14:05:23 INFO - PROCESS | 21617 | Values: 57.0 58.0 58.0 58.0 58.0 65.0 58.0 58.0 58.0 58.0 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:74.50 stddev:3.89 (5.2%) stddev-sans-first:3.93 14:05:23 INFO - PROCESS | 21617 | Values: 72.0 72.0 72.0 79.0 80.0 73.0 83.0 75.0 74.0 74.0 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:120.50 stddev:14.93 (12.4%) stddev-sans-first:15.83 14:05:23 INFO - PROCESS | 21617 | Values: 126.0 118.0 117.0 118.0 119.0 116.0 127.0 120.0 166.0 121.0 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:158.00 stddev:2.63 (1.7%) stddev-sans-first:1.94 14:05:23 INFO - PROCESS | 21617 | Values: 164.0 158.0 156.0 156.0 158.0 162.0 157.0 158.0 157.0 160.0 14:05:23 INFO - PROCESS | 21617 | 14:05:23 INFO - PROCESS | 21617 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 14:05:23 INFO - PROCESS | 21617 | Values: 66.0 66.0 68.0 65.0 66.0 65.0 66.0 66.0 66.0 65.0 14:05:23 INFO - PROCESS | 21617 | -------- Summary: end -------- 14:05:23 INFO - PROCESS | 21617 | 14:05:24 INFO - TEST-INFO | 21617: exit 0 14:05:24 INFO - TEST-OK | kraken | took 60493ms 14:05:24 INFO - SUITE-END | took 1173s 14:05:24 INFO - Completed test suite (00:19:33) 14:05:24 INFO - javascript benchmark 14:05:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.4438767603347, 3404.37019151457, 3430.1253180438985, 3450.0684815099926, 3481.338545676322, 5626.0, 5648.181013753004, 5655.745491452884, 5671.886562268752, 5696.003199440097, 5651.660900345983, 5656.632318899268, 5674.631148975313, 5683.630564013336, 5723.313202415706, 4950.777215025315, 5196.454372290912, 5220.164773636219, 5285.920711189336, 5308.5487733542695, 5095.133827249358, 5115.616328775357, 5120.052790233819, 5125.103106956268, 5125.103106956286, 5128.820491282806, 5132.666376685522, 5177.042247184264, 5192.688438693691, 5200.895982080356, 5209.505097015777, 5310.654807437504, 5317.149256119041, 5320.441353657888, 5356.250124982505, 5048.697078175322, 5058.924116138261, 5135.871603209912, 5213.817516386908, 5215.035218484592, 5538.335399752015, 5557.472040156179, 5592.496675299242, 5598.972005139989, 5603.551715862721, 6012.849678758066, 6016.548758843104, 6028.246469191351, 6029.125776762345, 6032.879342413171, 6041.486473649745, 6073.908891366589, 6088.208532890741, 6092.299385570672, 6113.050656958994, 5574.219609254707, 5621.353544342372, 5622.184783206494, 5623.325200975868, 5654.434556544354, 6067.764007036494, 6107.755689772448, 6113.554518421814, 6115.357887421846, 6125.785597504066, 5925.466707996215, 5996.580239383201, 6012.128241404972, 6023.66869822164, 6037.034074548139, 5970.701464926737, 5991.640501569833, 5993.041113421831, 6004.759809607567, 6004.849878753066, 5822.650640961556, 5943.673097979653, 5953.642781433128, 5961.672108034099, 5976.223090998229, 6037.15479832815, 6038.698065096728, 6044.637321760709, 6062.878742425127, 6081.969590152021, 4575.771211439482, 4578.839740609063, 4579.656525760582, 4586.908261834811, 4600.470945841204, 4006.759594424344, 4048.959510404858, 4107.424960505532, 4114.6091121343425, 4133.256013917464, 5724.227229324071, 5738.512226460798, 5740.971295143581, 5743.368229494752, 5764.7117644117625, 5996.4603185713495, 6056.666883321372, 6062.393760623902, 6078.1186727924205, 6078.240219972504, 5649.0396632572565, 5686.09022556389, 5736.42635736423, 5790.131480277992, 5792.275965504312, 5164.302819119446, 5175.4824517548695, 5193.169092945111, 5196.636235463481, 5199.0, 6272.780452684134, 6297.370262973757, 6300.3699630037545, 6303.495720342362, 6306.369363063657, 5893.0, 6032.426919442646, 6100.0, 6126.448619624255, 6136.631802091889, 6310.7791227306825, 6367.267764207176, 6367.586106903036, 6371.458426033653, 6372.522060845363, 5873.148393482836, 6005.429484199169, 6019.367966363468, 6021.157038014769, 6028.788992385245, 6029.909551356821, 6079.635221886701, 6094.421030002142, 6099.024156134997, 6139.723712432862, 5864.618799778001, 5889.322727886177, 5902.144189092472, 5905.320888097924, 5910.881782364415, 5822.70886455684, 5839.532837372915, 5844.824655260349, 5897.292324921037, 5899.528037757055, 5767.106098554731, 5773.364929857628, 5774.422557744192, 5775.537956963517, 5806.042003069446, 5900.822975310747, 5915.645061296336, 5917.822465326047, 5928.614640048383, 5930.140129681258, 5657.519110875457, 5821.738021789114, 5826.067829147316, 5856.59003869725, 5893.823185304448], "value": 5580.751810497999, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.3142080869427, 662.6057495790005, 666.2105405094962, 669.7957123077465, 672.5628341577974, 32777.18057048575, 40780.38829417557, 41544.79227603865, 41614.79192604033, 41698.791506042464, 42502.14995700092, 43340.0, 43468.565314346844, 43503.0, 43506.347404788874, 8308.916910830905, 8487.490750554956, 8871.556422178897, 9135.68025119121, 10441.42572158531, 10521.526531306072, 10719.678409647684, 10719.785604287948, 10720.463976801168, 10727.731806704816, 10588.682339529827, 10824.134069274478, 10825.945870270676, 10828.0, 10832.241743077988, 8051.315638170762, 8251.793705157419, 10539.683809485728, 10632.255742098056, 10777.407242601654, 10590.947045264724, 10734.355938643628, 10742.677719668345, 10746.946265268702, 10747.355158690425, 40503.59496405028, 41104.794476027426, 41154.0, 41179.382309265384, 41305.38041929343, 3675.3016926783826, 3737.588865224823, 3748.175401411685, 3884.495015647976, 4314.352847072964, 34633.653663463294, 34874.0, 35251.0, 35540.28919421597, 35630.82184589087, 4636.142313671948, 4673.252279635276, 4687.390639216914, 4704.835330763441, 4712.151812673717, 246238.0, 248183.0, 248215.0, 248630.0, 248790.0, 67629.0, 68316.6584167086, 68888.0, 68994.31005689979, 69022.30977690259, 64031.6798416005, 65421.34578654248, 65436.67281663561, 65624.34375656278, 72859.27140728525, 16651.333946642, 16724.41464548759, 16758.497245082668, 16767.413140540022, 16783.412580559867, 11313.604023859125, 11786.823197652042, 12146.75706485883, 12398.62804115878, 12527.686807829878, 20871.58256834855, 21262.78737212608, 21330.573388532142, 21341.893290533448, 21406.250781222894, 7688.692452301957, 7858.685652573948, 7915.0, 7981.64082616272, 8048.557329346825, 1057.360297020307, 1074.435921141407, 1105.2705214558353, 1120.3781901044836, 1148.6324376199536, 33901.83049084788, 34549.0, 34680.826595866856, 34780.30439391198, 34811.0, 1192.3144192089583, 1251.9109818587413, 1291.0510774580675, 1299.7660421124287, 1323.5963031275553, 18317.81682183188, 18479.907600461913, 18550.536236594195, 18551.628967420846, 18648.813511864708, 571301.0, 574245.0, 578631.0, 579693.0, 581090.0, 63564.0, 64149.0, 64157.358426416075, 64593.35406645967, 64620.0, 1462.997846475168, 1469.9044562103643, 1498.7227362937892, 1566.8903176777517, 1594.545554516957, 30449.0, 31209.0, 31976.36047279088, 32464.83767581147, 33741.66258337385, 49724.0, 49910.251346230565, 50247.246291306394, 50345.0, 50399.24401133913, 311140.0, 311640.0, 312860.0, 312879.0, 313058.0, 24013.639795403433, 28259.15222543327, 29000.854995724887, 29011.419771604873, 29099.709002910546, 44286.77856610825, 45330.54669453263, 45699.31451028171, 45835.77082114568, 45882.31176532288, 37043.814780925924, 37866.432003520524, 38320.23359532849, 38879.0, 39442.21115577615, 40614.59385406227, 41036.38445423261, 41386.0, 42659.36010959776, 43142.0, 43144.35283470813, 44015.77992110019, 44164.0, 44297.55702443063, 44304.778476107414, 34332.31335373328, 35884.820575896956, 35893.641063590076, 36154.0, 38736.22527549489, 26920.865395673678, 27343.589846151925, 27556.586651199847, 27771.305717357227, 27873.0], "value": 20782.447930243186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.26637554585153, 402.31807086987567, 403.6891593473025, 407.8478298805874, 416.77285879195836, 19002.99999999998, 19456.610867782634, 19840.503987400305, 19873.0, 19961.800381996174, 16251.674966500663, 16775.24511396987, 16798.412055578057, 18141.81858181418, 18157.364492242774, 5711.457411545907, 5763.884722305552, 5830.096335068071, 5831.0, 5832.1834943108, 5664.801731939383, 5722.284714410699, 5754.798582049629, 5795.768169273224, 5845.85385365365, 5612.803551875685, 5763.9711801440935, 5813.767449302023, 5818.970905145468, 5820.010598198316, 5740.856478588027, 5772.5670574706855, 5778.768849246025, 5789.65262084272, 5797.652140871562, 4910.631702622318, 5144.922826157611, 5175.301334319856, 5175.741212939338, 5187.662801917901, 24171.274861754177, 24352.512949740907, 24864.3783905402, 25100.121495747742, 25113.497730045296, 2313.5719891820067, 2414.9637755433682, 2474.270090323359, 2576.7680908718116, 2948.528235482334, 9900.90099099007, 9977.600895964226, 10001.149902258318, 10006.399616022989, 12162.452689628988, 1917.6068905874263, 2020.1818263603263, 2077.3248694174304, 2117.9743629374407, 2154.1060459909118, 68454.65772671155, 72690.9096363555, 72749.27250727531, 90960.54519727424, 92403.53798230966, 8976.115015846615, 11059.336439813476, 11143.108551316038, 11151.721206969729, 11248.26886252391, 13210.141340812816, 14641.633959151106, 15378.0, 15518.301676424588, 15711.371545138296, 7842.529448233125, 7944.9205507945335, 8138.959305203554, 8215.09633940266, 8244.54654993981, 7384.2246564111065, 7384.372328352043, 7504.587247701429, 7549.433792465587, 7563.810904727426, 4744.288356746516, 4801.831935882297, 4846.975765121152, 4852.4662287148385, 4871.074495845778, 1933.574613585009, 1971.083446197525, 1975.259277770836, 1975.4764987278095, 1975.8715683480527, 939.7180845746249, 1042.5308611124872, 1091.4433638844089, 1119.3339962722168, 1135.5911871726173, 20036.599268014557, 20038.795732469418, 20252.392428227176, 20388.28640997558, 20606.0, 1035.1253191053547, 1049.8582691336724, 1082.7726177502655, 1111.6609434122508, 1125.2123513540555, 10685.679429617125, 10897.83653245202, 11221.326720396803, 11254.49354779037, 11317.320960742381, 543363.0, 545021.0, 545985.0, 551455.0, 586326.0, 99805.0, 104779.0, 105578.0, 106472.46763766286, 106966.0, 1050.4432650695144, 1074.398336931321, 1074.9301295415773, 1078.3475997021847, 1079.6707004363586, 17358.82641173572, 17767.911160444633, 17771.289148434436, 17942.55143621368, 18088.0, 28054.579181312703, 35764.46353304754, 36432.0, 40945.0, 42534.5746542543, 44968.55031449644, 46558.30162547632, 50180.74909625574, 52140.739296303276, 56186.43813561812, 8510.214746062258, 8534.74395768128, 8649.264812491008, 8729.214370706666, 8810.207081362709, 9124.5437728112, 11799.351035692776, 12212.511499540275, 14051.508197213048, 14098.929505352819, 12097.153199276318, 12234.571789987307, 12279.0, 12314.50741970347, 12572.685682857636, 11665.300081995107, 11719.0, 12072.370230018834, 12160.513579457076, 12249.0, 9691.854622180532, 11990.340531270864, 12145.332006739714, 12555.623331300076, 12648.810267846175, 8236.958815205886, 8249.0, 8277.0, 8312.25189732927, 8359.038710548364, 8665.43674661145, 12188.817167742314, 12400.503979841065, 12510.937445312715, 12862.0], "value": 9295.231482536834, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.246173373777, 1541.3757428241559, 1570.3561539768693, 1751.3957684598818, 1825.9726104108433, 7649.732259370923, 8366.163383661631, 8481.491110533372, 8536.530490823017, 8561.700340488083, 8287.83424331513, 8460.78848028798, 8480.279176270009, 8486.066532681416, 8488.320934325255, 2134.125008746414, 2346.9647955280598, 2366.337425520853, 2405.170216275391, 2412.8069754419603, 2400.0, 2423.1761201191593, 2425.8180636452335, 2425.9272221833285, 2427.4416884116663, 2321.199186280739, 2358.5636657218383, 2366.2073205476186, 2367.5028244068767, 2368.111958015744, 2106.2522804404443, 2356.5522550715395, 2430.3195105370523, 2430.9392265193333, 2432.1852179519883, 2349.8237632177656, 2355.6819829322994, 2355.9528809423887, 2367.5856725073045, 2397.928062158138, 8502.022267439263, 8561.700340488116, 8563.743087707378, 8601.31189504838, 8614.18165274298, 4950.801967921278, 5131.61512886535, 5136.04983078128, 5140.845774626767, 5161.225816127611, 3388.6611338866164, 3433.1073920780777, 3471.7916924984584, 3498.8950331490096, 3529.435290353557, 1162.0935670177275, 1163.6043745126613, 1178.181164090957, 1183.0949323767325, 1183.911206659504, 12139.210951288227, 12171.391430428443, 12184.81722774159, 12192.51229950801, 12196.329201893892, 4651.5813576778255, 4673.509281525391, 4783.6651434399255, 4784.904301914012, 4788.1381351356395, 10300.948495257475, 10340.431276279876, 10341.896581034243, 10348.793024139626, 10352.844707329396, 4632.467266264355, 5045.924311135336, 5121.4878512149235, 5122.8975420492125, 5126.6923984561045, 4443.2224360736745, 4631.62946964242, 4647.419072615923, 4699.224627936353, 4720.504347043579, 4069.7761623111014, 4086.836526538965, 4120.443740095049, 4154.210699966997, 4157.355609880473, 1302.433441452971, 1303.3157592264138, 1316.0984725462897, 1317.5915466205506, 1321.62333734887, 949.8717673114041, 953.3564843730454, 1037.4138611684375, 1074.6453670288786, 1075.774087441646, 6031.638101713911, 6171.907421388682, 6178.227721534809, 6184.907226391608, 6288.685565721696, 434.86084452974745, 443.82247101159794, 444.73316010394154, 448.9685721999494, 458.0, 4385.802638881258, 4427.712198707074, 4438.023634800404, 4443.355713421536, 4476.485204201494, 10523.894761052445, 10849.077828384517, 10926.289791163548, 10933.507992140372, 10952.069074128789, 10114.848277275847, 10715.892841071489, 10852.67441976742, 10868.402237876835, 10868.402237876835, 7661.080670319486, 7839.294463498312, 7871.134175240719, 7902.960485197652, 7929.167437419103, 6103.572749907464, 6246.250449946036, 6318.210223722035, 6349.301576826638, 6408.61548307103, 9768.80462390734, 9882.357646752938, 9888.950555247178, 9926.751831204278, 10058.0, 9897.158741506764, 9992.950035249778, 10438.739031524272, 10464.686059418229, 10534.209934254808, 7026.367626913602, 7603.467757256939, 7669.769906902802, 7762.301392874669, 7847.686092556234, 8269.751907442786, 8275.875861862198, 8324.29243514284, 8350.290225330915, 8358.87461688063, 7613.6573854177805, 7872.763817085496, 7946.284834364935, 7996.080450748006, 8002.639881205243, 7729.111152217342, 7810.88283675734, 7813.1796161402235, 7930.444868859356, 8020.558869262247, 6834.2482326943, 6890.724371025103, 6909.689063992233, 6924.480663950123, 6931.514793964374, 5366.275552800478, 5430.456954304538, 5453.0, 5490.80782172622, 5491.533219676372, 5440.347158341025, 5528.253685752533, 5545.861353466195, 5564.415736347787, 5614.24207731951], "value": 4587.206796496657, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.77942388887493, 334.30631439762493, 338.1090825674347, 338.7154789976419, 341.99283111237406, 5408.67547947123, 5498.175273708941, 5509.741006187464, 5533.750981205845, 5550.222968784364, 5426.8914621707545, 5445.537129344, 5447.809326673567, 5457.69982650955, 5482.671039737618, 4041.595840415964, 4134.8139333729905, 4226.45056142701, 4251.744895306276, 4256.616904478597, 4222.134462435193, 4248.150369926012, 4248.936265956013, 4254.808533615979, 4255.0, 4017.3773065174946, 4174.478190226222, 4203.747775133486, 4232.449781528397, 4240.194363071022, 4081.8163182656854, 4233.1956928183545, 4245.893852653678, 4246.617804397588, 4253.298205796024, 3724.478572999782, 3724.491580909736, 3745.3632882410056, 3746.8572085513906, 3759.887203383903, 5285.709285989269, 5286.524212820865, 5317.468253174651, 5319.249928800186, 5332.626716129873, 4535.501094879561, 4761.381020467352, 4763.95236047642, 4766.52334766524, 4802.135615589193, 5630.930123276565, 5642.689652069134, 5647.661140331593, 5658.830235092953, 5683.460071293221, 3987.641112299907, 4017.27689015977, 4017.337139372, 4022.5374081980654, 4032.4354590357375, 5654.6041777075625, 5895.322037965646, 5901.734421951022, 5908.586398952075, 5943.55423343251, 4072.5927407259037, 4079.8980025499004, 4112.444819949328, 4114.753114813061, 4121.1345617420075, 4126.834926602963, 4158.542560318362, 4167.458230430086, 4167.5832416758685, 4185.497740271126, 4566.908661826745, 4738.360321356642, 4802.519748025239, 4806.951930480651, 4846.466888642247, 5677.643777832153, 5688.40271771458, 5714.514266287412, 5775.653460792366, 5782.942170578324, 1560.3368568358403, 1577.4478932373806, 1578.1556867076058, 1585.2549301828353, 1585.4054729476447, 1033.0805583031108, 1076.9030787229187, 1078.5577913055608, 1081.3403823667556, 1084.6258040975852, 5962.731677074542, 5993.610415323077, 5994.820155395345, 5999.310079340845, 6003.489703375175, 6074.908876366858, 6245.75016999324, 6248.5313601480075, 6248.937510624926, 6250.781222657185, 5968.283805943314, 5972.790952316735, 5974.910376344358, 5984.102384642251, 5988.850278742979, 3318.7930026532567, 3321.368939901411, 3348.7944340037566, 3349.8995030149135, 3352.2792599591203, 5860.794872179454, 6146.4775494082605, 6152.261728592597, 6169.167162433104, 6527.54307198501, 6024.457798798129, 6081.959020489755, 6105.96947015271, 6119.510439164945, 6124.203853499017, 5825.417458254141, 6097.512199024068, 6101.816945491642, 6163.7842675506145, 6166.445019948226, 5885.764569417347, 5896.64620122794, 5912.871366308212, 5961.076033214858, 5969.641821490724, 5840.591158618856, 5845.795397161079, 5859.648421094748, 5862.413758624274, 5906.173135761082, 5857.619254748428, 6103.176071230505, 6120.204373431426, 6151.108089327112, 6160.229971253593, 4116.958830411658, 4147.170565886895, 4159.209750147463, 4161.91676166481, 4197.160567886373, 5618.803341883015, 5701.942980570308, 5914.615549989409, 5947.91078133837, 5995.700214989146, 5752.482276594959, 5782.913256301074, 5792.623479473821, 5798.855028624318, 5807.041838096667, 5549.778008879761, 5735.8566035849435, 5797.652140871562, 5798.478136967693, 5799.739011744397, 5596.524295434933, 5636.915446268227, 5646.435356464321, 5672.780352224291, 5680.176374425602, 5731.541476681939, 5810.970945145247, 5818.418158184148, 5819.563532734977, 5834.18321434991, 5372.227165035607, 5661.2923384576925, 5679.148127780866, 5714.542836573148, 5729.971350143389], "value": 4414.449680345528, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [903.2999425445281, 921.5806807902409, 923.4090182283338, 944.433339996002, 950.3632566180659, 15110.47113351033, 15123.092614443141, 15307.464238751645, 15320.463783767571, 15336.923315383421, 14065.367058482367, 14117.364718587662, 14122.576322710309, 14133.293335333243, 14135.929320353409, 726.1358982810452, 860.5439117267858, 893.3389291923994, 896.1755185229572, 899.5951821680237, 860.5912191708951, 871.2376670413388, 873.9169778870997, 876.1939016105167, 876.8728534362514, 936.7470782888616, 937.779621788879, 937.7843096087904, 938.0197693410403, 938.5635679409073, 760.046142091677, 891.3582220801045, 919.8068405634858, 921.212363429265, 921.3642586615214, 673.3939454490949, 674.0596867369991, 675.7668604331498, 675.8411773233287, 676.0974099577021, 14411.351489183013, 14487.71024579513, 14529.055611385333, 14537.200453975027, 14582.927085364612, 14495.202763847985, 15131.243437828174, 15177.392904283815, 15208.771868421982, 15235.847641523555, 12215.389230538438, 12409.379531023413, 12482.937585312106, 12562.0, 12681.809772853414, 4026.4765580474646, 4057.7768222747736, 4083.734557253769, 4139.77231252281, 4157.043879907638, 51710.48289517094, 53693.99999999961, 58875.41124588742, 59728.10407843886, 59828.70085649544, 11601.941990290163, 11672.299662020307, 11702.76594468106, 11766.294022358687, 11829.704257393634, 19859.404217873485, 20031.198752050048, 20097.59804803896, 20098.39704808858, 20105.497362566053, 8683.869741953877, 8952.552372381355, 8954.641814327484, 9117.544122793834, 9299.442033478013, 5176.7152806596, 5185.766640501187, 5191.32512773337, 5232.3459567554055, 5323.30796996388, 3622.8188590570367, 3632.1282892105705, 3668.1013151777984, 3668.706503479715, 3688.6126956669164, 655.7967030220647, 665.2449469851753, 670.5909395268882, 682.4710849091994, 696.1819861662526, 743.5427212264526, 767.2021098057958, 798.9850998731421, 811.1726039439739, 842.2546046748672, 9554.808903822024, 9674.661386851567, 9904.55429505674, 9940.652077177409, 10082.596696132072, 794.6026986506747, 797.4513218299817, 804.9919500804917, 825.4551995682821, 825.69449303758, 4801.1117943180625, 4811.254255590389, 4858.489858564871, 4930.457649658535, 4936.851894443101, 75969.62015189888, 77157.22842771612, 77709.61145194237, 78004.60997695089, 78877.60561197158, 46466.303005454945, 54129.72935135378, 56090.0, 62351.376486235466, 67732.0, 56453.0, 57963.710181449664, 59123.0, 59865.0, 60868.08697869447, 8707.695230666895, 8960.68637597681, 8983.0, 9056.909430905607, 9146.0, 37249.25501490009, 38199.6180038196, 38667.0, 38669.806650966566, 39009.41485877771, 48935.26597100975, 52438.47561524488, 52979.47020529745, 53152.73423632857, 53252.0, 10183.898161018591, 10847.186461015297, 11963.880361196625, 11997.160198786001, 12101.334426606621, 13250.403731831899, 13812.723745525234, 14025.29873506341, 14124.081934674214, 14431.35058922372, 13197.340132993504, 13201.20792752438, 13415.798763018367, 14097.577072687836, 14099.929500352433, 12255.509779608716, 12383.380830958236, 12754.298513581842, 13550.051496395157, 14172.858271417153, 12137.150399472306, 13030.348482576022, 13316.86683133195, 13425.597232083053, 13725.970552208424, 10454.372737635462, 10637.414942178255, 10663.146948244277, 10981.560737570728, 11290.49192786343, 10577.349926428535, 10602.363858168535, 10664.360138391721, 10696.358218506915, 10848.186386020921], "value": 7239.192334550898, "unit": "score"}], "name": "dromaeo_css", "value": 7353.060177687202, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 107.0, 111.0, 110.0, 111.0, 99.0, 110.0, 110.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 154.0, 177.0, 134.0, 154.0, 161.0, 136.0, 183.0, 127.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 163.0, 161.0, 162.0, 162.0, 162.0, 165.0, 160.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 171.0, 77.0, 73.0, 74.0, 75.0, 163.0, 74.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 148.0, 93.0, 94.0, 93.0, 158.0, 91.0, 93.0, 147.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 116.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 63.0, 63.0, 64.0, 62.0, 84.0, 62.0, 60.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 65.0, 58.0, 58.0, 58.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 79.0, 80.0, 73.0, 83.0, 75.0, 74.0, 74.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 118.0, 117.0, 118.0, 119.0, 116.0, 127.0, 120.0, 166.0, 121.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 158.0, 156.0, 156.0, 158.0, 162.0, 157.0, 158.0, 157.0, 160.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1530.2, "alertThreshold": 2.0}]} 14:05:24 INFO - Return code: 0 14:05:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:05:24 ERROR - # TBPL SUCCESS # 14:05:24 INFO - Running post-action listener: _resource_record_post_action 14:05:24 INFO - Running post-run listener: _resource_record_post_run 14:05:25 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 498008064; Read time: 4; Write time: 701280 14:05:25 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 217874432; Read time: 0; Write time: 420868 14:05:25 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249151488; Read time: 4; Write time: 270296 14:05:25 INFO - Running post-run listener: _upload_blobber_files 14:05:25 INFO - Blob upload gear active. 14:05:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:05:25 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 14:05:25 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'] 14:05:25 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 14:05:26 INFO - (blobuploader) - INFO - Open directory for files ... 14:05:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:05:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:05:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:05:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:05:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:05:26 INFO - (blobuploader) - INFO - Done attempting. 14:05:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:05:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:05:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:05:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:05:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:05:27 INFO - (blobuploader) - INFO - Done attempting. 14:05:27 INFO - (blobuploader) - INFO - Iteration through files over. 14:05:27 INFO - Return code: 0 14:05:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:05:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:05:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0614800d2bb06a9aff3a001fa2cbcb349e552c2f80643dfd980e7fc01c396e40eb4c0194cc935af6949d8e6d4f22745ae56fb707a7d975d742a46b3762aab7bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1870be16559f62cee0c86bc9a72433ebf816f4797519b1fabee95a2b5d60eadb2684ed781f0b5a44afd52506089ee2ebec7061b44840cf87d1d9c6f955424ec9"} 14:05:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:05:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:05:27 INFO - Contents: 14:05:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0614800d2bb06a9aff3a001fa2cbcb349e552c2f80643dfd980e7fc01c396e40eb4c0194cc935af6949d8e6d4f22745ae56fb707a7d975d742a46b3762aab7bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1870be16559f62cee0c86bc9a72433ebf816f4797519b1fabee95a2b5d60eadb2684ed781f0b5a44afd52506089ee2ebec7061b44840cf87d1d9c6f955424ec9"} 14:05:27 INFO - Running post-run listener: copy_logs_to_upload_dir 14:05:27 INFO - Copying logs to upload dir... 14:05:27 INFO - mkdir: /builds/slave/test/build/upload/logs 14:05:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.694665 ========= master_lag: 24.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-25 14:05:50.775174) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 14:05:50.780332) ========= 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=33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500 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/0614800d2bb06a9aff3a001fa2cbcb349e552c2f80643dfd980e7fc01c396e40eb4c0194cc935af6949d8e6d4f22745ae56fb707a7d975d742a46b3762aab7bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1870be16559f62cee0c86bc9a72433ebf816f4797519b1fabee95a2b5d60eadb2684ed781f0b5a44afd52506089ee2ebec7061b44840cf87d1d9c6f955424ec9"} build_url:https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/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/0614800d2bb06a9aff3a001fa2cbcb349e552c2f80643dfd980e7fc01c396e40eb4c0194cc935af6949d8e6d4f22745ae56fb707a7d975d742a46b3762aab7bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1870be16559f62cee0c86bc9a72433ebf816f4797519b1fabee95a2b5d60eadb2684ed781f0b5a44afd52506089ee2ebec7061b44840cf87d1d9c6f955424ec9"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 14:05:50.840416) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:05:50.840709) ========= 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=33d5923976266a1c518c4bf7000001ab-1461617095.888889-1691927500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.70 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:05:51.543156) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:05:51.543468) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:05:51.798477) ========= ========= Total master_lag: 24.87 =========