builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1462789771.25 results: success (0) buildid: 20160509005049 builduid: 41dbd660830c4270b4520649f25740b3 revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 03:29:31.252540) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 03:29:31.253040) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 03:29:31.253360) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 03:29:31.269910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:29:31.270217) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 03:29:31-- 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% 38.5M=0s 2016-05-09 03:29:31 (38.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114948 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:29:31.398682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:29:31.398990) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013750 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:29:31.448428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:29:31.448788) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 307b5eca8726f6a72a1d69ba76630a6dbf402477 --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 307b5eca8726f6a72a1d69ba76630a6dbf402477 --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=9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 03:29:31,972 truncating revision to first 12 chars 2016-05-09 03:29:31,972 Setting DEBUG logging. 2016-05-09 03:29:31,972 attempt 1/10 2016-05-09 03:29:31,972 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/307b5eca8726?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 03:29:32,267 unpacking tar archive at: mozilla-aurora-307b5eca8726/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618336 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:29:32.080049) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 03:29:32.080371) ========= script_repo_revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 03:29:32.080773) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 03:29:32.081036) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 03:29:32.090319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-09 03:29:32.090621) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:29:32 INFO - MultiFileLogger online at 20160509 03:29:32 in /builds/slave/test 03:29:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:29:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:29:32 INFO - {'append_to_log': False, 03:29:32 INFO - 'base_work_dir': '/builds/slave/test', 03:29:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:29:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:29:32 INFO - 'branch': 'Mozilla-Aurora', 03:29:32 INFO - 'buildbot_json_path': 'buildprops.json', 03:29:32 INFO - 'config_files': ('talos/linux_config.py',), 03:29:32 INFO - 'default_actions': ('clobber', 03:29:32 INFO - 'read-buildbot-config', 03:29:32 INFO - 'download-and-extract', 03:29:32 INFO - 'populate-webroot', 03:29:32 INFO - 'create-virtualenv', 03:29:32 INFO - 'install', 03:29:32 INFO - 'run-tests'), 03:29:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:29:32 INFO - 'download_minidump_stackwalk': True, 03:29:32 INFO - 'download_symbols': 'ondemand', 03:29:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:29:32 INFO - 'tooltool.py': '/tools/tooltool.py', 03:29:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:29:32 INFO - '/tools/misc-python/virtualenv.py')}, 03:29:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:29:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:29:32 INFO - 'installer_path': 'installer.exe', 03:29:32 INFO - 'log_level': 'info', 03:29:32 INFO - 'log_name': 'talos', 03:29:32 INFO - 'log_to_console': True, 03:29:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:29:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:29:32 INFO - 'opt_config_files': (), 03:29:32 INFO - 'pip_index': False, 03:29:32 INFO - 'sps_profile': False, 03:29:32 INFO - 'sps_profile_interval': 0, 03:29:32 INFO - 'suite': 'dromaeojs', 03:29:32 INFO - 'system_bits': '32', 03:29:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:29:32 INFO - 'title': 'talos-linux64-ix-013', 03:29:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:29:32 INFO - 'use_talos_json': True, 03:29:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:29:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:29:32 INFO - 'work_dir': 'build'} 03:29:32 INFO - ##### 03:29:32 INFO - ##### Running clobber step. 03:29:32 INFO - ##### 03:29:32 INFO - Running pre-action listener: _resource_record_pre_action 03:29:32 INFO - Running main action method: clobber 03:29:32 INFO - rmtree: /builds/slave/test/build 03:29:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:29:33 INFO - Running post-action listener: _resource_record_post_action 03:29:33 INFO - ##### 03:29:33 INFO - ##### Running read-buildbot-config step. 03:29:33 INFO - ##### 03:29:33 INFO - Running pre-action listener: _resource_record_pre_action 03:29:33 INFO - Running main action method: read_buildbot_config 03:29:33 INFO - Using buildbot properties: 03:29:33 INFO - { 03:29:33 INFO - "project": "", 03:29:33 INFO - "product": "firefox", 03:29:33 INFO - "script_repo_revision": "production", 03:29:33 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:29:33 INFO - "repository": "", 03:29:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:29:33 INFO - "buildid": "20160509005049", 03:29:33 INFO - "pgo_build": "True", 03:29:33 INFO - "basedir": "/builds/slave/test", 03:29:33 INFO - "buildnumber": 224, 03:29:33 INFO - "slavename": "talos-linux64-ix-013", 03:29:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:29:33 INFO - "platform": "ubuntu64_hw", 03:29:33 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:29:33 INFO - "branch": "mozilla-aurora", 03:29:33 INFO - "repo_path": "releases/mozilla-aurora", 03:29:33 INFO - "revision": "307b5eca8726f6a72a1d69ba76630a6dbf402477", 03:29:33 INFO - "stage_platform": "linux64-pgo", 03:29:33 INFO - "builduid": "41dbd660830c4270b4520649f25740b3", 03:29:33 INFO - "slavebuilddir": "test" 03:29:33 INFO - } 03:29:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:29:33 INFO - Running post-action listener: _resource_record_post_action 03:29:33 INFO - ##### 03:29:33 INFO - ##### Running download-and-extract step. 03:29:33 INFO - ##### 03:29:33 INFO - Running pre-action listener: _resource_record_pre_action 03:29:33 INFO - Running main action method: download_and_extract 03:29:33 INFO - mkdir: /builds/slave/test/build/tests 03:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:33 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:29:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:29:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:29:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:29:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:29:34 INFO - Downloaded 1361 bytes. 03:29:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:29:34 INFO - Using the following test package requirements: 03:29:34 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:29:34 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:34 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:29:34 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:34 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:29:34 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:34 INFO - u'jsshell-linux-x86_64.zip'], 03:29:34 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:34 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:29:34 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:29:34 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:34 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:29:34 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:34 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:29:34 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:34 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:29:34 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:34 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:29:34 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:34 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:29:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:29:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:29:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:29:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:29:35 INFO - Downloaded 23798585 bytes. 03:29:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:29:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:29:36 INFO - Return code: 0 03:29:36 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:36 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:29:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:29:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:29:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:29:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:29:37 INFO - Downloaded 23798585 bytes. 03:29:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:29:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:29:39 INFO - Return code: 0 03:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:39 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:29:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:29:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:29:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:29:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:29:39 INFO - Downloaded 10840145 bytes. 03:29:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:29:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:29:40 INFO - Return code: 0 03:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:40 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:29:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:29:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:29:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:29:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:29:41 INFO - Downloaded 62704189 bytes. 03:29:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:29:41 INFO - mkdir: /builds/slave/test/properties 03:29:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:29:41 INFO - Writing to file /builds/slave/test/properties/build_url 03:29:41 INFO - Contents: 03:29:41 INFO - build_url:https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:29:42 INFO - Running post-action listener: _resource_record_post_action 03:29:42 INFO - Running post-action listener: set_extra_try_arguments 03:29:42 INFO - ##### 03:29:42 INFO - ##### Running populate-webroot step. 03:29:42 INFO - ##### 03:29:42 INFO - Running pre-action listener: _resource_record_pre_action 03:29:42 INFO - Running main action method: populate_webroot 03:29:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:29:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:29:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:29:42 INFO - '--tppagecycles', 03:29:42 INFO - '7'], 03:29:42 INFO - 'tests': ['tsvgm']}}, 03:29:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:29:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:29:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:29:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:29:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:29:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:29:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:42 INFO - 'talos_options': ['--disable-e10s'], 03:29:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:42 INFO - 'talos_options': ['--disable-e10s'], 03:29:42 INFO - 'tests': ['damp', 'tps']}, 03:29:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:42 INFO - 'tests': ['damp', 'tps']}, 03:29:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:29:42 INFO - 'tests': ['dromaeo_dom']}, 03:29:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:29:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:29:42 INFO - 'tests': ['a11yr', 03:29:42 INFO - 'ts_paint', 03:29:42 INFO - 'tpaint', 03:29:42 INFO - 'sessionrestore', 03:29:42 INFO - 'sessionrestore_no_auto_restore', 03:29:42 INFO - 'tabpaint']}, 03:29:42 INFO - 'other-e10s': {'tests': ['a11yr', 03:29:42 INFO - 'ts_paint', 03:29:42 INFO - 'tpaint', 03:29:42 INFO - 'sessionrestore', 03:29:42 INFO - 'sessionrestore_no_auto_restore', 03:29:42 INFO - 'tabpaint']}, 03:29:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:29:42 INFO - 'ts_paint', 03:29:42 INFO - 'tpaint', 03:29:42 INFO - 'sessionrestore', 03:29:42 INFO - 'sessionrestore_no_auto_restore', 03:29:42 INFO - 'tabpaint']}, 03:29:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:29:42 INFO - 'ts_paint', 03:29:42 INFO - 'tpaint', 03:29:42 INFO - 'sessionrestore', 03:29:42 INFO - 'sessionrestore_no_auto_restore', 03:29:42 INFO - 'tabpaint']}, 03:29:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:29:42 INFO - 'tests': ['a11yr', 03:29:42 INFO - 'ts_paint', 03:29:42 INFO - 'tpaint', 03:29:42 INFO - 'sessionrestore', 03:29:42 INFO - 'sessionrestore_no_auto_restore', 03:29:42 INFO - 'tabpaint']}, 03:29:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:29:42 INFO - 'tests': ['a11yr', 03:29:42 INFO - 'ts_paint', 03:29:42 INFO - 'tpaint', 03:29:42 INFO - 'sessionrestore', 03:29:42 INFO - 'sessionrestore_no_auto_restore', 03:29:42 INFO - 'tabpaint']}, 03:29:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:29:42 INFO - 'tests': ['tsvgx', 03:29:42 INFO - 'tsvgr_opacity', 03:29:42 INFO - 'tart', 03:29:42 INFO - 'tscrollx', 03:29:42 INFO - 'cart']}, 03:29:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:29:42 INFO - 'tsvgr_opacity', 03:29:42 INFO - 'tart', 03:29:42 INFO - 'tscrollx', 03:29:42 INFO - 'cart']}, 03:29:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:42 INFO - 'talos_options': ['--disable-e10s'], 03:29:42 INFO - 'tests': ['tp5o']}, 03:29:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:42 INFO - 'tests': ['tp5o']}, 03:29:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:42 INFO - 'talos_options': ['--disable-e10s', 03:29:42 INFO - '--xperf_path', 03:29:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:42 INFO - 'tests': ['tp5n']}, 03:29:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:42 INFO - 'talos_options': ['--xperf_path', 03:29:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:42 INFO - 'tests': ['tp5n']}}, 03:29:42 INFO - 'talos.zip': {'path': '', 03:29:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:29:42 INFO - Running post-action listener: _resource_record_post_action 03:29:42 INFO - ##### 03:29:42 INFO - ##### Running create-virtualenv step. 03:29:42 INFO - ##### 03:29:42 INFO - Running pre-action listener: _resource_record_pre_action 03:29:42 INFO - Running main action method: create_virtualenv 03:29:42 INFO - Creating virtualenv /builds/slave/test/build/venv 03:29:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:29:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:29:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:29:42 INFO - Using real prefix '/usr' 03:29:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:29:43 INFO - Installing distribute.............................................................................................................................................................................................done. 03:29:44 INFO - Installing pip.................done. 03:29:44 INFO - Return code: 0 03:29:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:44 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 0x7ffab2ce6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b48410>, '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 0x2b49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b497a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:29:44 INFO - Using env: {'DISPLAY': ':0', 03:29:44 INFO - 'HOME': '/home/cltbld', 03:29:44 INFO - 'LANG': 'en_US.UTF-8', 03:29:44 INFO - 'LANGUAGE': 'en_US:en', 03:29:44 INFO - 'LOGNAME': 'cltbld', 03:29:44 INFO - 'MAIL': '/var/mail/cltbld', 03:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:44 INFO - 'MOZ_NO_REMOTE': '1', 03:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:44 INFO - 'NO_EM_RESTART': '1', 03:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:44 INFO - 'PWD': '/builds/slave/test', 03:29:44 INFO - 'SHELL': '/bin/bash', 03:29:44 INFO - 'SHLVL': '1', 03:29:44 INFO - 'TERM': 'linux', 03:29:44 INFO - 'TMOUT': '86400', 03:29:44 INFO - 'USER': 'cltbld', 03:29:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 03:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:44 INFO - '_': '/tools/buildbot/bin/python'} 03:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:29:45 INFO - Cleaning up... 03:29:45 INFO - Return code: 0 03:29:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:45 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 0x7ffab2ce6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b48410>, '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 0x2b49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b497a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:29:45 INFO - Using env: {'DISPLAY': ':0', 03:29:45 INFO - 'HOME': '/home/cltbld', 03:29:45 INFO - 'LANG': 'en_US.UTF-8', 03:29:45 INFO - 'LANGUAGE': 'en_US:en', 03:29:45 INFO - 'LOGNAME': 'cltbld', 03:29:45 INFO - 'MAIL': '/var/mail/cltbld', 03:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:45 INFO - 'MOZ_NO_REMOTE': '1', 03:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:45 INFO - 'NO_EM_RESTART': '1', 03:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:45 INFO - 'PWD': '/builds/slave/test', 03:29:45 INFO - 'SHELL': '/bin/bash', 03:29:45 INFO - 'SHLVL': '1', 03:29:45 INFO - 'TERM': 'linux', 03:29:45 INFO - 'TMOUT': '86400', 03:29:45 INFO - 'USER': 'cltbld', 03:29:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 03:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:45 INFO - '_': '/tools/buildbot/bin/python'} 03:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:45 INFO - Downloading/unpacking psutil>=0.7.1 03:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:29:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:47 INFO - Installing collected packages: psutil 03:29:47 INFO - Running setup.py install for psutil 03:29:47 INFO - building 'psutil._psutil_linux' extension 03:29:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:29:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:29:47 INFO - building 'psutil._psutil_posix' extension 03:29:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:29:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:29:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:47 INFO - Successfully installed psutil 03:29:47 INFO - Cleaning up... 03:29:47 INFO - Return code: 0 03:29:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:47 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 0x7ffab2ce6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b48410>, '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 0x2b49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b497a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:29:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:29:47 INFO - Using env: {'DISPLAY': ':0', 03:29:47 INFO - 'HOME': '/home/cltbld', 03:29:47 INFO - 'LANG': 'en_US.UTF-8', 03:29:47 INFO - 'LANGUAGE': 'en_US:en', 03:29:47 INFO - 'LOGNAME': 'cltbld', 03:29:47 INFO - 'MAIL': '/var/mail/cltbld', 03:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:47 INFO - 'MOZ_NO_REMOTE': '1', 03:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:47 INFO - 'NO_EM_RESTART': '1', 03:29:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:47 INFO - 'PWD': '/builds/slave/test', 03:29:47 INFO - 'SHELL': '/bin/bash', 03:29:47 INFO - 'SHLVL': '1', 03:29:47 INFO - 'TERM': 'linux', 03:29:47 INFO - 'TMOUT': '86400', 03:29:47 INFO - 'USER': 'cltbld', 03:29:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 03:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:47 INFO - '_': '/tools/buildbot/bin/python'} 03:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:29:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:29:50 INFO - Installing collected packages: mozsystemmonitor 03:29:50 INFO - Running setup.py install for mozsystemmonitor 03:29:50 INFO - Successfully installed mozsystemmonitor 03:29:50 INFO - Cleaning up... 03:29:50 INFO - Return code: 0 03:29:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:50 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 0x7ffab2ce6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b48410>, '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 0x2b49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b497a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:29:50 INFO - Using env: {'DISPLAY': ':0', 03:29:50 INFO - 'HOME': '/home/cltbld', 03:29:50 INFO - 'LANG': 'en_US.UTF-8', 03:29:50 INFO - 'LANGUAGE': 'en_US:en', 03:29:50 INFO - 'LOGNAME': 'cltbld', 03:29:50 INFO - 'MAIL': '/var/mail/cltbld', 03:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:50 INFO - 'MOZ_NO_REMOTE': '1', 03:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:50 INFO - 'NO_EM_RESTART': '1', 03:29:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:50 INFO - 'PWD': '/builds/slave/test', 03:29:50 INFO - 'SHELL': '/bin/bash', 03:29:50 INFO - 'SHLVL': '1', 03:29:50 INFO - 'TERM': 'linux', 03:29:50 INFO - 'TMOUT': '86400', 03:29:50 INFO - 'USER': 'cltbld', 03:29:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 03:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:50 INFO - '_': '/tools/buildbot/bin/python'} 03:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:50 INFO - Downloading/unpacking blobuploader==1.2.4 03:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:52 INFO - Downloading blobuploader-1.2.4.tar.gz 03:29:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:29:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:29:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:53 INFO - Downloading docopt-0.6.1.tar.gz 03:29:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:29:53 INFO - Installing collected packages: blobuploader, requests, docopt 03:29:53 INFO - Running setup.py install for blobuploader 03:29:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:29:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:29:53 INFO - Running setup.py install for requests 03:29:53 INFO - Running setup.py install for docopt 03:29:53 INFO - Successfully installed blobuploader requests docopt 03:29:53 INFO - Cleaning up... 03:29:53 INFO - Return code: 0 03:29:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:53 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 0x7ffab2ce6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b48410>, '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 0x2b49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b497a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:53 INFO - Using env: {'DISPLAY': ':0', 03:29:53 INFO - 'HOME': '/home/cltbld', 03:29:53 INFO - 'LANG': 'en_US.UTF-8', 03:29:53 INFO - 'LANGUAGE': 'en_US:en', 03:29:53 INFO - 'LOGNAME': 'cltbld', 03:29:53 INFO - 'MAIL': '/var/mail/cltbld', 03:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:53 INFO - 'MOZ_NO_REMOTE': '1', 03:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:53 INFO - 'NO_EM_RESTART': '1', 03:29:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:53 INFO - 'PWD': '/builds/slave/test', 03:29:53 INFO - 'SHELL': '/bin/bash', 03:29:53 INFO - 'SHLVL': '1', 03:29:53 INFO - 'TERM': 'linux', 03:29:53 INFO - 'TMOUT': '86400', 03:29:53 INFO - 'USER': 'cltbld', 03:29:53 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 03:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:53 INFO - '_': '/tools/buildbot/bin/python'} 03:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:54 INFO - Running setup.py (path:/tmp/pip-c6nnbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:54 INFO - Running setup.py (path:/tmp/pip-sQsA_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:54 INFO - Running setup.py (path:/tmp/pip-5ct5Il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:54 INFO - Running setup.py (path:/tmp/pip-ZlXphG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:54 INFO - Running setup.py (path:/tmp/pip-eTJjBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:54 INFO - Running setup.py (path:/tmp/pip-6UIiPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:54 INFO - Running setup.py (path:/tmp/pip-PetX8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:54 INFO - Running setup.py (path:/tmp/pip-PAbAFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:54 INFO - Running setup.py (path:/tmp/pip-TViHR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:54 INFO - Running setup.py (path:/tmp/pip-IGuWTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:54 INFO - Running setup.py (path:/tmp/pip-JibG1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:54 INFO - Running setup.py (path:/tmp/pip-CYgiKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:54 INFO - Running setup.py (path:/tmp/pip-dv3zqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:54 INFO - Running setup.py (path:/tmp/pip-BGYAfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:55 INFO - Running setup.py (path:/tmp/pip-wgB_ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:55 INFO - Running setup.py (path:/tmp/pip-M01tWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:55 INFO - Running setup.py (path:/tmp/pip-jpAR1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:29:55 INFO - Running setup.py install for manifestparser 03:29:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:29:55 INFO - Running setup.py install for mozcrash 03:29:55 INFO - Running setup.py install for mozdebug 03:29:55 INFO - Running setup.py install for mozdevice 03:29:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:29:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:29:55 INFO - Running setup.py install for mozfile 03:29:55 INFO - Running setup.py install for mozhttpd 03:29:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:29:55 INFO - Running setup.py install for mozinfo 03:29:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:29:55 INFO - Running setup.py install for mozInstall 03:29:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Running setup.py install for mozleak 03:29:56 INFO - Running setup.py install for mozlog 03:29:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Running setup.py install for moznetwork 03:29:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Running setup.py install for mozprocess 03:29:56 INFO - Running setup.py install for mozprofile 03:29:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Running setup.py install for mozrunner 03:29:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Running setup.py install for mozscreenshot 03:29:56 INFO - Running setup.py install for moztest 03:29:56 INFO - Running setup.py install for mozversion 03:29:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:29:57 INFO - Cleaning up... 03:29:57 INFO - Return code: 0 03:29:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:57 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 0x7ffab2ce6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b48410>, '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 0x2b49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b497a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:29:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:57 INFO - Using env: {'DISPLAY': ':0', 03:29:57 INFO - 'HOME': '/home/cltbld', 03:29:57 INFO - 'LANG': 'en_US.UTF-8', 03:29:57 INFO - 'LANGUAGE': 'en_US:en', 03:29:57 INFO - 'LOGNAME': 'cltbld', 03:29:57 INFO - 'MAIL': '/var/mail/cltbld', 03:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:57 INFO - 'MOZ_NO_REMOTE': '1', 03:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:57 INFO - 'NO_EM_RESTART': '1', 03:29:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:57 INFO - 'PWD': '/builds/slave/test', 03:29:57 INFO - 'SHELL': '/bin/bash', 03:29:57 INFO - 'SHLVL': '1', 03:29:57 INFO - 'TERM': 'linux', 03:29:57 INFO - 'TMOUT': '86400', 03:29:57 INFO - 'USER': 'cltbld', 03:29:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 03:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:57 INFO - '_': '/tools/buildbot/bin/python'} 03:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:57 INFO - Running setup.py (path:/tmp/pip-3v67qR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:57 INFO - Running setup.py (path:/tmp/pip-1Y7kaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:57 INFO - Running setup.py (path:/tmp/pip-AlH24S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:57 INFO - Running setup.py (path:/tmp/pip-l3ouTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:57 INFO - Running setup.py (path:/tmp/pip-7iiyMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:57 INFO - Running setup.py (path:/tmp/pip-MiQLJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:57 INFO - Running setup.py (path:/tmp/pip-M1ONYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:57 INFO - Running setup.py (path:/tmp/pip-6LH0uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:57 INFO - Running setup.py (path:/tmp/pip-GbcQe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:57 INFO - Running setup.py (path:/tmp/pip-bMYfYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:57 INFO - Running setup.py (path:/tmp/pip-2FBVUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:58 INFO - Running setup.py (path:/tmp/pip-xz5Fav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:58 INFO - Running setup.py (path:/tmp/pip-stN2Eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:58 INFO - Running setup.py (path:/tmp/pip-IlfV8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:58 INFO - Running setup.py (path:/tmp/pip-NxyFOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:58 INFO - Running setup.py (path:/tmp/pip-834NCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:58 INFO - Running setup.py (path:/tmp/pip-yFJ30T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:00 INFO - Downloading blessings-1.6.tar.gz 03:30:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:00 INFO - Installing collected packages: blessings 03:30:00 INFO - Running setup.py install for blessings 03:30:00 INFO - Successfully installed blessings 03:30:00 INFO - Cleaning up... 03:30:00 INFO - Return code: 0 03:30:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:30:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:00 INFO - Reading from file tmpfile_stdout 03:30:00 INFO - Current package versions: 03:30:00 INFO - argparse == 1.2.1 03:30:00 INFO - blessings == 1.6 03:30:00 INFO - blobuploader == 1.2.4 03:30:00 INFO - docopt == 0.6.1 03:30:00 INFO - manifestparser == 1.1 03:30:00 INFO - mozInstall == 1.12 03:30:00 INFO - mozcrash == 0.17 03:30:00 INFO - mozdebug == 0.1 03:30:00 INFO - mozdevice == 0.48 03:30:00 INFO - mozfile == 1.2 03:30:00 INFO - mozhttpd == 0.7 03:30:00 INFO - mozinfo == 0.9 03:30:00 INFO - mozleak == 0.1 03:30:00 INFO - mozlog == 3.1 03:30:00 INFO - moznetwork == 0.27 03:30:00 INFO - mozprocess == 0.22 03:30:00 INFO - mozprofile == 0.28 03:30:00 INFO - mozrunner == 6.11 03:30:00 INFO - mozscreenshot == 0.1 03:30:00 INFO - mozsystemmonitor == 0.0 03:30:00 INFO - moztest == 0.7 03:30:00 INFO - mozversion == 1.4 03:30:00 INFO - psutil == 3.1.1 03:30:00 INFO - requests == 1.2.3 03:30:00 INFO - wsgiref == 0.1.2 03:30:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:00 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 0x7ffab2ce6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b48410>, '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 0x2b49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b497a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:30:00 INFO - Using env: {'DISPLAY': ':0', 03:30:00 INFO - 'HOME': '/home/cltbld', 03:30:00 INFO - 'LANG': 'en_US.UTF-8', 03:30:00 INFO - 'LANGUAGE': 'en_US:en', 03:30:00 INFO - 'LOGNAME': 'cltbld', 03:30:00 INFO - 'MAIL': '/var/mail/cltbld', 03:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:00 INFO - 'MOZ_NO_REMOTE': '1', 03:30:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:00 INFO - 'NO_EM_RESTART': '1', 03:30:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:00 INFO - 'PWD': '/builds/slave/test', 03:30:00 INFO - 'SHELL': '/bin/bash', 03:30:00 INFO - 'SHLVL': '1', 03:30:00 INFO - 'TERM': 'linux', 03:30:00 INFO - 'TMOUT': '86400', 03:30:00 INFO - 'USER': 'cltbld', 03:30:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 03:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:00 INFO - '_': '/tools/buildbot/bin/python'} 03:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:30:01 INFO - Cleaning up... 03:30:01 INFO - Return code: 0 03:30:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:01 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 0x7ffab2ce6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b48410>, '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 0x2b49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b497a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:30:01 INFO - Using env: {'DISPLAY': ':0', 03:30:01 INFO - 'HOME': '/home/cltbld', 03:30:01 INFO - 'LANG': 'en_US.UTF-8', 03:30:01 INFO - 'LANGUAGE': 'en_US:en', 03:30:01 INFO - 'LOGNAME': 'cltbld', 03:30:01 INFO - 'MAIL': '/var/mail/cltbld', 03:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:01 INFO - 'MOZ_NO_REMOTE': '1', 03:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:01 INFO - 'NO_EM_RESTART': '1', 03:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:01 INFO - 'PWD': '/builds/slave/test', 03:30:01 INFO - 'SHELL': '/bin/bash', 03:30:01 INFO - 'SHLVL': '1', 03:30:01 INFO - 'TERM': 'linux', 03:30:01 INFO - 'TMOUT': '86400', 03:30:01 INFO - 'USER': 'cltbld', 03:30:01 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 03:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:01 INFO - '_': '/tools/buildbot/bin/python'} 03:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:01 INFO - Downloading/unpacking jsonschema 03:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:30:03 INFO - Downloading/unpacking functools32 (from jsonschema) 03:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:03 INFO - Downloading functools32-3.2.3-2.tar.gz 03:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:30:03 INFO - warning: no files found matching '*.txt' 03:30:03 INFO - no previously-included directories found matching 'build' 03:30:03 INFO - no previously-included directories found matching 'dist' 03:30:03 INFO - no previously-included directories found matching '.git*' 03:30:03 INFO - Installing collected packages: jsonschema, functools32 03:30:03 INFO - Running setup.py install for functools32 03:30:03 INFO - warning: no files found matching '*.txt' 03:30:03 INFO - no previously-included directories found matching 'build' 03:30:03 INFO - no previously-included directories found matching 'dist' 03:30:03 INFO - no previously-included directories found matching '.git*' 03:30:03 INFO - Successfully installed jsonschema functools32 03:30:03 INFO - Cleaning up... 03:30:03 INFO - Return code: 0 03:30:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:03 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 0x7ffab2ce6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b48410>, '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 0x2b49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b497a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:30:03 INFO - Using env: {'DISPLAY': ':0', 03:30:03 INFO - 'HOME': '/home/cltbld', 03:30:03 INFO - 'LANG': 'en_US.UTF-8', 03:30:03 INFO - 'LANGUAGE': 'en_US:en', 03:30:03 INFO - 'LOGNAME': 'cltbld', 03:30:03 INFO - 'MAIL': '/var/mail/cltbld', 03:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:03 INFO - 'MOZ_NO_REMOTE': '1', 03:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:03 INFO - 'NO_EM_RESTART': '1', 03:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:03 INFO - 'PWD': '/builds/slave/test', 03:30:03 INFO - 'SHELL': '/bin/bash', 03:30:03 INFO - 'SHLVL': '1', 03:30:03 INFO - 'TERM': 'linux', 03:30:03 INFO - 'TMOUT': '86400', 03:30:03 INFO - 'USER': 'cltbld', 03:30:03 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 03:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:03 INFO - '_': '/tools/buildbot/bin/python'} 03:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:03 INFO - Downloading/unpacking flake8 03:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:30:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:30:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:30:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:30:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:30:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:30:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:30:06 INFO - no previously-included directories found matching 'docs/_build' 03:30:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:30:06 INFO - Running setup.py install for pep8 03:30:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:30:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:30:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:30:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:30:06 INFO - no previously-included directories found matching 'docs/_build' 03:30:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:30:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:30:06 INFO - Cleaning up... 03:30:06 INFO - Return code: 0 03:30:06 INFO - Running post-action listener: _resource_record_post_action 03:30:06 INFO - Running post-action listener: _start_resource_monitoring 03:30:06 INFO - Starting resource monitoring. 03:30:06 INFO - ##### 03:30:06 INFO - ##### Running install step. 03:30:06 INFO - ##### 03:30:06 INFO - Running pre-action listener: _resource_record_pre_action 03:30:06 INFO - Running main action method: install 03:30:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:06 INFO - Reading from file tmpfile_stdout 03:30:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:30:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:30:07 INFO - Reading from file tmpfile_stdout 03:30:07 INFO - Output received: 03:30:07 INFO - Usage: mozinstall [options] installer 03:30:07 INFO - Options: 03:30:07 INFO - -h, --help show this help message and exit 03:30:07 INFO - -d DEST, --destination=DEST 03:30:07 INFO - Directory to install application into. [default: 03:30:07 INFO - "/builds/slave/test"] 03:30:07 INFO - --app=APP Application being installed. [default: firefox] 03:30:07 INFO - mkdir: /builds/slave/test/build/application 03:30:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:30:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:30:22 INFO - Reading from file tmpfile_stdout 03:30:22 INFO - Output received: 03:30:22 INFO - /builds/slave/test/build/application/firefox/firefox 03:30:22 INFO - Running post-action listener: _resource_record_post_action 03:30:22 INFO - ##### 03:30:22 INFO - ##### Running run-tests step. 03:30:22 INFO - ##### 03:30:22 INFO - Running pre-action listener: _resource_record_pre_action 03:30:22 INFO - Running main action method: run_tests 03:30:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:30:22 INFO - Python 2.7.3 03:30:22 INFO - Return code: 0 03:30:22 INFO - grabbing minidump binary from tooltool 03:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:22 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 0x2b48410>, '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 0x2b49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b497a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:30:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:30:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:30:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:30:22 INFO - Return code: 0 03:30:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:30:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:30:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:30:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:30:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:30:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:30:23 INFO - Return code: 0 03:30:23 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/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:30:23 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/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:30:23 INFO - Using env: {'DISPLAY': ':0', 03:30:23 INFO - 'HOME': '/home/cltbld', 03:30:23 INFO - 'LANG': 'en_US.UTF-8', 03:30:23 INFO - 'LANGUAGE': 'en_US:en', 03:30:23 INFO - 'LOGNAME': 'cltbld', 03:30:23 INFO - 'MAIL': '/var/mail/cltbld', 03:30:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:30:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:23 INFO - 'MOZ_NO_REMOTE': '1', 03:30:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:23 INFO - 'NO_EM_RESTART': '1', 03:30:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:23 INFO - 'PWD': '/builds/slave/test', 03:30:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:30:23 INFO - 'SHELL': '/bin/bash', 03:30:23 INFO - 'SHLVL': '1', 03:30:23 INFO - 'TERM': 'linux', 03:30:23 INFO - 'TMOUT': '86400', 03:30:23 INFO - 'USER': 'cltbld', 03:30:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608', 03:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:23 INFO - '_': '/tools/buildbot/bin/python'} 03:30:23 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/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:30:23 INFO - mozversion application_buildid: 20160509005049 03:30:23 INFO - mozversion application_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 03:30:23 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:30:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:30:23 INFO - mozversion application_name: Firefox 03:30:23 INFO - mozversion application_remotingname: firefox-dev 03:30:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:30:23 INFO - mozversion application_vendor: Mozilla 03:30:23 INFO - mozversion application_version: 48.0a2 03:30:23 INFO - mozversion platform_buildid: 20160509005049 03:30:23 INFO - mozversion platform_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 03:30:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:30:23 INFO - mozversion platform_version: 48.0a2 03:30:23 INFO - using testdate: 1462789823 03:30:23 INFO - actual date: 1462789823 03:30:23 INFO - starting webserver on 'localhost:52222' 03:30:23 INFO - SUITE-START | Running 2 tests 03:30:23 INFO - TEST-START | dromaeo_css 03:30:23 INFO - operating with platform_type : linux_ 03:30:23 INFO - Initialising browser for dromaeo_css test... 03:30:23 INFO - TEST-INFO | started process 12089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzSwZCP/profile http://localhost:52222/getInfo.html) 03:30:28 INFO - PROCESS | 12089 | __metrics Screen width/height:1600/1200 03:30:28 INFO - PROCESS | 12089 | colorDepth:24 03:30:28 INFO - PROCESS | 12089 | Browser inner width/height: 1024/697 03:30:28 INFO - PROCESS | 12089 | __metrics 03:30:29 ERROR - PROCESS | 12089 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:30:29 INFO - TEST-INFO | 12089: exit 0 03:30:29 INFO - Browser initialized. 03:30:29 INFO - Running cycle 1/1 for dromaeo_css test... 03:30:29 INFO - TEST-INFO | started process 12177 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzSwZCP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:30:41 INFO - PROCESS | 12177 | RSS: Main: 141660160 03:30:41 INFO - PROCESS | 12177 | 03:31:33 INFO - PROCESS | 12177 | 1462789893371 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:33:40 INFO - PROCESS | 12177 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52222/tests/dromaeo/cssquery-ext.html) 03:33:41 INFO - PROCESS | 12177 | RSS: Main: 245518336 03:33:41 INFO - PROCESS | 12177 | 03:36:43 INFO - PROCESS | 12177 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-ext.html (next: http://localhost:52222/tests/dromaeo/cssquery-jquery.html) 03:36:44 INFO - PROCESS | 12177 | RSS: Main: 222666752 03:36:44 INFO - PROCESS | 12177 | 03:39:46 INFO - PROCESS | 12177 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52222/tests/dromaeo/cssquery-mootools.html) 03:39:46 INFO - PROCESS | 12177 | RSS: Main: 224292864 03:39:46 INFO - PROCESS | 12177 | 03:42:48 INFO - PROCESS | 12177 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52222/tests/dromaeo/cssquery-prototype.html) 03:42:49 INFO - PROCESS | 12177 | RSS: Main: 219246592 03:42:49 INFO - PROCESS | 12177 | 03:45:52 INFO - PROCESS | 12177 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52222/tests/dromaeo/cssquery-yui.html) 03:45:52 INFO - PROCESS | 12177 | RSS: Main: 211398656 03:45:52 INFO - PROCESS | 12177 | 03:48:54 INFO - PROCESS | 12177 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-yui.html (next: http://localhost:52222/tests/dromaeo/cssquery-dojo.html) 03:48:55 INFO - PROCESS | 12177 | RSS: Main: 254017536 03:48:55 INFO - PROCESS | 12177 | 03:48:55 INFO - PROCESS | 12177 | __start_tp_report 03:48:55 INFO - PROCESS | 12177 | _x_x_mozilla_page_load 03:48:55 INFO - PROCESS | 12177 | _x_x_mozilla_page_load_details 03:48:55 INFO - PROCESS | 12177 | |i|pagename|runs| 03:48:55 INFO - PROCESS | 12177 | |0;dojo.html;3330.766846320758;3390.169408494919;3402.7958322500654;3404.8467818948143;3420.17915700232;5557.083081291582;5559.722013899304;5576.135698966662;5584.497395234438;5587.2177895094665;5562.249096371998;5568.443155684429;5588.86027849303;5589.804356847511;5638.267025286717;5030.396352437712;5031.572316353096;5094.872628184297;5143.15138002231;5209.635325527214;5042.193249080148;5090.109230884599;5108;5134.8716282093055;5143.12566863634;5171.7414129293575;5201.921971170435;5223.347081614798;5234.26720259164;5243.606729495303;5133.050385678662;5148.150555158413;5181.093308670967;5183.637145399824;5231.372235331746;4966.652334336598;5013.097642424362;5079.314292570492;5086.974565127188;5096.821611243626;5453.863653408696;5457.972710136424;5465.72671366434;5467.9453205467835;5499.257600223998;5869.530437564985;5890.911636325459;5909.793157239476;5936.109583562457;5936.821895343147;5825.854353641151;5899.410058994109;5936.525077993793;5972.58191926561;5978.97010514949;5591.720413979285;5618.775248990036;5629.802956896489;5639.859003524863;5640.2667653205235;5976.8804623908145;6107.694615269219;6128.78549250783;6133.26400831903;6135.631862088289;5910.70446477683;5984.102384642251;6001.12983617373;6003.219581454383;6004.189434426296;5936.495397891227;5954.880902382015;5976.7908123215475;5977.641341519523;6010.489108425745;5943.227380440515;5945.940540594625;5946.375630558816;5961.344252132262;5964.284285885721;5760.193572899798;5971.4327138921735;5999.520038397005;6077.3314935357075;6079.483243924316;4555.863324100283;4577.702449340783;4580.496145424001;4582.862514124582;4608.28571571407;4020.4572382728543;4097.303458412077;4121.979390103031;4123.731957422758;4137.213929353413;5643.463870932255;5655.604107712421;5676.858078548069;5694.544436445074;5721.427857214246;6012.759489620454;6026.728797204137;6040.154378387029;6056;6066.059760737093;5572.888542229132;5610.382857885629;5743.310802703702;5744.626599271034;5745.253117094751;5108.335916330853;5108.56577190943;5115.053715062651;5137.049645815536;5146.974265128651;6139.631622102688;6142.293636231801;6144.324124346318;6149.077638354193;6159.692015399301;5919.822405327847;5966.075258334965;5987.311459182076;5989.341172471025;6071.119687645355;6239.937600623935;6262.780802671885;6275.058741188858;6277.843053923689;6282.905756413566;5843.926465832619;5967.6121052131475;5969.343372229138;5973.695375477267;6004.39956004396;5907.084401917709;6023.096535519707;6039.214902062704;6111.84720381994;6111.877762444815;5908;5932.199153114274;5937.079752638348;5938.2280303560265;5942.821715348547;5873.676947767914;5894.734736936763;5898.3216930053595;5900.43945825146;5902.38025007368;5660.490555849993;5798.94201057984;5849.122631605123;5879.5002424794375;5881.823545293648;5905.43898329658;5921.615095018982;5946.940530594638;5948.37542058095;5953.374895635896;5602.3837377887585;5852.912206316823;5854.443827836519;5857.648541087548;5865.178874957594 03:48:55 INFO - PROCESS | 12177 | |1;ext.html;588.9411058894111;637.5314144104084;653.1378580274038;679.8334408070024;682.5120039171991;33057.50413743793;33434;41044.38433423497;41144.38283425751;41185.38221926666;43835.342469862895;44351;44456.11087778251;44520.3321950171;44524;8214.301784348338;8892.244159246457;9079.409838360518;9089.727308180765;10309.53607087683;10482.58069677212;10659.253852230348;10667.306625069346;10674.573017079307;10684.19868509861;10604.522796474177;10713.500109984609;10714.089302409304;10721.678349649485;10728.088112510446;8466.32269418448;10531.21015923805;10942.56229750809;11207.047400970927;11216.887831121667;10662.893371066268;10768.407737574431;10790.622328218475;10792.244542882001;10795.406252656101;39700.40449393261;40167.397489037685;40197.19605607871;40227.19545609101;40234;3922.980385098056;3948.1314110895555;3970.642642162219;4076.9592304076878;4098.6516146127615;34598.30803383918;34683.826580867186;34848.47727284093;35954.64045359539;36125.27749445022;4427.402300689398;4437.556244375537;4446.377507149002;4448.199324121657;4683.718976861399;355922;357047;358371;359746;360516;39099.80450097788;39267.41098883519;61655;62012.68993655003;62116.689416553534;37404.62595374011;37438;37776.62223377731;37842.81078594589;37866.62133378686;16447.424340148038;16689.08210048459;16762.49712508602;16788.748168777478;16796.496105116865;13656.24890631005;14696.779548306784;15069.849301507064;15070.773938390932;15082.924585377223;9222.953885230665;9285.767855803524;9292.628294868266;9328.300377471716;9353.064693530592;3545.556805399325;3639;3666.496736338089;3678.5953545110015;3746.9133951154404;1051.164324362134;1097.3525619884147;1112.9387883666313;1120.9943950280197;1182.024829515653;32447.351052978807;32581.345985766013;32968.505472417935;33134.502982455284;33628.663713362555;1175.494537348931;1207.2273744803333;1207.7101495640984;1229.5612837656054;1333.4599487207697;16828.83171168297;16951.745723814154;17444.47666570005;17574.912125439547;17579.912100439415;505044;510439;510543;511156;513788;62550;62644.686776565824;63134.36865631285;63285.68357158277;63338.36661633417;1432.9324653133483;1499.8200215974152;1524.9466268680765;1542.591213328469;1606.349428481467;29804.014940698074;32961.175970599965;33297.33405331928;33555;33569.16077098092;50333.74833125811;61058.694706526185;62107.378926210156;62121.689391552754;62287;416197;420325;424124;424590;424725;41092.794536027126;46717.299240510736;46859.53140468688;47740.7612961933;48061.75969120132;45939;45947;46745.53254467548;47080.529194708986;47706.761466192445;38566.83811020793;39949.80150595487;42292.36561451642;42334.36498452587;42697.57302426936;41299.174016520104;41403.58596413997;42057.78971105247;42497;42853.1429371417;42381;42886.78556607197;42924.78537607292;43839.34240986451;43913;36507.634923650425;36650.8167459161;37536;37958.810205948794;38424;28664.283392915346;28911.132666020054;29052.854735726185;29474.26314342073;29517 03:48:55 INFO - PROCESS | 12177 | |2;jquery.html;414.3349923372986;416.80410207202607;419.77332240590073;430.13972055888223;434.2552522424042;14493.927530362333;18784.906075469622;19330.323438679632;19362.70955935662;20205.59588808223;16215.351385944548;17772.28910843565;18895.43313700588;19539;19626.313079042236;5510.724463776805;5683.687397193153;5685.687287199203;5687.943120568803;5697.572682048843;5703.857403564903;5728.16941543476;5739.713014349287;5745.2818397700285;5751.741171647265;4256;5666.603337766358;6159.538034647397;6412.743490260384;6425.8393540161405;6343.46080583151;6366.77716279928;6367.6497792621385;6400.775972840952;6408.423241908227;5575.721213939328;5820.82537523875;5825.563082768809;5826.417358264182;5826.796062137805;13316.667083322898;13552.932235338858;13904.374303156383;23489.53020939589;23944.521109577887;2423.7212720537186;2423.842450240729;2441.6581678565017;2456.299954512955;2483.217786397297;10661.573537058508;11124.66626001213;13231.875290600214;14146.71706565863;15119.941604087719;1978.6636271833822;2055.7635871874777;2113.5138918048783;2117.7564580073335;2149.957000859974;79646;84184.57907710483;84580.15419845784;84931.15068849294;84971;11076.11391088711;11300.547978080785;11402.315861048364;11698.06415486759;11920.940395297968;16129.516114516584;16208.432704855273;16232.837671623369;16246.75629865553;16252.349906003627;8799.692010779592;9000.729978100668;9055.23030542398;9118.40730352525;9144.359894807432;8753.255973242218;8892.955535222412;8958.552072396355;9002.86495702565;9031.774205644911;4379.58393952574;4657.69724967876;4794.7842347094465;4858.271259311132;4977.1538838397555;1811.8329808685492;1876.6152938647544;1961.1763059515038;1976;1976.416956997689;1012.2458768217725;1079.2337440417234;1083.815751322277;1089.7057794395469;1107.8670559532748;19301.710474342897;19599.90200049019;19657.213711451666;19681.507962301057;19886.128725349074;1066.4454483668449;1086.6685660873352;1087.0868470484832;1093.1145771924766;1121.960731374398;10904.945475272572;11075.556977720962;11140.777184456427;11160.274582152135;11210.495527701272;506434;526547;531131;534929;535140;87808;90331;90923.54538227267;91611;94036;1079.1690398393193;1092.9617463388743;1098.7198264442516;1105.8230683090667;1108.1190453589415;17171.570710732332;17525.824741752418;17567.560810979827;17629.20668569943;17636.38272660451;38958.220835582564;38973;39044.6095539041;39418.40872386859;39717;55365.16952245639;55597.16604250859;56001.71999139978;56450.43549564616;56595;8827.735167944971;8847.558751367991;8913.37606367548;8955.776105597151;9016.90983090187;12399.690007749878;13326.133801302884;13418.865811341762;13456.327183640975;13521.932390337985;11502;11725;11842.46708898119;11945.223560468541;12122.333271670142;11533.826992595286;11623.24448910852;11629.709257268636;11974.880251197377;12156.817647735113;11687.941560292144;11738.647840564796;11825.763484730429;11959.61894496275;12239.938800305941;8754.781130471789;8799.780005499657;8895.73312800617;8995.23540499065;9115.680951166678;10105.89894101079;11343.48954297075;11497.54009839597;11864.58473953442;11986.700332491757 03:48:55 INFO - PROCESS | 12177 | |3;mootools.html;1398.7622104242278;1556.7042261970228;1572.6933248016635;1762.3655484025749;1871.2140900821653;8169.305609023233;8304.211099945504;8337.95831020844;8340.541270230151;8350.958245208772;7941.642626081826;8077.19228077192;8105.189481051892;8113.066997295313;8134.308583770372;2160.3626930055593;2350.3184076617845;2376.3108698477463;2400.711914570254;2404.350825277174;2435.266488160238;2458.2502336787275;2468.4445999650025;2473.084958565333;2474.7648973347505;2423.8424502407374;2454.0551887523343;2458.090506512593;2459.372859920718;2459.7786199242064;2070.596233734422;2358.6226203807396;2413.083028449196;2415.0460568075687;2419.8911049002663;2275.226423016166;2279.931602051941;2281.471414152522;2287.576798292305;2340.3447034830274;8282.668693252263;8339.041010283834;8345.666173353058;8354.624041918067;8361.080281169066;5161.2516185152945;5242.0826355388035;5269.815556455544;5275;5320.707361095138;3511.3679537683206;3585.3367127081574;3626.2928728897878;3646.5988741238443;3721.2557488502407;1205.1323047405854;1207.3963018490754;1216.1669256559285;1258.855231648363;1315.6579289384733;11585.015273701745;11633.825492617618;11648.534058637644;11658.533658653643;11666.533338666442;4464.419625448736;4573.5426457354;4648.5119062498625;4668.486466488684;4705.247160454311;9889.653862114792;9896.158826499684;9910.603575857029;9922;9926.404415734934;4780.378550788445;5302.257683924254;5306.681599104066;5310;5312.707801070978;4684.95315046852;4753.762311884392;4779.091972525209;4792.353032340659;4854.17479028566;4099.282625540519;4110.588941105865;4190.53904070552;4302.161078589707;4309.439772829513;1303.6349822049842;1307.607717684691;1308.4373719300602;1312.252016350671;1318.5846458365584;824.7814329202766;842.1704620948361;927.1655510041018;945.583943065063;1007.2948935744861;5479.205515200274;5485;5499.312585926759;5551.557314781483;5644.153376993484;902.8194361127669;927.9118483744169;959.4387283439266;981.4847205217176;1005.2410430125209;3671.155634204148;3749.1564398010228;3776.055986003499;3778.6032466591164;3812.752171108869;9817.312788104764;10182.898171018343;10210.591576336863;10219.284650074573;10227.795444091225;9830.4101753895;10039.247056470647;10063.245256605784;10082;10230.693079207636;8023.277904988462;8024.358051355877;8080.0707918590115;8189.426740128253;8211.671533138728;5301.443348448357;5311.707856067954;5357.571394288369;5365.678059316453;5434.782608695766;9307.813843723223;9389.671361502315;9477.478738669439;9489.762755931157;9533.47565883883;9035.819283614423;9178.770530736785;9212;9212.078792120734;9601.807963840545;6889.793306200822;7038.014677945194;7040.859182816417;7512.173660897188;7595.506292090997;7518.060242469692;7770.300672939463;7919.841603167789;7953.16491768356;7970.163132871197;6717.9328206719265;7004.0544526488275;7041.507094503336;7293.854122917406;7367.189609142883;7245;7261.636918154177;7275.890861636974;7347.779566612797;7363.668634911334;6567.934320656924;6676.232233293234;6678.532502724763;6686.598804071771;6688.3646053624825;4845.903081938271;4944.554990050912;4961.652684312208;4985.302057711996;4996.400431948189;4907.631927605373;4933.432655244549;4964.900701986012;4966.155753521838;4993.950060499494 03:48:55 INFO - PROCESS | 12177 | |4;prototype.html;361.9583747868995;362.69352397224344;362.9074585980575;370.3038288018525;372.94592284118784;6356.364363563642;6393.616383017023;6408.327125651809;6408.455281301083;6413.615183089012;6266.122742816009;6341.52438567107;6355.205599300088;6361.55469117162;6363;4648.674592778515;4769.356136921506;4853.150698627744;4874.2444921037295;4888.657793954425;4842.9515704843025;4869.074875773609;4878.219484882419;4906.656534042619;4919.2621106834085;4635.768211589424;4879.243717223836;4881.707097574139;4882.6093912487095;4884.438289596688;4756.833510827122;4855.708657480527;4872.098661747588;4875.512448755132;4881.341018962448;4273.423087883127;4282.164977829325;4288;4298.31227003681;4304.7632380219075;6075.848103797441;6080.270367555921;6086.300075491331;6091.482224010964;6097.847553811191;5651.7739290428335;5654.74553645087;5663.546916246732;5665.206871038058;5665.971670141664;6428.839279018062;6675.232348279913;6684.431823295025;6688.498362622774;6696.43080338167;4586.3579098926175;4588.426446694163;4610.76946152691;4613.6078433333205;4617.376654151713;6936.410405115521;7028.54314469563;7034.613096279702;7035.6482175891515;7038.894416583807;4755.976220118877;4759.904801903943;4764.094821983812;4765.523447655207;4769.976150119227;4815.446223684321;4822.565969062801;4824.541668541483;4828.251620998751;4830.033993201374;5575.414581468968;5586.190002449622;5596.188552659842;5597.916031259534;5603.10350343943;6545.280019197884;6775.966120169466;6778.593284402951;6783.491238157059;6796.048553202556;1658.4361317152227;1678.8069372022373;1684.5030715938829;1685.0311071133901;1687.64559442516;1033.2715435617872;1093.868735751715;1100.6808025672465;1111.360967443723;1115.983260251097;6387.616742995435;6399.104125422445;6479.8056058318325;6489.318621544669;6494.675266236669;6865.107536020286;6874.828129296708;6878.69045892936;6883;6887.793366199022;6467.027556595283;6471.708773105222;6478.870422591616;6480.740770369227;6484.059811327425;3684.428913518409;3706.09200745819;3718.9070273242846;3721.4603882436895;3724.217914237986;7067.22260551339;7335.046443962251;7356.043714317211;7358.374538164316;7366.631668416558;7125.75059872902;7144.9285507145305;7155.105611798525;7162.247963963709;7162.4270058395205;7286.453515986216;7294.343509084102;7300.525465844703;7301.926980730231;7321.377682897013;6857.622830744357;6996.300369962963;7013.929860701328;7014.298570143149;7026.367626913602;6864.176298844171;6887.690053947485;6898.06876071744;6911.308869113049;6924.065251191025;7249.855002900018;7271.781846544613;7281.708731650887;7297.1973082961895;7304.160021597372;4732.148213321635;4763.095011947719;4772.355731976278;4781.354517140142;4784.282357646381;6959.8956015660815;6981.441484681111;6981.930180698128;6992.265812089658;6996.510244282851;6660.866782664417;6831.351021652935;6838.623875686885;6844.486663500357;6846.110005699426;6748;6780.762673306608;6782.016607591971;6783.559068660521;6787.5588086774205;6639.568428052161;6675.4325882300545;6678.165229346332;6681.365270299314;6686.665666716742;6704.06143139951;6773.762918297836;6845.691943862438;6858.108445902001;6859.485538584527;6423.614583125028;6572.277049524644;6665.533412661067;6716.429103526255;6758.662066896733 03:48:55 INFO - PROCESS | 12177 | |5;yui.html;813.5322189740897;876.5485774825962;920.6455514626869;927.8283517549254;952.8237276103916;15226.314815833286;17134.82865171348;17437.128143592832;17491.037992910402;17517.124143792822;15542;15594.142322172276;15595.766063509056;15602.921985390058;15699.921500392482;765.2844590308052;896.5472436419615;903.5301643145593;907.5280853955938;923.6213152607432;916.7066538707617;916.8258030974127;917.5824999625188;924.852023676212;924.9213816825578;957.7701351675582;959.1894848852743;960.0255740423476;961.024560071528;961.7643677299071;791.7862177212178;801.2708435323827;940.3652534539159;958.4536814016013;960.1934375124858;704.4822055788991;705.3052743048094;705.8835292176836;705.9752908648172;706.0221593093551;13858.16850988944;13985.230812305319;14004;14045.508407205802;14106.506272280421;13857.37641806111;14223.359948802328;14274.286285685674;14336.139831610137;14354.497592584314;12136.271823690608;12535.31055791931;12612.68468288291;12680.61958141248;12742.617721468278;4006.098627808749;4023.4568333274924;4056.918861622751;4082.040720430696;4105.220008198433;59066.40933590652;59084.70457647727;59740.70129649324;59881.700591497196;60229;11499.942500287445;11671.59149429766;11674.824877626843;11696.532138714527;12077.248798924282;20381.184752610025;20540.691889621667;20544.691829622567;20604.896975515025;20610.79389206119;8986.55067246635;8998.10018998108;9116.270698344117;9248.451643639792;9313.115254050854;5041.899162016739;5082.059818933509;5101.285819985205;5144.048351055067;5206.635535512478;3345.7156141728224;3426.588809342895;3427;3440.518327434111;3449.6205417404067;638.0970926139553;643.8486955565438;664.9833754156185;676.2865177237962;703.5919166883298;652.5725649699455;681.4786688183543;751.8082888863305;778.7313376884965;779.8206412525037;9462.101100395452;9557.617695292249;9588.328816982745;9604.66383676568;9606;636.2651137935692;696.8257935516122;707.1090426063197;814.3566582399837;825.8265764189588;4394.2969124939855;4520.81916723334;4569.405977222939;4575;4653.7207767534055;71046;72224.63887680529;72345.27654723385;72406;72414.27585724181;59967.40032599618;62462;62641;62750.37249627537;63386;53596.464035359924;54351.45648543543;55122.44877551173;55256;56341;9136.360454768102;9197;9213.170814626716;9315.254779617479;9383.436993780122;36846.815765921;40216;41362.172756545304;41531.792341038104;42254.78872605618;51214.48785512097;51541.226881597555;52244.47755522396;52312.738436307576;52862.47137528729;12899.677508062374;13134.737305254033;13475.932620337227;13517.662058448617;13802.102863313852;14061.507847225297;14171.220582868042;14316.355763990854;14360.712785744436;14881.925590372412;12859;13229.140105893086;13724.313784310545;13808.240546770025;13902.791458128338;12601.18092323996;12925.224486530838;13209;13398.196108233537;13515;13345.022015899558;13541.187528748307;13634.522791702242;13997.580072597839;14436.783448248074;11847.585334513251;11850.407479626158;11876.465559049691;12023.398830058637;12197.329146897006;11838.230515016496;11845.763084738084;12084.939575302067;12101.152919295564;12102.455389507317 03:48:55 INFO - PROCESS | 12177 | __end_tp_report 03:48:55 INFO - PROCESS | 12177 | __start_cc_report 03:48:55 INFO - PROCESS | 12177 | _x_x_mozilla_cycle_collect,809 03:48:55 INFO - PROCESS | 12177 | __end_cc_report 03:48:55 INFO - PROCESS | 12177 | __startTimestamp1462790935198__endTimestamp 03:48:55 INFO - PROCESS | 12177 | 03:48:55 INFO - PROCESS | 12177 | ------- Summary: start ------- 03:48:55 INFO - PROCESS | 12177 | Number of tests: 6 03:48:55 INFO - PROCESS | 12177 | 03:48:55 INFO - PROCESS | 12177 | [#0] dojo.html Cycles:165 Average:5578.15 Median:5852.91 stddev:615.22 (10.5%) stddev-sans-first:591.30 03:48:55 INFO - PROCESS | 12177 | Values: 3330.8 3390.2 3402.8 3404.8 3420.2 5557.1 5559.7 5576.1 5584.5 5587.2 5562.2 5568.4 5588.9 5589.8 5638.3 5030.4 5031.6 5094.9 5143.2 5209.6 5042.2 5090.1 5108.0 5134.9 5143.1 5171.7 5201.9 5223.3 5234.3 5243.6 5133.1 5148.2 5181.1 5183.6 5231.4 4966.7 5013.1 5079.3 5087.0 5096.8 5453.9 5458.0 5465.7 5467.9 5499.3 5869.5 5890.9 5909.8 5936.1 5936.8 5825.9 5899.4 5936.5 5972.6 5979.0 5591.7 5618.8 5629.8 5639.9 5640.3 5976.9 6107.7 6128.8 6133.3 6135.6 5910.7 5984.1 6001.1 6003.2 6004.2 5936.5 5954.9 5976.8 5977.6 6010.5 5943.2 5945.9 5946.4 5961.3 5964.3 5760.2 5971.4 5999.5 6077.3 6079.5 4555.9 4577.7 4580.5 4582.9 4608.3 4020.5 4097.3 4122.0 4123.7 4137.2 5643.5 5655.6 5676.9 5694.5 5721.4 6012.8 6026.7 6040.2 6056.0 6066.1 5572.9 5610.4 5743.3 5744.6 5745.3 5108.3 5108.6 5115.1 5137.0 5147.0 6139.6 6142.3 6144.3 6149.1 6159.7 5919.8 5966.1 5987.3 5989.3 6071.1 6239.9 6262.8 6275.1 6277.8 6282.9 5843.9 5967.6 5969.3 5973.7 6004.4 5907.1 6023.1 6039.2 6111.8 6111.9 5908.0 5932.2 5937.1 5938.2 5942.8 5873.7 5894.7 5898.3 5900.4 5902.4 5660.5 5798.9 5849.1 5879.5 5881.8 5905.4 5921.6 5946.9 5948.4 5953.4 5602.4 5852.9 5854.4 5857.6 5865.2 03:48:55 INFO - PROCESS | 12177 | 03:48:55 INFO - PROCESS | 12177 | [#1] ext.html Cycles:180 Average:59412.40 Median:38191.41 stddev:114990.85 (301.1%) stddev-sans-first:115228.62 03:48:55 INFO - PROCESS | 12177 | Values: 588.9 637.5 653.1 679.8 682.5 33057.5 33434.0 41044.4 41144.4 41185.4 43835.3 44351.0 44456.1 44520.3 44524.0 8214.3 8892.2 9079.4 9089.7 10309.5 10482.6 10659.3 10667.3 10674.6 10684.2 10604.5 10713.5 10714.1 10721.7 10728.1 8466.3 10531.2 10942.6 11207.0 11216.9 10662.9 10768.4 10790.6 10792.2 10795.4 39700.4 40167.4 40197.2 40227.2 40234.0 3923.0 3948.1 3970.6 4077.0 4098.7 34598.3 34683.8 34848.5 35954.6 36125.3 4427.4 4437.6 4446.4 4448.2 4683.7 355922.0 357047.0 358371.0 359746.0 360516.0 39099.8 39267.4 61655.0 62012.7 62116.7 37404.6 37438.0 37776.6 37842.8 37866.6 16447.4 16689.1 16762.5 16788.7 16796.5 13656.2 14696.8 15069.8 15070.8 15082.9 9223.0 9285.8 9292.6 9328.3 9353.1 3545.6 3639.0 3666.5 3678.6 3746.9 1051.2 1097.4 1112.9 1121.0 1182.0 32447.4 32581.3 32968.5 33134.5 33628.7 1175.5 1207.2 1207.7 1229.6 1333.5 16828.8 16951.7 17444.5 17574.9 17579.9 505044.0 510439.0 510543.0 511156.0 513788.0 62550.0 62644.7 63134.4 63285.7 63338.4 1432.9 1499.8 1524.9 1542.6 1606.3 29804.0 32961.2 33297.3 33555.0 33569.2 50333.7 61058.7 62107.4 62121.7 62287.0 416197.0 420325.0 424124.0 424590.0 424725.0 41092.8 46717.3 46859.5 47740.8 48061.8 45939.0 45947.0 46745.5 47080.5 47706.8 38566.8 39949.8 42292.4 42334.4 42697.6 41299.2 41403.6 42057.8 42497.0 42853.1 42381.0 42886.8 42924.8 43839.3 43913.0 36507.6 36650.8 37536.0 37958.8 38424.0 28664.3 28911.1 29052.9 29474.3 29517.0 03:48:55 INFO - PROCESS | 12177 | 03:48:55 INFO - PROCESS | 12177 | [#2] jquery.html Cycles:180 Average:29999.60 Median:2115.64 stddev:86663.86 (4096.4%) stddev-sans-first:86878.50 03:48:55 INFO - PROCESS | 12177 | Values: 414.3 416.8 419.8 430.1 434.3 14493.9 18784.9 19330.3 19362.7 20205.6 16215.4 17772.3 18895.4 19539.0 19626.3 5510.7 5683.7 5685.7 5687.9 5697.6 5703.9 5728.2 5739.7 5745.3 5751.7 4256.0 5666.6 6159.5 6412.7 6425.8 6343.5 6366.8 6367.6 6400.8 6408.4 5575.7 5820.8 5825.6 5826.4 5826.8 13316.7 13552.9 13904.4 23489.5 23944.5 2423.7 2423.8 2441.7 2456.3 2483.2 10661.6 11124.7 13231.9 14146.7 15119.9 1978.7 2055.8 2113.5 2117.8 2150.0 79646.0 84184.6 84580.2 84931.2 84971.0 11076.1 11300.5 11402.3 11698.1 11920.9 16129.5 16208.4 16232.8 16246.8 16252.3 8799.7 9000.7 9055.2 9118.4 9144.4 8753.3 8893.0 8958.6 9002.9 9031.8 4379.6 4657.7 4794.8 4858.3 4977.2 1811.8 1876.6 1961.2 1976.0 1976.4 1012.2 1079.2 1083.8 1089.7 1107.9 19301.7 19599.9 19657.2 19681.5 19886.1 1066.4 1086.7 1087.1 1093.1 1122.0 10904.9 11075.6 11140.8 11160.3 11210.5 506434.0 526547.0 531131.0 534929.0 535140.0 87808.0 90331.0 90923.5 91611.0 94036.0 1079.2 1093.0 1098.7 1105.8 1108.1 17171.6 17525.8 17567.6 17629.2 17636.4 38958.2 38973.0 39044.6 39418.4 39717.0 55365.2 55597.2 56001.7 56450.4 56595.0 8827.7 8847.6 8913.4 8955.8 9016.9 12399.7 13326.1 13418.9 13456.3 13521.9 11502.0 11725.0 11842.5 11945.2 12122.3 11533.8 11623.2 11629.7 11974.9 12156.8 11687.9 11738.6 11825.8 11959.6 12239.9 8754.8 8799.8 8895.7 8995.2 9115.7 10105.9 11343.5 11497.5 11864.6 11986.7 03:48:55 INFO - PROCESS | 12177 | 03:48:55 INFO - PROCESS | 12177 | [#3] mootools.html Cycles:180 Average:5540.30 Median:5078.83 stddev:3015.33 (59.4%) stddev-sans-first:3007.72 03:48:55 INFO - PROCESS | 12177 | Values: 1398.8 1556.7 1572.7 1762.4 1871.2 8169.3 8304.2 8338.0 8340.5 8351.0 7941.6 8077.2 8105.2 8113.1 8134.3 2160.4 2350.3 2376.3 2400.7 2404.4 2435.3 2458.3 2468.4 2473.1 2474.8 2423.8 2454.1 2458.1 2459.4 2459.8 2070.6 2358.6 2413.1 2415.0 2419.9 2275.2 2279.9 2281.5 2287.6 2340.3 8282.7 8339.0 8345.7 8354.6 8361.1 5161.3 5242.1 5269.8 5275.0 5320.7 3511.4 3585.3 3626.3 3646.6 3721.3 1205.1 1207.4 1216.2 1258.9 1315.7 11585.0 11633.8 11648.5 11658.5 11666.5 4464.4 4573.5 4648.5 4668.5 4705.2 9889.7 9896.2 9910.6 9922.0 9926.4 4780.4 5302.3 5306.7 5310.0 5312.7 4685.0 4753.8 4779.1 4792.4 4854.2 4099.3 4110.6 4190.5 4302.2 4309.4 1303.6 1307.6 1308.4 1312.3 1318.6 824.8 842.2 927.2 945.6 1007.3 5479.2 5485.0 5499.3 5551.6 5644.2 902.8 927.9 959.4 981.5 1005.2 3671.2 3749.2 3776.1 3778.6 3812.8 9817.3 10182.9 10210.6 10219.3 10227.8 9830.4 10039.2 10063.2 10082.0 10230.7 8023.3 8024.4 8080.1 8189.4 8211.7 5301.4 5311.7 5357.6 5365.7 5434.8 9307.8 9389.7 9477.5 9489.8 9533.5 9035.8 9178.8 9212.0 9212.1 9601.8 6889.8 7038.0 7040.9 7512.2 7595.5 7518.1 7770.3 7919.8 7953.2 7970.2 6717.9 7004.1 7041.5 7293.9 7367.2 7245.0 7261.6 7275.9 7347.8 7363.7 6567.9 6676.2 6678.5 6686.6 6688.4 4845.9 4944.6 4961.7 4985.3 4996.4 4907.6 4933.4 4964.9 4966.2 4994.0 03:48:55 INFO - PROCESS | 12177 | 03:48:55 INFO - PROCESS | 12177 | [#4] prototype.html Cycles:180 Average:5647.35 Median:6411.04 stddev:1717.37 (26.8%) stddev-sans-first:1675.74 03:48:55 INFO - PROCESS | 12177 | Values: 362.0 362.7 362.9 370.3 372.9 6356.4 6393.6 6408.3 6408.5 6413.6 6266.1 6341.5 6355.2 6361.6 6363.0 4648.7 4769.4 4853.2 4874.2 4888.7 4843.0 4869.1 4878.2 4906.7 4919.3 4635.8 4879.2 4881.7 4882.6 4884.4 4756.8 4855.7 4872.1 4875.5 4881.3 4273.4 4282.2 4288.0 4298.3 4304.8 6075.8 6080.3 6086.3 6091.5 6097.8 5651.8 5654.7 5663.5 5665.2 5666.0 6428.8 6675.2 6684.4 6688.5 6696.4 4586.4 4588.4 4610.8 4613.6 4617.4 6936.4 7028.5 7034.6 7035.6 7038.9 4756.0 4759.9 4764.1 4765.5 4770.0 4815.4 4822.6 4824.5 4828.3 4830.0 5575.4 5586.2 5596.2 5597.9 5603.1 6545.3 6776.0 6778.6 6783.5 6796.0 1658.4 1678.8 1684.5 1685.0 1687.6 1033.3 1093.9 1100.7 1111.4 1116.0 6387.6 6399.1 6479.8 6489.3 6494.7 6865.1 6874.8 6878.7 6883.0 6887.8 6467.0 6471.7 6478.9 6480.7 6484.1 3684.4 3706.1 3718.9 3721.5 3724.2 7067.2 7335.0 7356.0 7358.4 7366.6 7125.8 7144.9 7155.1 7162.2 7162.4 7286.5 7294.3 7300.5 7301.9 7321.4 6857.6 6996.3 7013.9 7014.3 7026.4 6864.2 6887.7 6898.1 6911.3 6924.1 7249.9 7271.8 7281.7 7297.2 7304.2 4732.1 4763.1 4772.4 4781.4 4784.3 6959.9 6981.4 6981.9 6992.3 6996.5 6660.9 6831.4 6838.6 6844.5 6846.1 6748.0 6780.8 6782.0 6783.6 6787.6 6639.6 6675.4 6678.2 6681.4 6686.7 6704.1 6773.8 6845.7 6858.1 6859.5 6423.6 6572.3 6665.5 6716.4 6758.7 03:48:55 INFO - PROCESS | 12177 | 03:48:55 INFO - PROCESS | 12177 | [#5] yui.html Cycles:180 Average:16430.06 Median:5061.98 stddev:19402.90 (383.3%) stddev-sans-first:19421.89 03:48:55 INFO - PROCESS | 12177 | Values: 813.5 876.5 920.6 927.8 952.8 15226.3 17134.8 17437.1 17491.0 17517.1 15542.0 15594.1 15595.8 15602.9 15699.9 765.3 896.5 903.5 907.5 923.6 916.7 916.8 917.6 924.9 924.9 957.8 959.2 960.0 961.0 961.8 791.8 801.3 940.4 958.5 960.2 704.5 705.3 705.9 706.0 706.0 13858.2 13985.2 14004.0 14045.5 14106.5 13857.4 14223.4 14274.3 14336.1 14354.5 12136.3 12535.3 12612.7 12680.6 12742.6 4006.1 4023.5 4056.9 4082.0 4105.2 59066.4 59084.7 59740.7 59881.7 60229.0 11499.9 11671.6 11674.8 11696.5 12077.2 20381.2 20540.7 20544.7 20604.9 20610.8 8986.6 8998.1 9116.3 9248.5 9313.1 5041.9 5082.1 5101.3 5144.0 5206.6 3345.7 3426.6 3427.0 3440.5 3449.6 638.1 643.8 665.0 676.3 703.6 652.6 681.5 751.8 778.7 779.8 9462.1 9557.6 9588.3 9604.7 9606.0 636.3 696.8 707.1 814.4 825.8 4394.3 4520.8 4569.4 4575.0 4653.7 71046.0 72224.6 72345.3 72406.0 72414.3 59967.4 62462.0 62641.0 62750.4 63386.0 53596.5 54351.5 55122.4 55256.0 56341.0 9136.4 9197.0 9213.2 9315.3 9383.4 36846.8 40216.0 41362.2 41531.8 42254.8 51214.5 51541.2 52244.5 52312.7 52862.5 12899.7 13134.7 13475.9 13517.7 13802.1 14061.5 14171.2 14316.4 14360.7 14881.9 12859.0 13229.1 13724.3 13808.2 13902.8 12601.2 12925.2 13209.0 13398.2 13515.0 13345.0 13541.2 13634.5 13997.6 14436.8 11847.6 11850.4 11876.5 12023.4 12197.3 11838.2 11845.8 12084.9 12101.2 12102.5 03:48:55 INFO - PROCESS | 12177 | -------- Summary: end -------- 03:48:55 INFO - PROCESS | 12177 | 03:48:55 INFO - TEST-INFO | 12177: exit 0 03:48:55 INFO - TEST-OK | dromaeo_css | took 1112027ms 03:48:55 INFO - TEST-START | kraken 03:48:55 INFO - operating with platform_type : linux_ 03:48:55 INFO - Initialising browser for kraken test... 03:48:55 INFO - TEST-INFO | started process 12371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUdMGex/profile http://localhost:52222/getInfo.html) 03:48:59 INFO - PROCESS | 12371 | __metrics Screen width/height:1600/1200 03:48:59 INFO - PROCESS | 12371 | colorDepth:24 03:48:59 INFO - PROCESS | 12371 | Browser inner width/height: 1024/697 03:48:59 INFO - PROCESS | 12371 | __metrics 03:49:00 ERROR - PROCESS | 12371 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:49:01 INFO - TEST-INFO | 12371: exit 0 03:49:01 INFO - Browser initialized. 03:49:01 INFO - Running cycle 1/1 for kraken test... 03:49:01 INFO - TEST-INFO | started process 12459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUdMGex/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:13 INFO - PROCESS | 12459 | RSS: Main: 142028800 03:49:13 INFO - PROCESS | 12459 | 03:49:16 INFO - PROCESS | 12459 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-beat-detection) 03:49:16 INFO - PROCESS | 12459 | RSS: Main: 197201920 03:49:16 INFO - PROCESS | 12459 | 03:49:19 INFO - PROCESS | 12459 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-dft) 03:49:20 INFO - PROCESS | 12459 | RSS: Main: 182231040 03:49:20 INFO - PROCESS | 12459 | 03:49:22 INFO - PROCESS | 12459 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-fft) 03:49:23 INFO - PROCESS | 12459 | RSS: Main: 272625664 03:49:23 INFO - PROCESS | 12459 | 03:49:25 INFO - PROCESS | 12459 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-oscillator) 03:49:26 INFO - PROCESS | 12459 | RSS: Main: 179134464 03:49:26 INFO - PROCESS | 12459 | 03:49:28 INFO - PROCESS | 12459 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52222/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:49:28 INFO - PROCESS | 12459 | RSS: Main: 177336320 03:49:28 INFO - PROCESS | 12459 | 03:49:31 INFO - PROCESS | 12459 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52222/tests/kraken/driver.html?testName=imaging-darkroom) 03:49:32 INFO - PROCESS | 12459 | RSS: Main: 211972096 03:49:32 INFO - PROCESS | 12459 | 03:49:35 INFO - PROCESS | 12459 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52222/tests/kraken/driver.html?testName=imaging-desaturate) 03:49:36 INFO - PROCESS | 12459 | RSS: Main: 211906560 03:49:36 INFO - PROCESS | 12459 | 03:49:39 INFO - PROCESS | 12459 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52222/tests/kraken/driver.html?testName=json-parse-financial) 03:49:39 INFO - PROCESS | 12459 | RSS: Main: 212484096 03:49:39 INFO - PROCESS | 12459 | 03:49:41 INFO - PROCESS | 12459 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52222/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:49:41 INFO - PROCESS | 12459 | RSS: Main: 192413696 03:49:41 INFO - PROCESS | 12459 | 03:49:43 INFO - PROCESS | 12459 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:49:44 INFO - PROCESS | 12459 | RSS: Main: 195047424 03:49:44 INFO - PROCESS | 12459 | 03:49:46 INFO - PROCESS | 12459 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:49:46 INFO - PROCESS | 12459 | RSS: Main: 211206144 03:49:46 INFO - PROCESS | 12459 | 03:49:49 INFO - PROCESS | 12459 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:49:49 INFO - PROCESS | 12459 | RSS: Main: 212062208 03:49:49 INFO - PROCESS | 12459 | 03:49:52 INFO - PROCESS | 12459 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:53 INFO - PROCESS | 12459 | RSS: Main: 208519168 03:49:53 INFO - PROCESS | 12459 | 03:49:54 INFO - PROCESS | 12459 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52222/tests/kraken/driver.html?testName=ai-astar) 03:49:55 INFO - PROCESS | 12459 | RSS: Main: 272179200 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | __start_tp_report 03:49:55 INFO - PROCESS | 12459 | _x_x_mozilla_page_load 03:49:55 INFO - PROCESS | 12459 | _x_x_mozilla_page_load_details 03:49:55 INFO - PROCESS | 12459 | |i|pagename|runs| 03:49:55 INFO - PROCESS | 12459 | |0;ai-astar;111;111;110;111;110;111;106;110;110;109 03:49:55 INFO - PROCESS | 12459 | |1;audio-beat-detection;155;131;158;181;128;165;159;134;193;127 03:49:55 INFO - PROCESS | 12459 | |2;audio-dft;160;160;160;159;161;159;161;160;161;161 03:49:55 INFO - PROCESS | 12459 | |3;audio-fft;76;73;75;185;76;76;75;74;169;76 03:49:55 INFO - PROCESS | 12459 | |4;audio-oscillator;93;93;158;91;92;93;150;91;93;147 03:49:55 INFO - PROCESS | 12459 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;117;116 03:49:55 INFO - PROCESS | 12459 | |6;imaging-darkroom;145;145;145;145;146;146;146;146;145;145 03:49:55 INFO - PROCESS | 12459 | |7;imaging-desaturate;95;94;95;94;94;94;94;94;95;94 03:49:55 INFO - PROCESS | 12459 | |8;json-parse-financial;52;55;54;53;54;54;54;78;52;53 03:49:55 INFO - PROCESS | 12459 | |9;json-stringify-tinderbox;57;58;56;57;56;56;57;57;57;58 03:49:55 INFO - PROCESS | 12459 | |10;stanford-crypto-aes;73;71;72;73;73;74;73;75;73;72 03:49:55 INFO - PROCESS | 12459 | |11;stanford-crypto-ccm;114;117;111;112;114;115;122;110;125;111 03:49:55 INFO - PROCESS | 12459 | |12;stanford-crypto-pbkdf2;162;164;168;161;160;164;158;166;159;159 03:49:55 INFO - PROCESS | 12459 | |13;stanford-crypto-sha256-iterative;67;69;68;69;67;67;66;67;67;71 03:49:55 INFO - PROCESS | 12459 | __end_tp_report 03:49:55 INFO - PROCESS | 12459 | __start_cc_report 03:49:55 INFO - PROCESS | 12459 | _x_x_mozilla_cycle_collect,1587 03:49:55 INFO - PROCESS | 12459 | __end_cc_report 03:49:55 INFO - PROCESS | 12459 | __startTimestamp1462790995102__endTimestamp 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | ------- Summary: start ------- 03:49:55 INFO - PROCESS | 12459 | Number of tests: 14 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:1.52 (1.4%) stddev-sans-first:1.56 03:49:55 INFO - PROCESS | 12459 | Values: 111.0 111.0 110.0 111.0 110.0 111.0 106.0 110.0 110.0 109.0 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:158.50 stddev:22.95 (14.5%) stddev-sans-first:24.33 03:49:55 INFO - PROCESS | 12459 | Values: 155.0 131.0 158.0 181.0 128.0 165.0 159.0 134.0 193.0 127.0 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 03:49:55 INFO - PROCESS | 12459 | Values: 160.0 160.0 160.0 159.0 161.0 159.0 161.0 160.0 161.0 161.0 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | [#3] audio-fft Cycles:10 Average:95.50 Median:75.50 stddev:43.13 (57.1%) stddev-sans-first:45.17 03:49:55 INFO - PROCESS | 12459 | Values: 76.0 73.0 75.0 185.0 76.0 76.0 75.0 74.0 169.0 76.0 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:92.50 stddev:28.82 (31.2%) stddev-sans-first:29.90 03:49:55 INFO - PROCESS | 12459 | Values: 93.0 93.0 158.0 91.0 92.0 93.0 150.0 91.0 93.0 147.0 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:49:55 INFO - PROCESS | 12459 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:49:55 INFO - PROCESS | 12459 | Values: 145.0 145.0 145.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 03:49:55 INFO - PROCESS | 12459 | Values: 95.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:54.00 stddev:7.82 (14.5%) stddev-sans-first:8.17 03:49:55 INFO - PROCESS | 12459 | Values: 52.0 55.0 54.0 53.0 54.0 54.0 54.0 78.0 52.0 53.0 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 03:49:55 INFO - PROCESS | 12459 | Values: 57.0 58.0 56.0 57.0 56.0 56.0 57.0 57.0 57.0 58.0 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:1.10 (1.5%) stddev-sans-first:1.17 03:49:55 INFO - PROCESS | 12459 | Values: 73.0 71.0 72.0 73.0 73.0 74.0 73.0 75.0 73.0 72.0 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | [#11] stanford-crypto-ccm Cycles:10 Average:115.10 Median:114.50 stddev:4.95 (4.3%) stddev-sans-first:5.24 03:49:55 INFO - PROCESS | 12459 | Values: 114.0 117.0 111.0 112.0 114.0 115.0 122.0 110.0 125.0 111.0 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:163.00 stddev:3.31 (2.0%) stddev-sans-first:3.52 03:49:55 INFO - PROCESS | 12459 | Values: 162.0 164.0 168.0 161.0 160.0 164.0 158.0 166.0 159.0 159.0 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - PROCESS | 12459 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:1.48 (2.2%) stddev-sans-first:1.54 03:49:55 INFO - PROCESS | 12459 | Values: 67.0 69.0 68.0 69.0 67.0 67.0 66.0 67.0 67.0 71.0 03:49:55 INFO - PROCESS | 12459 | -------- Summary: end -------- 03:49:55 INFO - PROCESS | 12459 | 03:49:55 INFO - TEST-INFO | 12459: exit 0 03:49:56 INFO - TEST-OK | kraken | took 60174ms 03:49:56 INFO - SUITE-END | took 1172s 03:49:56 INFO - Completed test suite (00:19:32) 03:49:56 INFO - javascript benchmark 03:49:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3330.766846320758, 3390.169408494919, 3402.7958322500654, 3404.8467818948143, 3420.17915700232, 5557.083081291582, 5559.722013899304, 5576.135698966662, 5584.497395234438, 5587.2177895094665, 5562.249096371998, 5568.443155684429, 5588.86027849303, 5589.804356847511, 5638.267025286717, 5030.396352437712, 5031.572316353096, 5094.872628184297, 5143.15138002231, 5209.635325527214, 5042.193249080148, 5090.109230884599, 5108.0, 5134.8716282093055, 5143.12566863634, 5171.7414129293575, 5201.921971170435, 5223.347081614798, 5234.26720259164, 5243.606729495303, 5133.050385678662, 5148.150555158413, 5181.093308670967, 5183.637145399824, 5231.372235331746, 4966.652334336598, 5013.097642424362, 5079.314292570492, 5086.974565127188, 5096.821611243626, 5453.863653408696, 5457.972710136424, 5465.72671366434, 5467.9453205467835, 5499.257600223998, 5869.530437564985, 5890.911636325459, 5909.793157239476, 5936.109583562457, 5936.821895343147, 5825.854353641151, 5899.410058994109, 5936.525077993793, 5972.58191926561, 5978.97010514949, 5591.720413979285, 5618.775248990036, 5629.802956896489, 5639.859003524863, 5640.2667653205235, 5976.8804623908145, 6107.694615269219, 6128.78549250783, 6133.26400831903, 6135.631862088289, 5910.70446477683, 5984.102384642251, 6001.12983617373, 6003.219581454383, 6004.189434426296, 5936.495397891227, 5954.880902382015, 5976.7908123215475, 5977.641341519523, 6010.489108425745, 5943.227380440515, 5945.940540594625, 5946.375630558816, 5961.344252132262, 5964.284285885721, 5760.193572899798, 5971.4327138921735, 5999.520038397005, 6077.3314935357075, 6079.483243924316, 4555.863324100283, 4577.702449340783, 4580.496145424001, 4582.862514124582, 4608.28571571407, 4020.4572382728543, 4097.303458412077, 4121.979390103031, 4123.731957422758, 4137.213929353413, 5643.463870932255, 5655.604107712421, 5676.858078548069, 5694.544436445074, 5721.427857214246, 6012.759489620454, 6026.728797204137, 6040.154378387029, 6056.0, 6066.059760737093, 5572.888542229132, 5610.382857885629, 5743.310802703702, 5744.626599271034, 5745.253117094751, 5108.335916330853, 5108.56577190943, 5115.053715062651, 5137.049645815536, 5146.974265128651, 6139.631622102688, 6142.293636231801, 6144.324124346318, 6149.077638354193, 6159.692015399301, 5919.822405327847, 5966.075258334965, 5987.311459182076, 5989.341172471025, 6071.119687645355, 6239.937600623935, 6262.780802671885, 6275.058741188858, 6277.843053923689, 6282.905756413566, 5843.926465832619, 5967.6121052131475, 5969.343372229138, 5973.695375477267, 6004.39956004396, 5907.084401917709, 6023.096535519707, 6039.214902062704, 6111.84720381994, 6111.877762444815, 5908.0, 5932.199153114274, 5937.079752638348, 5938.2280303560265, 5942.821715348547, 5873.676947767914, 5894.734736936763, 5898.3216930053595, 5900.43945825146, 5902.38025007368, 5660.490555849993, 5798.94201057984, 5849.122631605123, 5879.5002424794375, 5881.823545293648, 5905.43898329658, 5921.615095018982, 5946.940530594638, 5948.37542058095, 5953.374895635896, 5602.3837377887585, 5852.912206316823, 5854.443827836519, 5857.648541087548, 5865.178874957594], "value": 5538.457878150888, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.9411058894111, 637.5314144104084, 653.1378580274038, 679.8334408070024, 682.5120039171991, 33057.50413743793, 33434.0, 41044.38433423497, 41144.38283425751, 41185.38221926666, 43835.342469862895, 44351.0, 44456.11087778251, 44520.3321950171, 44524.0, 8214.301784348338, 8892.244159246457, 9079.409838360518, 9089.727308180765, 10309.53607087683, 10482.58069677212, 10659.253852230348, 10667.306625069346, 10674.573017079307, 10684.19868509861, 10604.522796474177, 10713.500109984609, 10714.089302409304, 10721.678349649485, 10728.088112510446, 8466.32269418448, 10531.21015923805, 10942.56229750809, 11207.047400970927, 11216.887831121667, 10662.893371066268, 10768.407737574431, 10790.622328218475, 10792.244542882001, 10795.406252656101, 39700.40449393261, 40167.397489037685, 40197.19605607871, 40227.19545609101, 40234.0, 3922.980385098056, 3948.1314110895555, 3970.642642162219, 4076.9592304076878, 4098.6516146127615, 34598.30803383918, 34683.826580867186, 34848.47727284093, 35954.64045359539, 36125.27749445022, 4427.402300689398, 4437.556244375537, 4446.377507149002, 4448.199324121657, 4683.718976861399, 355922.0, 357047.0, 358371.0, 359746.0, 360516.0, 39099.80450097788, 39267.41098883519, 61655.0, 62012.68993655003, 62116.689416553534, 37404.62595374011, 37438.0, 37776.62223377731, 37842.81078594589, 37866.62133378686, 16447.424340148038, 16689.08210048459, 16762.49712508602, 16788.748168777478, 16796.496105116865, 13656.24890631005, 14696.779548306784, 15069.849301507064, 15070.773938390932, 15082.924585377223, 9222.953885230665, 9285.767855803524, 9292.628294868266, 9328.300377471716, 9353.064693530592, 3545.556805399325, 3639.0, 3666.496736338089, 3678.5953545110015, 3746.9133951154404, 1051.164324362134, 1097.3525619884147, 1112.9387883666313, 1120.9943950280197, 1182.024829515653, 32447.351052978807, 32581.345985766013, 32968.505472417935, 33134.502982455284, 33628.663713362555, 1175.494537348931, 1207.2273744803333, 1207.7101495640984, 1229.5612837656054, 1333.4599487207697, 16828.83171168297, 16951.745723814154, 17444.47666570005, 17574.912125439547, 17579.912100439415, 505044.0, 510439.0, 510543.0, 511156.0, 513788.0, 62550.0, 62644.686776565824, 63134.36865631285, 63285.68357158277, 63338.36661633417, 1432.9324653133483, 1499.8200215974152, 1524.9466268680765, 1542.591213328469, 1606.349428481467, 29804.014940698074, 32961.175970599965, 33297.33405331928, 33555.0, 33569.16077098092, 50333.74833125811, 61058.694706526185, 62107.378926210156, 62121.689391552754, 62287.0, 416197.0, 420325.0, 424124.0, 424590.0, 424725.0, 41092.794536027126, 46717.299240510736, 46859.53140468688, 47740.7612961933, 48061.75969120132, 45939.0, 45947.0, 46745.53254467548, 47080.529194708986, 47706.761466192445, 38566.83811020793, 39949.80150595487, 42292.36561451642, 42334.36498452587, 42697.57302426936, 41299.174016520104, 41403.58596413997, 42057.78971105247, 42497.0, 42853.1429371417, 42381.0, 42886.78556607197, 42924.78537607292, 43839.34240986451, 43913.0, 36507.634923650425, 36650.8167459161, 37536.0, 37958.810205948794, 38424.0, 28664.283392915346, 28911.132666020054, 29052.854735726185, 29474.26314342073, 29517.0], "value": 20243.092704497303, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.3349923372986, 416.80410207202607, 419.77332240590073, 430.13972055888223, 434.2552522424042, 14493.927530362333, 18784.906075469622, 19330.323438679632, 19362.70955935662, 20205.59588808223, 16215.351385944548, 17772.28910843565, 18895.43313700588, 19539.0, 19626.313079042236, 5510.724463776805, 5683.687397193153, 5685.687287199203, 5687.943120568803, 5697.572682048843, 5703.857403564903, 5728.16941543476, 5739.713014349287, 5745.2818397700285, 5751.741171647265, 4256.0, 5666.603337766358, 6159.538034647397, 6412.743490260384, 6425.8393540161405, 6343.46080583151, 6366.77716279928, 6367.6497792621385, 6400.775972840952, 6408.423241908227, 5575.721213939328, 5820.82537523875, 5825.563082768809, 5826.417358264182, 5826.796062137805, 13316.667083322898, 13552.932235338858, 13904.374303156383, 23489.53020939589, 23944.521109577887, 2423.7212720537186, 2423.842450240729, 2441.6581678565017, 2456.299954512955, 2483.217786397297, 10661.573537058508, 11124.66626001213, 13231.875290600214, 14146.71706565863, 15119.941604087719, 1978.6636271833822, 2055.7635871874777, 2113.5138918048783, 2117.7564580073335, 2149.957000859974, 79646.0, 84184.57907710483, 84580.15419845784, 84931.15068849294, 84971.0, 11076.11391088711, 11300.547978080785, 11402.315861048364, 11698.06415486759, 11920.940395297968, 16129.516114516584, 16208.432704855273, 16232.837671623369, 16246.75629865553, 16252.349906003627, 8799.692010779592, 9000.729978100668, 9055.23030542398, 9118.40730352525, 9144.359894807432, 8753.255973242218, 8892.955535222412, 8958.552072396355, 9002.86495702565, 9031.774205644911, 4379.58393952574, 4657.69724967876, 4794.7842347094465, 4858.271259311132, 4977.1538838397555, 1811.8329808685492, 1876.6152938647544, 1961.1763059515038, 1976.0, 1976.416956997689, 1012.2458768217725, 1079.2337440417234, 1083.815751322277, 1089.7057794395469, 1107.8670559532748, 19301.710474342897, 19599.90200049019, 19657.213711451666, 19681.507962301057, 19886.128725349074, 1066.4454483668449, 1086.6685660873352, 1087.0868470484832, 1093.1145771924766, 1121.960731374398, 10904.945475272572, 11075.556977720962, 11140.777184456427, 11160.274582152135, 11210.495527701272, 506434.0, 526547.0, 531131.0, 534929.0, 535140.0, 87808.0, 90331.0, 90923.54538227267, 91611.0, 94036.0, 1079.1690398393193, 1092.9617463388743, 1098.7198264442516, 1105.8230683090667, 1108.1190453589415, 17171.570710732332, 17525.824741752418, 17567.560810979827, 17629.20668569943, 17636.38272660451, 38958.220835582564, 38973.0, 39044.6095539041, 39418.40872386859, 39717.0, 55365.16952245639, 55597.16604250859, 56001.71999139978, 56450.43549564616, 56595.0, 8827.735167944971, 8847.558751367991, 8913.37606367548, 8955.776105597151, 9016.90983090187, 12399.690007749878, 13326.133801302884, 13418.865811341762, 13456.327183640975, 13521.932390337985, 11502.0, 11725.0, 11842.46708898119, 11945.223560468541, 12122.333271670142, 11533.826992595286, 11623.24448910852, 11629.709257268636, 11974.880251197377, 12156.817647735113, 11687.941560292144, 11738.647840564796, 11825.763484730429, 11959.61894496275, 12239.938800305941, 8754.781130471789, 8799.780005499657, 8895.73312800617, 8995.23540499065, 9115.680951166678, 10105.89894101079, 11343.48954297075, 11497.54009839597, 11864.58473953442, 11986.700332491757], "value": 9457.072529438705, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.7622104242278, 1556.7042261970228, 1572.6933248016635, 1762.3655484025749, 1871.2140900821653, 8169.305609023233, 8304.211099945504, 8337.95831020844, 8340.541270230151, 8350.958245208772, 7941.642626081826, 8077.19228077192, 8105.189481051892, 8113.066997295313, 8134.308583770372, 2160.3626930055593, 2350.3184076617845, 2376.3108698477463, 2400.711914570254, 2404.350825277174, 2435.266488160238, 2458.2502336787275, 2468.4445999650025, 2473.084958565333, 2474.7648973347505, 2423.8424502407374, 2454.0551887523343, 2458.090506512593, 2459.372859920718, 2459.7786199242064, 2070.596233734422, 2358.6226203807396, 2413.083028449196, 2415.0460568075687, 2419.8911049002663, 2275.226423016166, 2279.931602051941, 2281.471414152522, 2287.576798292305, 2340.3447034830274, 8282.668693252263, 8339.041010283834, 8345.666173353058, 8354.624041918067, 8361.080281169066, 5161.2516185152945, 5242.0826355388035, 5269.815556455544, 5275.0, 5320.707361095138, 3511.3679537683206, 3585.3367127081574, 3626.2928728897878, 3646.5988741238443, 3721.2557488502407, 1205.1323047405854, 1207.3963018490754, 1216.1669256559285, 1258.855231648363, 1315.6579289384733, 11585.015273701745, 11633.825492617618, 11648.534058637644, 11658.533658653643, 11666.533338666442, 4464.419625448736, 4573.5426457354, 4648.5119062498625, 4668.486466488684, 4705.247160454311, 9889.653862114792, 9896.158826499684, 9910.603575857029, 9922.0, 9926.404415734934, 4780.378550788445, 5302.257683924254, 5306.681599104066, 5310.0, 5312.707801070978, 4684.95315046852, 4753.762311884392, 4779.091972525209, 4792.353032340659, 4854.17479028566, 4099.282625540519, 4110.588941105865, 4190.53904070552, 4302.161078589707, 4309.439772829513, 1303.6349822049842, 1307.607717684691, 1308.4373719300602, 1312.252016350671, 1318.5846458365584, 824.7814329202766, 842.1704620948361, 927.1655510041018, 945.583943065063, 1007.2948935744861, 5479.205515200274, 5485.0, 5499.312585926759, 5551.557314781483, 5644.153376993484, 902.8194361127669, 927.9118483744169, 959.4387283439266, 981.4847205217176, 1005.2410430125209, 3671.155634204148, 3749.1564398010228, 3776.055986003499, 3778.6032466591164, 3812.752171108869, 9817.312788104764, 10182.898171018343, 10210.591576336863, 10219.284650074573, 10227.795444091225, 9830.4101753895, 10039.247056470647, 10063.245256605784, 10082.0, 10230.693079207636, 8023.277904988462, 8024.358051355877, 8080.0707918590115, 8189.426740128253, 8211.671533138728, 5301.443348448357, 5311.707856067954, 5357.571394288369, 5365.678059316453, 5434.782608695766, 9307.813843723223, 9389.671361502315, 9477.478738669439, 9489.762755931157, 9533.47565883883, 9035.819283614423, 9178.770530736785, 9212.0, 9212.078792120734, 9601.807963840545, 6889.793306200822, 7038.014677945194, 7040.859182816417, 7512.173660897188, 7595.506292090997, 7518.060242469692, 7770.300672939463, 7919.841603167789, 7953.16491768356, 7970.163132871197, 6717.9328206719265, 7004.0544526488275, 7041.507094503336, 7293.854122917406, 7367.189609142883, 7245.0, 7261.636918154177, 7275.890861636974, 7347.779566612797, 7363.668634911334, 6567.934320656924, 6676.232233293234, 6678.532502724763, 6686.598804071771, 6688.3646053624825, 4845.903081938271, 4944.554990050912, 4961.652684312208, 4985.302057711996, 4996.400431948189, 4907.631927605373, 4933.432655244549, 4964.900701986012, 4966.155753521838, 4993.950060499494], "value": 4522.817336749193, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.9583747868995, 362.69352397224344, 362.9074585980575, 370.3038288018525, 372.94592284118784, 6356.364363563642, 6393.616383017023, 6408.327125651809, 6408.455281301083, 6413.615183089012, 6266.122742816009, 6341.52438567107, 6355.205599300088, 6361.55469117162, 6363.0, 4648.674592778515, 4769.356136921506, 4853.150698627744, 4874.2444921037295, 4888.657793954425, 4842.9515704843025, 4869.074875773609, 4878.219484882419, 4906.656534042619, 4919.2621106834085, 4635.768211589424, 4879.243717223836, 4881.707097574139, 4882.6093912487095, 4884.438289596688, 4756.833510827122, 4855.708657480527, 4872.098661747588, 4875.512448755132, 4881.341018962448, 4273.423087883127, 4282.164977829325, 4288.0, 4298.31227003681, 4304.7632380219075, 6075.848103797441, 6080.270367555921, 6086.300075491331, 6091.482224010964, 6097.847553811191, 5651.7739290428335, 5654.74553645087, 5663.546916246732, 5665.206871038058, 5665.971670141664, 6428.839279018062, 6675.232348279913, 6684.431823295025, 6688.498362622774, 6696.43080338167, 4586.3579098926175, 4588.426446694163, 4610.76946152691, 4613.6078433333205, 4617.376654151713, 6936.410405115521, 7028.54314469563, 7034.613096279702, 7035.6482175891515, 7038.894416583807, 4755.976220118877, 4759.904801903943, 4764.094821983812, 4765.523447655207, 4769.976150119227, 4815.446223684321, 4822.565969062801, 4824.541668541483, 4828.251620998751, 4830.033993201374, 5575.414581468968, 5586.190002449622, 5596.188552659842, 5597.916031259534, 5603.10350343943, 6545.280019197884, 6775.966120169466, 6778.593284402951, 6783.491238157059, 6796.048553202556, 1658.4361317152227, 1678.8069372022373, 1684.5030715938829, 1685.0311071133901, 1687.64559442516, 1033.2715435617872, 1093.868735751715, 1100.6808025672465, 1111.360967443723, 1115.983260251097, 6387.616742995435, 6399.104125422445, 6479.8056058318325, 6489.318621544669, 6494.675266236669, 6865.107536020286, 6874.828129296708, 6878.69045892936, 6883.0, 6887.793366199022, 6467.027556595283, 6471.708773105222, 6478.870422591616, 6480.740770369227, 6484.059811327425, 3684.428913518409, 3706.09200745819, 3718.9070273242846, 3721.4603882436895, 3724.217914237986, 7067.22260551339, 7335.046443962251, 7356.043714317211, 7358.374538164316, 7366.631668416558, 7125.75059872902, 7144.9285507145305, 7155.105611798525, 7162.247963963709, 7162.4270058395205, 7286.453515986216, 7294.343509084102, 7300.525465844703, 7301.926980730231, 7321.377682897013, 6857.622830744357, 6996.300369962963, 7013.929860701328, 7014.298570143149, 7026.367626913602, 6864.176298844171, 6887.690053947485, 6898.06876071744, 6911.308869113049, 6924.065251191025, 7249.855002900018, 7271.781846544613, 7281.708731650887, 7297.1973082961895, 7304.160021597372, 4732.148213321635, 4763.095011947719, 4772.355731976278, 4781.354517140142, 4784.282357646381, 6959.8956015660815, 6981.441484681111, 6981.930180698128, 6992.265812089658, 6996.510244282851, 6660.866782664417, 6831.351021652935, 6838.623875686885, 6844.486663500357, 6846.110005699426, 6748.0, 6780.762673306608, 6782.016607591971, 6783.559068660521, 6787.5588086774205, 6639.568428052161, 6675.4325882300545, 6678.165229346332, 6681.365270299314, 6686.665666716742, 6704.06143139951, 6773.762918297836, 6845.691943862438, 6858.108445902001, 6859.485538584527, 6423.614583125028, 6572.277049524644, 6665.533412661067, 6716.429103526255, 6758.662066896733], "value": 5086.728598393153, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.5322189740897, 876.5485774825962, 920.6455514626869, 927.8283517549254, 952.8237276103916, 15226.314815833286, 17134.82865171348, 17437.128143592832, 17491.037992910402, 17517.124143792822, 15542.0, 15594.142322172276, 15595.766063509056, 15602.921985390058, 15699.921500392482, 765.2844590308052, 896.5472436419615, 903.5301643145593, 907.5280853955938, 923.6213152607432, 916.7066538707617, 916.8258030974127, 917.5824999625188, 924.852023676212, 924.9213816825578, 957.7701351675582, 959.1894848852743, 960.0255740423476, 961.024560071528, 961.7643677299071, 791.7862177212178, 801.2708435323827, 940.3652534539159, 958.4536814016013, 960.1934375124858, 704.4822055788991, 705.3052743048094, 705.8835292176836, 705.9752908648172, 706.0221593093551, 13858.16850988944, 13985.230812305319, 14004.0, 14045.508407205802, 14106.506272280421, 13857.37641806111, 14223.359948802328, 14274.286285685674, 14336.139831610137, 14354.497592584314, 12136.271823690608, 12535.31055791931, 12612.68468288291, 12680.61958141248, 12742.617721468278, 4006.098627808749, 4023.4568333274924, 4056.918861622751, 4082.040720430696, 4105.220008198433, 59066.40933590652, 59084.70457647727, 59740.70129649324, 59881.700591497196, 60229.0, 11499.942500287445, 11671.59149429766, 11674.824877626843, 11696.532138714527, 12077.248798924282, 20381.184752610025, 20540.691889621667, 20544.691829622567, 20604.896975515025, 20610.79389206119, 8986.55067246635, 8998.10018998108, 9116.270698344117, 9248.451643639792, 9313.115254050854, 5041.899162016739, 5082.059818933509, 5101.285819985205, 5144.048351055067, 5206.635535512478, 3345.7156141728224, 3426.588809342895, 3427.0, 3440.518327434111, 3449.6205417404067, 638.0970926139553, 643.8486955565438, 664.9833754156185, 676.2865177237962, 703.5919166883298, 652.5725649699455, 681.4786688183543, 751.8082888863305, 778.7313376884965, 779.8206412525037, 9462.101100395452, 9557.617695292249, 9588.328816982745, 9604.66383676568, 9606.0, 636.2651137935692, 696.8257935516122, 707.1090426063197, 814.3566582399837, 825.8265764189588, 4394.2969124939855, 4520.81916723334, 4569.405977222939, 4575.0, 4653.7207767534055, 71046.0, 72224.63887680529, 72345.27654723385, 72406.0, 72414.27585724181, 59967.40032599618, 62462.0, 62641.0, 62750.37249627537, 63386.0, 53596.464035359924, 54351.45648543543, 55122.44877551173, 55256.0, 56341.0, 9136.360454768102, 9197.0, 9213.170814626716, 9315.254779617479, 9383.436993780122, 36846.815765921, 40216.0, 41362.172756545304, 41531.792341038104, 42254.78872605618, 51214.48785512097, 51541.226881597555, 52244.47755522396, 52312.738436307576, 52862.47137528729, 12899.677508062374, 13134.737305254033, 13475.932620337227, 13517.662058448617, 13802.102863313852, 14061.507847225297, 14171.220582868042, 14316.355763990854, 14360.712785744436, 14881.925590372412, 12859.0, 13229.140105893086, 13724.313784310545, 13808.240546770025, 13902.791458128338, 12601.18092323996, 12925.224486530838, 13209.0, 13398.196108233537, 13515.0, 13345.022015899558, 13541.187528748307, 13634.522791702242, 13997.580072597839, 14436.783448248074, 11847.585334513251, 11850.407479626158, 11876.465559049691, 12023.398830058637, 12197.329146897006, 11838.230515016496, 11845.763084738084, 12084.939575302067, 12101.152919295564, 12102.455389507317], "value": 7324.998623221304, "unit": "score"}], "name": "dromaeo_css", "value": 7505.036556451777, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 110.0, 111.0, 110.0, 111.0, 106.0, 110.0, 110.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 158.0, 181.0, 128.0, 165.0, 159.0, 134.0, 193.0, 127.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 161.0, 159.0, 161.0, 160.0, 161.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 75.0, 185.0, 76.0, 76.0, 75.0, 74.0, 169.0, 76.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 158.0, 91.0, 92.0, 93.0, 150.0, 91.0, 93.0, 147.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 54.0, 53.0, 54.0, 54.0, 54.0, 78.0, 52.0, 53.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 56.0, 57.0, 56.0, 56.0, 57.0, 57.0, 57.0, 58.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 72.0, 73.0, 73.0, 74.0, 73.0, 75.0, 73.0, 72.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 111.0, 112.0, 114.0, 115.0, 122.0, 110.0, 125.0, 111.0], "value": 115.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 168.0, 161.0, 160.0, 164.0, 158.0, 166.0, 159.0, 159.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 69.0, 67.0, 67.0, 66.0, 67.0, 67.0, 71.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1515.9, "alertThreshold": 2.0}]} 03:49:56 INFO - Return code: 0 03:49:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:49:56 ERROR - # TBPL SUCCESS # 03:49:56 INFO - Running post-action listener: _resource_record_post_action 03:49:56 INFO - Running post-run listener: _resource_record_post_run 03:49:57 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 499630080; Read time: 32; Write time: 353108 03:49:57 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248213504; Read time: 0; Write time: 222712 03:49:57 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 244408320; Read time: 32; Write time: 128644 03:49:57 INFO - Running post-run listener: _upload_blobber_files 03:49:57 INFO - Blob upload gear active. 03:49:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:49:57 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:49:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:49:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:58 INFO - (blobuploader) - INFO - Done attempting. 03:49:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:49:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:50:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:00 INFO - (blobuploader) - INFO - Done attempting. 03:50:00 INFO - (blobuploader) - INFO - Iteration through files over. 03:50:00 INFO - Return code: 0 03:50:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:50:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:50:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80e35a8f0c89a0b5a3868f5183f834b75b5cd912be4e2c8d15ef63d48d5d84b30b5938605518c8e707d660304f5e4fac2c937cfcb98e92ae06e0c25816f991c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92ebc820fc1f7ca036bd1be25694625c2fe1bb4933017440f5a75057ce6ba0a968800fb0eff6e8e69e52ce62d3ac62c8ece0662a1bddb9b9be9a93339db63e57"} 03:50:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:50:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:50:00 INFO - Contents: 03:50:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80e35a8f0c89a0b5a3868f5183f834b75b5cd912be4e2c8d15ef63d48d5d84b30b5938605518c8e707d660304f5e4fac2c937cfcb98e92ae06e0c25816f991c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92ebc820fc1f7ca036bd1be25694625c2fe1bb4933017440f5a75057ce6ba0a968800fb0eff6e8e69e52ce62d3ac62c8ece0662a1bddb9b9be9a93339db63e57"} 03:50:00 INFO - Running post-run listener: copy_logs_to_upload_dir 03:50:00 INFO - Copying logs to upload dir... 03:50:00 INFO - mkdir: /builds/slave/test/build/upload/logs 03:50:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.660806 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-09 03:49:59.776725) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 03:49:59.782935) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608 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/80e35a8f0c89a0b5a3868f5183f834b75b5cd912be4e2c8d15ef63d48d5d84b30b5938605518c8e707d660304f5e4fac2c937cfcb98e92ae06e0c25816f991c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92ebc820fc1f7ca036bd1be25694625c2fe1bb4933017440f5a75057ce6ba0a968800fb0eff6e8e69e52ce62d3ac62c8ece0662a1bddb9b9be9a93339db63e57"} build_url:https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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/80e35a8f0c89a0b5a3868f5183f834b75b5cd912be4e2c8d15ef63d48d5d84b30b5938605518c8e707d660304f5e4fac2c937cfcb98e92ae06e0c25816f991c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92ebc820fc1f7ca036bd1be25694625c2fe1bb4933017440f5a75057ce6ba0a968800fb0eff6e8e69e52ce62d3ac62c8ece0662a1bddb9b9be9a93339db63e57"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 03:49:59.807534) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:49:59.807858) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1462789771.118617-1834917608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004338 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:49:59.893654) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 03:49:59.893970) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 03:49:59.894266) ========= ========= Total master_lag: 0.18 =========