builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1464587244.8 results: success (0) buildid: 20160529195147 builduid: e7e33c2797ff4f47a5ba3ffe276f1b26 revision: ccf0f53adb66c86d81a39b53e32092489fb5f0b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 22:47:24.804017) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 22:47:24.804522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 22:47:24.804934) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 22:47:24.822565) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 22:47:24.822996) ========= 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=232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-29 22:47:25-- 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% 21.5M=0.001s 2016-05-29 22:47:25 (21.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117879 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 22:47:24.955785) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 22:47:24.956111) ========= 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=232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016841 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 22:47:25.012620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 22:47:25.012975) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ccf0f53adb66c86d81a39b53e32092489fb5f0b5 --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 ccf0f53adb66c86d81a39b53e32092489fb5f0b5 --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=232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-29 22:47:25,275 truncating revision to first 12 chars 2016-05-29 22:47:25,275 Setting DEBUG logging. 2016-05-29 22:47:25,275 attempt 1/10 2016-05-29 22:47:25,275 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ccf0f53adb66?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-29 22:47:25,569 unpacking tar archive at: mozilla-aurora-ccf0f53adb66/testing/mozharness/ program finished with exit code 0 elapsedTime=0.627967 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 22:47:25.654971) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 22:47:25.655318) ========= script_repo_revision: ccf0f53adb66c86d81a39b53e32092489fb5f0b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 22:47:25.655794) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 22:47:25.656108) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 22:47:25.666910) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-29 22:47:25.667237) ========= /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=232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:47:26 INFO - MultiFileLogger online at 20160529 22:47:26 in /builds/slave/test 22:47:26 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 22:47:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:47:26 INFO - {'append_to_log': False, 22:47:26 INFO - 'base_work_dir': '/builds/slave/test', 22:47:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:47:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:47:26 INFO - 'branch': 'Mozilla-Aurora', 22:47:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:47:26 INFO - 'config_files': ('talos/linux_config.py',), 22:47:26 INFO - 'default_actions': ('clobber', 22:47:26 INFO - 'read-buildbot-config', 22:47:26 INFO - 'download-and-extract', 22:47:26 INFO - 'populate-webroot', 22:47:26 INFO - 'create-virtualenv', 22:47:26 INFO - 'install', 22:47:26 INFO - 'run-tests'), 22:47:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:47:26 INFO - 'download_minidump_stackwalk': True, 22:47:26 INFO - 'download_symbols': 'ondemand', 22:47:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:47:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:47:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:47:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:47:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:47:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:47:26 INFO - 'installer_path': 'installer.exe', 22:47:26 INFO - 'log_level': 'info', 22:47:26 INFO - 'log_name': 'talos', 22:47:26 INFO - 'log_to_console': True, 22:47:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:47:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:47:26 INFO - 'opt_config_files': (), 22:47:26 INFO - 'pip_index': False, 22:47:26 INFO - 'sps_profile': False, 22:47:26 INFO - 'sps_profile_interval': 0, 22:47:26 INFO - 'suite': 'dromaeojs', 22:47:26 INFO - 'system_bits': '32', 22:47:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:47:26 INFO - 'title': 'talos-linux64-ix-025', 22:47:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:47:26 INFO - 'use_talos_json': True, 22:47:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:47:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:47:26 INFO - 'work_dir': 'build'} 22:47:26 INFO - ##### 22:47:26 INFO - ##### Running clobber step. 22:47:26 INFO - ##### 22:47:26 INFO - Running pre-action listener: _resource_record_pre_action 22:47:26 INFO - Running main action method: clobber 22:47:26 INFO - rmtree: /builds/slave/test/build 22:47:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:47:26 INFO - Running post-action listener: _resource_record_post_action 22:47:26 INFO - ##### 22:47:26 INFO - ##### Running read-buildbot-config step. 22:47:26 INFO - ##### 22:47:26 INFO - Running pre-action listener: _resource_record_pre_action 22:47:26 INFO - Running main action method: read_buildbot_config 22:47:26 INFO - Using buildbot properties: 22:47:26 INFO - { 22:47:26 INFO - "project": "", 22:47:26 INFO - "product": "firefox", 22:47:26 INFO - "script_repo_revision": "production", 22:47:26 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 22:47:26 INFO - "repository": "", 22:47:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 22:47:26 INFO - "buildid": "20160529195147", 22:47:26 INFO - "pgo_build": "True", 22:47:26 INFO - "basedir": "/builds/slave/test", 22:47:26 INFO - "buildnumber": 267, 22:47:26 INFO - "slavename": "talos-linux64-ix-025", 22:47:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:47:26 INFO - "platform": "ubuntu64_hw", 22:47:26 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 22:47:26 INFO - "branch": "mozilla-aurora", 22:47:26 INFO - "repo_path": "releases/mozilla-aurora", 22:47:26 INFO - "revision": "ccf0f53adb66c86d81a39b53e32092489fb5f0b5", 22:47:26 INFO - "stage_platform": "linux64-pgo", 22:47:26 INFO - "builduid": "e7e33c2797ff4f47a5ba3ffe276f1b26", 22:47:26 INFO - "slavebuilddir": "test" 22:47:26 INFO - } 22:47:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 22:47:26 INFO - Running post-action listener: _resource_record_post_action 22:47:26 INFO - ##### 22:47:26 INFO - ##### Running download-and-extract step. 22:47:26 INFO - ##### 22:47:26 INFO - Running pre-action listener: _resource_record_pre_action 22:47:26 INFO - Running main action method: download_and_extract 22:47:26 INFO - mkdir: /builds/slave/test/build/tests 22:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:26 INFO - https://queue.taskcluster.net/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:47:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 22:47:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 22:47:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/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 22:47:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/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 22:47:30 INFO - Downloaded 1361 bytes. 22:47:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 22:47:30 INFO - Using the following test package requirements: 22:47:30 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 22:47:30 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 22:47:30 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 22:47:30 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 22:47:30 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 22:47:30 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 22:47:30 INFO - u'jsshell-linux-x86_64.zip'], 22:47:30 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 22:47:30 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 22:47:30 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 22:47:30 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 22:47:30 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 22:47:30 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 22:47:30 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 22:47:30 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 22:47:30 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 22:47:30 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 22:47:30 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 22:47:30 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:30 INFO - https://queue.taskcluster.net/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:47:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 22:47:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 22:47:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/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 22:47:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/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 22:47:41 INFO - Downloaded 24136545 bytes. 22:47:41 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'] 22:47:41 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 22:47:43 INFO - Return code: 0 22:47:43 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 22:47:43 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')]} 22:47:43 INFO - https://queue.taskcluster.net/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:47:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 22:47:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 22:47:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/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 22:47:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/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 22:47:48 INFO - Downloaded 24136545 bytes. 22:47:48 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'] 22:47:48 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 22:47:49 INFO - Return code: 0 22:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:49 INFO - https://queue.taskcluster.net/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:47:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 22:47:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 22:47:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/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 22:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/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 22:47:51 INFO - Downloaded 10840145 bytes. 22:47:51 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'] 22:47:51 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 22:47:51 INFO - Return code: 0 22:47:51 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')]} 22:47:51 INFO - https://queue.taskcluster.net/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:47:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 22:47:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 22:47:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/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 22:47:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMEDIQFwQl6M51gRvfBfHg/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 22:47:53 INFO - Downloaded 62776878 bytes. 22:47:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 22:47:53 INFO - mkdir: /builds/slave/test/properties 22:47:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:47:53 INFO - Writing to file /builds/slave/test/properties/build_url 22:47:53 INFO - Contents: 22:47:53 INFO - build_url:https://queue.taskcluster.net/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 22:47:55 INFO - Running post-action listener: _resource_record_post_action 22:47:55 INFO - Running post-action listener: set_extra_try_arguments 22:47:55 INFO - ##### 22:47:55 INFO - ##### Running populate-webroot step. 22:47:55 INFO - ##### 22:47:55 INFO - Running pre-action listener: _resource_record_pre_action 22:47:55 INFO - Running main action method: populate_webroot 22:47:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:47:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:47:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:47:55 INFO - '--tppagecycles', 22:47:55 INFO - '7'], 22:47:55 INFO - 'tests': ['tsvgm']}}, 22:47:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:47:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:47:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:47:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:47:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:47:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:47:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:55 INFO - 'talos_options': ['--disable-e10s'], 22:47:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:47:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:47:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:55 INFO - 'talos_options': ['--disable-e10s'], 22:47:55 INFO - 'tests': ['damp', 'tps']}, 22:47:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:55 INFO - 'tests': ['damp', 'tps']}, 22:47:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:47:55 INFO - 'tests': ['dromaeo_dom']}, 22:47:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:47:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:47:55 INFO - 'tests': ['a11yr', 22:47:55 INFO - 'ts_paint', 22:47:55 INFO - 'tpaint', 22:47:55 INFO - 'sessionrestore', 22:47:55 INFO - 'sessionrestore_no_auto_restore', 22:47:55 INFO - 'tabpaint']}, 22:47:55 INFO - 'other-e10s': {'tests': ['a11yr', 22:47:55 INFO - 'ts_paint', 22:47:55 INFO - 'tpaint', 22:47:55 INFO - 'sessionrestore', 22:47:55 INFO - 'sessionrestore_no_auto_restore', 22:47:55 INFO - 'tabpaint']}, 22:47:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:47:55 INFO - 'ts_paint', 22:47:55 INFO - 'tpaint', 22:47:55 INFO - 'sessionrestore', 22:47:55 INFO - 'sessionrestore_no_auto_restore', 22:47:55 INFO - 'tabpaint']}, 22:47:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:47:55 INFO - 'ts_paint', 22:47:55 INFO - 'tpaint', 22:47:55 INFO - 'sessionrestore', 22:47:55 INFO - 'sessionrestore_no_auto_restore', 22:47:55 INFO - 'tabpaint']}, 22:47:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:47:55 INFO - 'tests': ['a11yr', 22:47:55 INFO - 'ts_paint', 22:47:55 INFO - 'tpaint', 22:47:55 INFO - 'sessionrestore', 22:47:55 INFO - 'sessionrestore_no_auto_restore', 22:47:55 INFO - 'tabpaint']}, 22:47:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:47:55 INFO - 'tests': ['a11yr', 22:47:55 INFO - 'ts_paint', 22:47:55 INFO - 'tpaint', 22:47:55 INFO - 'sessionrestore', 22:47:55 INFO - 'sessionrestore_no_auto_restore', 22:47:55 INFO - 'tabpaint']}, 22:47:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:47:55 INFO - 'tests': ['tsvgx', 22:47:55 INFO - 'tsvgr_opacity', 22:47:55 INFO - 'tart', 22:47:55 INFO - 'tscrollx', 22:47:55 INFO - 'cart']}, 22:47:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:47:55 INFO - 'tsvgr_opacity', 22:47:55 INFO - 'tart', 22:47:55 INFO - 'tscrollx', 22:47:55 INFO - 'cart']}, 22:47:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:55 INFO - 'talos_options': ['--disable-e10s'], 22:47:55 INFO - 'tests': ['tp5o']}, 22:47:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:55 INFO - 'tests': ['tp5o']}, 22:47:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:55 INFO - 'talos_options': ['--disable-e10s', 22:47:55 INFO - '--xperf_path', 22:47:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:47:55 INFO - 'tests': ['tp5n']}, 22:47:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:55 INFO - 'talos_options': ['--xperf_path', 22:47:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:47:55 INFO - 'tests': ['tp5n']}}, 22:47:55 INFO - 'talos.zip': {'path': '', 22:47:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:47:55 INFO - Running post-action listener: _resource_record_post_action 22:47:55 INFO - ##### 22:47:55 INFO - ##### Running create-virtualenv step. 22:47:55 INFO - ##### 22:47:55 INFO - Running pre-action listener: _resource_record_pre_action 22:47:55 INFO - Running main action method: create_virtualenv 22:47:55 INFO - Creating virtualenv /builds/slave/test/build/venv 22:47:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:47:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:47:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:47:55 INFO - Using real prefix '/usr' 22:47:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:47:55 INFO - Installing distribute.............................................................................................................................................................................................done. 22:47:57 INFO - Installing pip.................done. 22:47:57 INFO - Return code: 0 22:47:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:47: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')]} 22:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47: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')]} 22:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90607e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4410>, '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 0x29f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f57a0>, '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': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', '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 22:47:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:47:57 INFO - Using env: {'DISPLAY': ':0', 22:47:57 INFO - 'HOME': '/home/cltbld', 22:47:57 INFO - 'LANG': 'en_US.UTF-8', 22:47:57 INFO - 'LANGUAGE': 'en_US:en', 22:47:57 INFO - 'LOGNAME': 'cltbld', 22:47:57 INFO - 'MAIL': '/var/mail/cltbld', 22:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:57 INFO - 'MOZ_NO_REMOTE': '1', 22:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:57 INFO - 'NO_EM_RESTART': '1', 22:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:57 INFO - 'PWD': '/builds/slave/test', 22:47:57 INFO - 'SHELL': '/bin/bash', 22:47:57 INFO - 'SHLVL': '1', 22:47:57 INFO - 'TERM': 'linux', 22:47:57 INFO - 'TMOUT': '86400', 22:47:57 INFO - 'USER': 'cltbld', 22:47:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', 22:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:57 INFO - '_': '/tools/buildbot/bin/python'} 22:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:47:57 INFO - Cleaning up... 22:47:57 INFO - Return code: 0 22:47:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:47: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')]} 22:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47: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')]} 22:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90607e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4410>, '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 0x29f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f57a0>, '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': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', '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 22:47:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:47:57 INFO - Using env: {'DISPLAY': ':0', 22:47:57 INFO - 'HOME': '/home/cltbld', 22:47:57 INFO - 'LANG': 'en_US.UTF-8', 22:47:57 INFO - 'LANGUAGE': 'en_US:en', 22:47:57 INFO - 'LOGNAME': 'cltbld', 22:47:57 INFO - 'MAIL': '/var/mail/cltbld', 22:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:57 INFO - 'MOZ_NO_REMOTE': '1', 22:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:57 INFO - 'NO_EM_RESTART': '1', 22:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:57 INFO - 'PWD': '/builds/slave/test', 22:47:57 INFO - 'SHELL': '/bin/bash', 22:47:57 INFO - 'SHLVL': '1', 22:47:57 INFO - 'TERM': 'linux', 22:47:57 INFO - 'TMOUT': '86400', 22:47:57 INFO - 'USER': 'cltbld', 22:47:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', 22:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:57 INFO - '_': '/tools/buildbot/bin/python'} 22:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:58 INFO - Downloading/unpacking psutil>=0.7.1 22:47: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 22:47: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 22:47: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 22:47: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 22:47: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 22:47: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 22:48:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:48:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:48:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:48:00 INFO - Installing collected packages: psutil 22:48:00 INFO - Running setup.py install for psutil 22:48:00 INFO - building 'psutil._psutil_linux' extension 22:48:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:48:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:48:00 INFO - building 'psutil._psutil_posix' extension 22:48:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:48:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:48:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:48:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:48:00 INFO - Successfully installed psutil 22:48:00 INFO - Cleaning up... 22:48:00 INFO - Return code: 0 22:48:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:48: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')]} 22:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48: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')]} 22:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90607e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4410>, '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 0x29f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f57a0>, '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': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', '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 22:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:48:00 INFO - Using env: {'DISPLAY': ':0', 22:48:00 INFO - 'HOME': '/home/cltbld', 22:48:00 INFO - 'LANG': 'en_US.UTF-8', 22:48:00 INFO - 'LANGUAGE': 'en_US:en', 22:48:00 INFO - 'LOGNAME': 'cltbld', 22:48:00 INFO - 'MAIL': '/var/mail/cltbld', 22:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:00 INFO - 'MOZ_NO_REMOTE': '1', 22:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:00 INFO - 'NO_EM_RESTART': '1', 22:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:00 INFO - 'PWD': '/builds/slave/test', 22:48:00 INFO - 'SHELL': '/bin/bash', 22:48:00 INFO - 'SHLVL': '1', 22:48:00 INFO - 'TERM': 'linux', 22:48:00 INFO - 'TMOUT': '86400', 22:48:00 INFO - 'USER': 'cltbld', 22:48:00 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', 22:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:00 INFO - '_': '/tools/buildbot/bin/python'} 22:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:48:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:48:02 INFO - Installing collected packages: mozsystemmonitor 22:48:02 INFO - Running setup.py install for mozsystemmonitor 22:48:02 INFO - Successfully installed mozsystemmonitor 22:48:02 INFO - Cleaning up... 22:48:02 INFO - Return code: 0 22:48:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90607e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4410>, '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 0x29f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f57a0>, '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': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', '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 22:48:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:48:02 INFO - Using env: {'DISPLAY': ':0', 22:48:02 INFO - 'HOME': '/home/cltbld', 22:48:02 INFO - 'LANG': 'en_US.UTF-8', 22:48:02 INFO - 'LANGUAGE': 'en_US:en', 22:48:02 INFO - 'LOGNAME': 'cltbld', 22:48:02 INFO - 'MAIL': '/var/mail/cltbld', 22:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:02 INFO - 'MOZ_NO_REMOTE': '1', 22:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:02 INFO - 'NO_EM_RESTART': '1', 22:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:02 INFO - 'PWD': '/builds/slave/test', 22:48:02 INFO - 'SHELL': '/bin/bash', 22:48:02 INFO - 'SHLVL': '1', 22:48:02 INFO - 'TERM': 'linux', 22:48:02 INFO - 'TMOUT': '86400', 22:48:02 INFO - 'USER': 'cltbld', 22:48:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', 22:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:02 INFO - '_': '/tools/buildbot/bin/python'} 22:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:03 INFO - Downloading/unpacking blobuploader==1.2.4 22:48: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 22:48: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 22:48: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 22:48: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 22:48: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 22:48: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 22:48:05 INFO - Downloading blobuploader-1.2.4.tar.gz 22:48:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:48:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:48: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 22:48: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 22:48: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 22:48: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 22:48: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 22:48: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 22:48:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:48:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:48: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 22:48: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 22:48: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 22:48: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 22:48: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 22:48: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 22:48:05 INFO - Downloading docopt-0.6.1.tar.gz 22:48:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:48:05 INFO - Installing collected packages: blobuploader, requests, docopt 22:48:05 INFO - Running setup.py install for blobuploader 22:48:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:48:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:48:06 INFO - Running setup.py install for requests 22:48:06 INFO - Running setup.py install for docopt 22:48:06 INFO - Successfully installed blobuploader requests docopt 22:48:06 INFO - Cleaning up... 22:48:06 INFO - Return code: 0 22:48:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90607e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4410>, '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 0x29f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f57a0>, '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': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', '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 22:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:48:06 INFO - Using env: {'DISPLAY': ':0', 22:48:06 INFO - 'HOME': '/home/cltbld', 22:48:06 INFO - 'LANG': 'en_US.UTF-8', 22:48:06 INFO - 'LANGUAGE': 'en_US:en', 22:48:06 INFO - 'LOGNAME': 'cltbld', 22:48:06 INFO - 'MAIL': '/var/mail/cltbld', 22:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:06 INFO - 'MOZ_NO_REMOTE': '1', 22:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:06 INFO - 'NO_EM_RESTART': '1', 22:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:06 INFO - 'PWD': '/builds/slave/test', 22:48:06 INFO - 'SHELL': '/bin/bash', 22:48:06 INFO - 'SHLVL': '1', 22:48:06 INFO - 'TERM': 'linux', 22:48:06 INFO - 'TMOUT': '86400', 22:48:06 INFO - 'USER': 'cltbld', 22:48:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', 22:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:06 INFO - '_': '/tools/buildbot/bin/python'} 22:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:48:06 INFO - Running setup.py (path:/tmp/pip-gj8BiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:48:06 INFO - Running setup.py (path:/tmp/pip-Hy2FfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:48:06 INFO - Running setup.py (path:/tmp/pip-w7JQ_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:48:06 INFO - Running setup.py (path:/tmp/pip-JBoQiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:48:07 INFO - Running setup.py (path:/tmp/pip-abufUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:48:07 INFO - Running setup.py (path:/tmp/pip-Kl69zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:48:07 INFO - Running setup.py (path:/tmp/pip-JIEknQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:48:07 INFO - Running setup.py (path:/tmp/pip-Htak1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:48:07 INFO - Running setup.py (path:/tmp/pip-WMokxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:48:07 INFO - Running setup.py (path:/tmp/pip-DClejB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:48:07 INFO - Running setup.py (path:/tmp/pip-Y6DCVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:48:07 INFO - Running setup.py (path:/tmp/pip-7jHErI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:48:07 INFO - Running setup.py (path:/tmp/pip-0Tpo72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:48:07 INFO - Running setup.py (path:/tmp/pip-zz7wqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:48:07 INFO - Running setup.py (path:/tmp/pip-_Ew0vW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:48:07 INFO - Running setup.py (path:/tmp/pip-tJ5wCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:48:07 INFO - Running setup.py (path:/tmp/pip-IXOS_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:48:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:48:07 INFO - Running setup.py install for manifestparser 22:48:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:48:08 INFO - Running setup.py install for mozcrash 22:48:08 INFO - Running setup.py install for mozdebug 22:48:08 INFO - Running setup.py install for mozdevice 22:48:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:48:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:48:08 INFO - Running setup.py install for mozfile 22:48:08 INFO - Running setup.py install for mozhttpd 22:48:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:48:08 INFO - Running setup.py install for mozinfo 22:48:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:48:08 INFO - Running setup.py install for mozInstall 22:48:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:48:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:48:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:48:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:48:08 INFO - Running setup.py install for mozleak 22:48:08 INFO - Running setup.py install for mozlog 22:48:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:48:09 INFO - Running setup.py install for moznetwork 22:48:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:48:09 INFO - Running setup.py install for mozprocess 22:48:09 INFO - Running setup.py install for mozprofile 22:48:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:48:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:48:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:48:09 INFO - Running setup.py install for mozrunner 22:48:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:48:09 INFO - Running setup.py install for mozscreenshot 22:48:09 INFO - Running setup.py install for moztest 22:48:09 INFO - Running setup.py install for mozversion 22:48:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:48:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:48:09 INFO - Cleaning up... 22:48:09 INFO - Return code: 0 22:48:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90607e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4410>, '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 0x29f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f57a0>, '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': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', '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 22:48:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:48:09 INFO - Using env: {'DISPLAY': ':0', 22:48:09 INFO - 'HOME': '/home/cltbld', 22:48:09 INFO - 'LANG': 'en_US.UTF-8', 22:48:09 INFO - 'LANGUAGE': 'en_US:en', 22:48:09 INFO - 'LOGNAME': 'cltbld', 22:48:09 INFO - 'MAIL': '/var/mail/cltbld', 22:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:09 INFO - 'MOZ_NO_REMOTE': '1', 22:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:09 INFO - 'NO_EM_RESTART': '1', 22:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:09 INFO - 'PWD': '/builds/slave/test', 22:48:09 INFO - 'SHELL': '/bin/bash', 22:48:09 INFO - 'SHLVL': '1', 22:48:09 INFO - 'TERM': 'linux', 22:48:09 INFO - 'TMOUT': '86400', 22:48:09 INFO - 'USER': 'cltbld', 22:48:09 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', 22:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:09 INFO - '_': '/tools/buildbot/bin/python'} 22:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:48:09 INFO - Running setup.py (path:/tmp/pip-pJlcYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:48:10 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)) 22:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:48:10 INFO - Running setup.py (path:/tmp/pip-oajglU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:48:10 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)) 22:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:48:10 INFO - Running setup.py (path:/tmp/pip-AAwAAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:48:10 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)) 22:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:48:10 INFO - Running setup.py (path:/tmp/pip-Q0Sjce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:48:10 INFO - Running setup.py (path:/tmp/pip-kXANEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:48:10 INFO - Running setup.py (path:/tmp/pip-fIUWgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:48:10 INFO - Running setup.py (path:/tmp/pip-lao7xO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:48:10 INFO - Running setup.py (path:/tmp/pip-rjo5EJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:48:10 INFO - Running setup.py (path:/tmp/pip-43BA38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:48:10 INFO - Running setup.py (path:/tmp/pip-0ArixC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:48:10 INFO - Running setup.py (path:/tmp/pip-S3aZ1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:48:10 INFO - Running setup.py (path:/tmp/pip-dr2tAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:48:10 INFO - Running setup.py (path:/tmp/pip-EvR8QM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:48:10 INFO - Running setup.py (path:/tmp/pip-qHWKo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:48:10 INFO - Running setup.py (path:/tmp/pip-nbfjIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:48:11 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)) 22:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:48:11 INFO - Running setup.py (path:/tmp/pip-4M9ijb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:48:11 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)) 22:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:48:11 INFO - Running setup.py (path:/tmp/pip-2grFE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:48:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:48:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:48:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:48:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:48:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:48:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:48:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:13 INFO - Downloading blessings-1.6.tar.gz 22:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:48:13 INFO - Installing collected packages: blessings 22:48:13 INFO - Running setup.py install for blessings 22:48:13 INFO - Successfully installed blessings 22:48:13 INFO - Cleaning up... 22:48:13 INFO - Return code: 0 22:48:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:48:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:48:13 INFO - Reading from file tmpfile_stdout 22:48:13 INFO - Current package versions: 22:48:13 INFO - argparse == 1.2.1 22:48:13 INFO - blessings == 1.6 22:48:13 INFO - blobuploader == 1.2.4 22:48:13 INFO - docopt == 0.6.1 22:48:13 INFO - manifestparser == 1.1 22:48:13 INFO - mozInstall == 1.12 22:48:13 INFO - mozcrash == 0.17 22:48:13 INFO - mozdebug == 0.1 22:48:13 INFO - mozdevice == 0.48 22:48:13 INFO - mozfile == 1.2 22:48:13 INFO - mozhttpd == 0.7 22:48:13 INFO - mozinfo == 0.9 22:48:13 INFO - mozleak == 0.1 22:48:13 INFO - mozlog == 3.1 22:48:13 INFO - moznetwork == 0.27 22:48:13 INFO - mozprocess == 0.22 22:48:13 INFO - mozprofile == 0.28 22:48:13 INFO - mozrunner == 6.11 22:48:13 INFO - mozscreenshot == 0.1 22:48:13 INFO - mozsystemmonitor == 0.0 22:48:13 INFO - moztest == 0.7 22:48:13 INFO - mozversion == 1.4 22:48:13 INFO - psutil == 3.1.1 22:48:13 INFO - requests == 1.2.3 22:48:13 INFO - wsgiref == 0.1.2 22:48:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90607e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4410>, '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 0x29f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f57a0>, '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': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', '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 22:48:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:48:13 INFO - Using env: {'DISPLAY': ':0', 22:48:13 INFO - 'HOME': '/home/cltbld', 22:48:13 INFO - 'LANG': 'en_US.UTF-8', 22:48:13 INFO - 'LANGUAGE': 'en_US:en', 22:48:13 INFO - 'LOGNAME': 'cltbld', 22:48:13 INFO - 'MAIL': '/var/mail/cltbld', 22:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:13 INFO - 'MOZ_NO_REMOTE': '1', 22:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:13 INFO - 'NO_EM_RESTART': '1', 22:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:13 INFO - 'PWD': '/builds/slave/test', 22:48:13 INFO - 'SHELL': '/bin/bash', 22:48:13 INFO - 'SHLVL': '1', 22:48:13 INFO - 'TERM': 'linux', 22:48:13 INFO - 'TMOUT': '86400', 22:48:13 INFO - 'USER': 'cltbld', 22:48:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', 22:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:13 INFO - '_': '/tools/buildbot/bin/python'} 22:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:48:13 INFO - Cleaning up... 22:48:13 INFO - Return code: 0 22:48:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90607e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4410>, '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 0x29f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f57a0>, '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': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', '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 22:48:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:48:13 INFO - Using env: {'DISPLAY': ':0', 22:48:13 INFO - 'HOME': '/home/cltbld', 22:48:13 INFO - 'LANG': 'en_US.UTF-8', 22:48:13 INFO - 'LANGUAGE': 'en_US:en', 22:48:13 INFO - 'LOGNAME': 'cltbld', 22:48:13 INFO - 'MAIL': '/var/mail/cltbld', 22:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:13 INFO - 'MOZ_NO_REMOTE': '1', 22:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:13 INFO - 'NO_EM_RESTART': '1', 22:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:13 INFO - 'PWD': '/builds/slave/test', 22:48:13 INFO - 'SHELL': '/bin/bash', 22:48:13 INFO - 'SHLVL': '1', 22:48:13 INFO - 'TERM': 'linux', 22:48:13 INFO - 'TMOUT': '86400', 22:48:13 INFO - 'USER': 'cltbld', 22:48:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', 22:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:13 INFO - '_': '/tools/buildbot/bin/python'} 22:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:13 INFO - Downloading/unpacking jsonschema 22:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:48:15 INFO - Downloading/unpacking functools32 (from jsonschema) 22:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:16 INFO - Downloading functools32-3.2.3-2.tar.gz 22:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:48:16 INFO - warning: no files found matching '*.txt' 22:48:16 INFO - no previously-included directories found matching 'build' 22:48:16 INFO - no previously-included directories found matching 'dist' 22:48:16 INFO - no previously-included directories found matching '.git*' 22:48:16 INFO - Installing collected packages: jsonschema, functools32 22:48:16 INFO - Running setup.py install for functools32 22:48:16 INFO - warning: no files found matching '*.txt' 22:48:16 INFO - no previously-included directories found matching 'build' 22:48:16 INFO - no previously-included directories found matching 'dist' 22:48:16 INFO - no previously-included directories found matching '.git*' 22:48:16 INFO - Successfully installed jsonschema functools32 22:48:16 INFO - Cleaning up... 22:48:16 INFO - Return code: 0 22:48:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90607e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4410>, '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 0x29f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f57a0>, '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': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', '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 22:48:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:48:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:48:16 INFO - Using env: {'DISPLAY': ':0', 22:48:16 INFO - 'HOME': '/home/cltbld', 22:48:16 INFO - 'LANG': 'en_US.UTF-8', 22:48:16 INFO - 'LANGUAGE': 'en_US:en', 22:48:16 INFO - 'LOGNAME': 'cltbld', 22:48:16 INFO - 'MAIL': '/var/mail/cltbld', 22:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:16 INFO - 'MOZ_NO_REMOTE': '1', 22:48:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:16 INFO - 'NO_EM_RESTART': '1', 22:48:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:16 INFO - 'PWD': '/builds/slave/test', 22:48:16 INFO - 'SHELL': '/bin/bash', 22:48:16 INFO - 'SHLVL': '1', 22:48:16 INFO - 'TERM': 'linux', 22:48:16 INFO - 'TMOUT': '86400', 22:48:16 INFO - 'USER': 'cltbld', 22:48:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', 22:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:16 INFO - '_': '/tools/buildbot/bin/python'} 22:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:16 INFO - Downloading/unpacking flake8 22:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:48:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:48:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:48:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:48:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:48:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:48:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:48:19 INFO - no previously-included directories found matching 'docs/_build' 22:48:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:48:19 INFO - Running setup.py install for pep8 22:48:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:48:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:48:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:48:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:48:19 INFO - no previously-included directories found matching 'docs/_build' 22:48:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:48:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:48:19 INFO - Cleaning up... 22:48:19 INFO - Return code: 0 22:48:19 INFO - Running post-action listener: _resource_record_post_action 22:48:19 INFO - Running post-action listener: _start_resource_monitoring 22:48:19 INFO - Starting resource monitoring. 22:48:19 INFO - ##### 22:48:19 INFO - ##### Running install step. 22:48:19 INFO - ##### 22:48:19 INFO - Running pre-action listener: _resource_record_pre_action 22:48:19 INFO - Running main action method: install 22:48:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:48:19 INFO - Reading from file tmpfile_stdout 22:48:19 INFO - Detecting whether we're running mozinstall >=1.0... 22:48:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:48:19 INFO - Reading from file tmpfile_stdout 22:48:19 INFO - Output received: 22:48:19 INFO - Usage: mozinstall [options] installer 22:48:19 INFO - Options: 22:48:19 INFO - -h, --help show this help message and exit 22:48:19 INFO - -d DEST, --destination=DEST 22:48:19 INFO - Directory to install application into. [default: 22:48:19 INFO - "/builds/slave/test"] 22:48:19 INFO - --app=APP Application being installed. [default: firefox] 22:48:19 INFO - mkdir: /builds/slave/test/build/application 22:48:19 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'] 22:48:19 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 22:48:35 INFO - Reading from file tmpfile_stdout 22:48:35 INFO - Output received: 22:48:35 INFO - /builds/slave/test/build/application/firefox/firefox 22:48:35 INFO - Running post-action listener: _resource_record_post_action 22:48:35 INFO - ##### 22:48:35 INFO - ##### Running run-tests step. 22:48:35 INFO - ##### 22:48:35 INFO - Running pre-action listener: _resource_record_pre_action 22:48:35 INFO - Running main action method: run_tests 22:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:48:35 INFO - Python 2.7.3 22:48:35 INFO - Return code: 0 22:48:35 INFO - grabbing minidump binary from tooltool 22:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:35 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 0x29f4410>, '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 0x29f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f57a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:48:35 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 22:48:35 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 22:48:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:48:35 INFO - Return code: 0 22:48:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:48:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:48:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:48:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:48:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:48:36 INFO - Return code: 0 22:48:36 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/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 22:48:36 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/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 22:48:36 INFO - Using env: {'DISPLAY': ':0', 22:48:36 INFO - 'HOME': '/home/cltbld', 22:48:36 INFO - 'LANG': 'en_US.UTF-8', 22:48:36 INFO - 'LANGUAGE': 'en_US:en', 22:48:36 INFO - 'LOGNAME': 'cltbld', 22:48:36 INFO - 'MAIL': '/var/mail/cltbld', 22:48:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:48:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:36 INFO - 'MOZ_NO_REMOTE': '1', 22:48:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:36 INFO - 'NO_EM_RESTART': '1', 22:48:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:36 INFO - 'PWD': '/builds/slave/test', 22:48:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:48:36 INFO - 'SHELL': '/bin/bash', 22:48:36 INFO - 'SHLVL': '1', 22:48:36 INFO - 'TERM': 'linux', 22:48:36 INFO - 'TMOUT': '86400', 22:48:36 INFO - 'USER': 'cltbld', 22:48:36 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722', 22:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:36 INFO - '_': '/tools/buildbot/bin/python'} 22:48:36 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/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 22:48:36 INFO - mozversion application_buildid: 20160529195147 22:48:36 INFO - mozversion application_changeset: ccf0f53adb66c86d81a39b53e32092489fb5f0b5 22:48:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:48:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:48:36 INFO - mozversion application_name: Firefox 22:48:36 INFO - mozversion application_remotingname: firefox-dev 22:48:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:48:36 INFO - mozversion application_vendor: Mozilla 22:48:36 INFO - mozversion application_version: 48.0a2 22:48:36 INFO - mozversion platform_buildid: 20160529195147 22:48:36 INFO - mozversion platform_changeset: ccf0f53adb66c86d81a39b53e32092489fb5f0b5 22:48:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:48:36 INFO - mozversion platform_version: 48.0a2 22:48:36 INFO - using testdate: 1464587316 22:48:36 INFO - actual date: 1464587316 22:48:36 INFO - starting webserver on 'localhost:54868' 22:48:36 INFO - SUITE-START | Running 2 tests 22:48:36 INFO - TEST-START | dromaeo_css 22:48:36 INFO - operating with platform_type : linux_ 22:48:36 INFO - Initialising browser for dromaeo_css test... 22:48:36 INFO - TEST-INFO | started process 413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplI5w3V/profile http://localhost:54868/getInfo.html) 22:48:40 INFO - PROCESS | 413 | __metrics Screen width/height:1600/1200 22:48:40 INFO - PROCESS | 413 | colorDepth:24 22:48:40 INFO - PROCESS | 413 | Browser inner width/height: 1024/697 22:48:40 INFO - PROCESS | 413 | __metrics 22:48:41 ERROR - PROCESS | 413 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:48:42 INFO - TEST-INFO | 413: exit 0 22:48:42 INFO - Browser initialized. 22:48:42 INFO - Running cycle 1/1 for dromaeo_css test... 22:48:42 INFO - TEST-INFO | started process 502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplI5w3V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:48:54 INFO - PROCESS | 502 | RSS: Main: 141647872 22:48:54 INFO - PROCESS | 502 | 22:49:45 INFO - PROCESS | 502 | 1464587385768 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] 22:51:52 INFO - PROCESS | 502 | Cycle 1(1): loaded http://localhost:54868/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54868/tests/dromaeo/cssquery-ext.html) 22:51:53 INFO - PROCESS | 502 | RSS: Main: 247513088 22:51:53 INFO - PROCESS | 502 | 22:54:55 INFO - PROCESS | 502 | Cycle 1(1): loaded http://localhost:54868/tests/dromaeo/cssquery-ext.html (next: http://localhost:54868/tests/dromaeo/cssquery-jquery.html) 22:54:56 INFO - PROCESS | 502 | RSS: Main: 222056448 22:54:56 INFO - PROCESS | 502 | 22:57:58 INFO - PROCESS | 502 | Cycle 1(1): loaded http://localhost:54868/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54868/tests/dromaeo/cssquery-mootools.html) 22:57:58 INFO - PROCESS | 502 | RSS: Main: 218857472 22:57:58 INFO - PROCESS | 502 | 23:01:00 INFO - PROCESS | 502 | Cycle 1(1): loaded http://localhost:54868/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54868/tests/dromaeo/cssquery-prototype.html) 23:01:01 INFO - PROCESS | 502 | RSS: Main: 219914240 23:01:01 INFO - PROCESS | 502 | 23:04:03 INFO - PROCESS | 502 | Cycle 1(1): loaded http://localhost:54868/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54868/tests/dromaeo/cssquery-yui.html) 23:04:04 INFO - PROCESS | 502 | RSS: Main: 183726080 23:04:04 INFO - PROCESS | 502 | 23:07:06 INFO - PROCESS | 502 | Cycle 1(1): loaded http://localhost:54868/tests/dromaeo/cssquery-yui.html (next: http://localhost:54868/tests/dromaeo/cssquery-dojo.html) 23:07:06 INFO - PROCESS | 502 | RSS: Main: 252768256 23:07:06 INFO - PROCESS | 502 | 23:07:06 INFO - PROCESS | 502 | __start_tp_report 23:07:06 INFO - PROCESS | 502 | _x_x_mozilla_page_load 23:07:06 INFO - PROCESS | 502 | _x_x_mozilla_page_load_details 23:07:06 INFO - PROCESS | 502 | |i|pagename|runs| 23:07:06 INFO - PROCESS | 502 | |0;dojo.html;3209.7432205423565;3294.5717056782614;3306.5866766654167;3324.202191474047;3357.043242675838;5292.206169074636;5304;5334.226537152111;5335.439778823226;5339.5461385782255;5347.331583552056;5357.812476563321;5360.115580929142;5370.5435038021815;5377.704226267554;4833.637477189207;4873.756312184385;4927.334809800667;4999.475055119196;5016.347874776274;4831.734254615994;4908.852734417973;4910.386201724785;4939.67892087015;5022.447530771612;5009.924851127236;5017.573506251973;5020.0712868119335;5021.422536408305;5050.621203409741;5008.1486147355035;5019.347484826949;5022.547970682656;5024.120778863702;5051.191809310511;4852.684575502581;4912.606991440712;4930.457649658535;4963.230699241623;4965.4041515018425;5285.339332583427;5287.629865909388;5288.894222115575;5302.0721373759825;5325.360956685184;5741.971290143564;5744.253247077853;5745.454181852718;5745.913811292792;5748.080307150836;5576.776928922838;5684.658920464744;5722.513586345124;5774.913376299359;5806.158107074492;5305.257263983007;5307.601929855237;5316.73416329182;5318.388385335697;5324.094903866313;5728.169415434739;5744.425557444222;5745.3105627324985;5745.683987380734;5764.193012978187;5461.918071228934;5632.549396048306;5645.491905728504;5698.800541981011;5753.194552762617;5777.566682498829;5799.159121927297;5805.216295800097;5807.303123625107;5808.82573522795;5635.6618602883955;5736.139579063174;5778.422157784188;5794.1308803679785;5796.42035796417;5597.524210442077;5626.099824028218;5650.0959846424375;5684.317881854204;5708.543316534668;4413.558644135625;4414.580614841585;4415.27148020573;4417.028253784162;4444.599986001275;3915.256101340736;3959.425883246971;3961.3463778476803;3975.860844870416;3995.820188091543;5496;5522.585806064561;5541.861453463695;5541.944580554224;5577.832665020056;5801.477866991991;5805.94194058054;5809.2738407699035;5816.1566572846705;5817.825465236049;5333.57331413486;5431.837044888581;5514.117741161395;5522.889542209134;5551.306086739158;4957.553820156131;4971.975140124277;4973.975130124326;4978.502149785065;4986.90026199474;5913.58604897653;5937.732802023919;5948.643081415129;5951.672658003765;5994.580379373489;5651.858703532444;5758.3090029196765;5780.653160810365;5857.355690874086;5880.235569376125;5969.761209551743;6007.3992600739575;6012.488938440281;6018.458338749533;6020.367861374492;5689.971550142222;5704.914426283526;5706.714664266853;5707.743151558273;5713.542916566747;5593.608447408642;5690.203371527907;5741.196232527366;5758.942410575841;5767.192593037062;5661.264035675335;5672.319321681424;5677.829665110054;5680.68756218412;5687.715614219355;5508.394076651645;5628;5632.183333416549;5636.098224284095;5637.041702910597;5460.31746031746;5516.393196748274;5526.972365138148;5531.917021244604;5566.805161819317;5609.214709940693;5640.689762063126;5641.464060914206;5646.604737668488;5649.37856835756;5458.399576046552;5490.972545137249;5533.916991245054;5543.113101903676;5545.417731138173 23:07:06 INFO - PROCESS | 502 | |1;ext.html;611.3855575146979;643.2313385504323;672.8654269146172;674.4536925090677;757.5833291689569;39472.210555788864;39901;39987.60012399879;40387.59612403875;40435.39346909799;39514;39978;39985.400218996736;40057.59942400582;40059.799701001524;7778.64996075178;8693.69572064978;8907.821843563157;8909.777255568597;10194.337368071088;10502.842457363146;10683.412412317319;10687.412192329419;10693.83959240612;10694.411807350592;10703.357798532074;10823.621173258938;10824.891751082507;10834.458277086114;10843.07833834125;8031.95984020082;10503.73740656482;10715.571377144905;10785.191110666692;10920.2901811382;10218.335808172445;10335.689929302132;10356.79286414275;10365.740856478573;10384.584616615326;40294.39558406626;40670.796646016875;40739.59260407388;40806.795966020276;40822;3714.220013797106;3793;3811.6378944000276;3902.180542086165;4043.939340909889;32035.839820800746;33383.49924751131;33421.6657833421;33481;33638.15904602405;4355.1072030234045;4457.153140903218;4457.821687132511;4466.70966387187;4473.261911784584;348213;348318;349451;350118;351381;35558.111047224025;62230.37769622246;62587.37412625906;62611.37388626146;62634;37180.81409592989;37345.25309493849;37359.626403735616;37387.69143080033;37399.62600373961;16423.5894102646;16639.916800416162;16652.666946661;16838.747418788727;16862.325506979585;12666.430010649543;12910.225386476654;13847;14155.29223538819;14390.85609143895;8558.400911936105;8591.05498395176;8620.655173792979;8631.352648551383;8643.78390540229;3464.5842498899788;3504.491848681927;3506.63180366063;3531.8410671519327;3538.9469157962653;1115.2694984784978;1149.51720277482;1179.6343133628602;1234.8456442944632;1253.5424570031873;33242.50136247958;33425.83287083549;33564.49653255203;34352.48471272933;34404.48393274103;1187.4597058338609;1189.5717541684987;1196.8085106382937;1231.3166192762924;1315.3160356614508;17809.643807123786;17888.642227155644;18066.90966545159;18143.818561814478;18153.546161346072;438235;443561;444038;444242;446084;61821;62598.37401625925;62615;62642;62701.372986270464;1420.8953436740549;1487.5611694550134;1489.7541905585674;1496.895217334798;1549.147968617256;30329.69670303357;31254.374912502077;31886.681133188373;33133.33733325368;34569;49989.75005124951;50050.74974625104;50298.74850625724;50397.74801125971;50453;301126;302830;303571;303769;304113;26969.303069692873;29866.850665746533;30121.548176776927;30313.848430757706;30459.847700761355;48345.03309933852;49094.26358604695;49096.2635560474;50104.498955009985;50501.2124090702;40394;41026.38460423036;41090.1781964365;41567.58432415758;42767.14465710606;40069.398959016224;40869.79565102155;41202.38196427116;41798.373024405264;42102.36846447244;42459.36310955277;43123.784381077894;43279;43605.56394436015;43749;35400.46899296564;36696.26607467782;37295.25409491849;37481.81259093687;37808.810955945046;28212.153635390972;28375.71624283731;28617;28787.28031799222;28928 23:07:06 INFO - PROCESS | 502 | |2;jquery.html;431.4434379650251;432.99134017319636;435.27309393313175;442.1863770661982;446.32381941358824;18467.722984155233;18622.53443663909;18965.52586185346;18986.145623446944;19287.324943626976;16738.41415550456;17160.82839171608;17371.30514779407;17408.390706325248;17437.651246975052;5297.417284098756;5408.702521361323;5460.945390546083;5552.500274975251;5824.126381042835;5776.508996735282;5796.275465566804;5828.737706803204;5829.475347218749;5837.387074357174;5622.240997465331;5743.798967036155;5807.651540907538;5810.680412577307;5892.351841297454;5903;5920.526357891358;5923.348431672513;5958.6424814511265;5961.225040744697;5742.712864356808;5776.104703770922;5787.681677507735;5792.68140252286;5810.535157187415;13671;14228.92885535576;14305.499307524187;14346.928265358607;14557.344919478648;2412.9396765080837;2499.487605040962;2509.836860604055;2579.729128441524;2586.702529209146;10305.381677099398;10749.83875241872;12407.379631018413;12937.741245175044;14550.636234094127;2030.5735795482967;2052.640787862118;2054.3734161080865;2142.517933464958;2167.9241226556996;67584.6620766898;68833;78327.99999999943;79743;83401;10508.159347252202;10509.737256568647;10540.262181647211;10614.734631634117;10699.73250668724;14354.56936291892;14363.497277595234;14381.352839122264;14403.78394324086;14411.279436028157;8366.665333386596;8695.913040869636;8744.825103498022;8769.649214031368;8811.867821982676;8118.903947967067;8404.159584041547;8654;8905.777355566033;8986.236169925629;4450.621697155713;4539.455265368177;4596.609288210473;4640;4706.10583989041;1872.6816441205028;2027.5336672565393;2072.896355182235;2111.4826867417582;2174.173813950689;1008.2740426892625;1010.6058637131524;1069.316582364729;1122.7810576937582;1197.1021733699724;18454.169562369727;18742;19181.904090479737;19200.519987000436;19439.416817495498;1024.2318261304022;1039.34521251611;1072.1529991306936;1106.2145876427826;1135.9318440893574;10549.47252637365;10612.522436490377;10938.56245750177;10951.705396926864;11117.499712512956;501340;505611;511628;512977;525288;93797.5310123445;95416;95697;95818.52090739501;96298;1141.372245265101;1160.3733983648904;1170.163333216737;1184.5972369394447;1185.4013723069968;17207.46116475731;17457.738133928255;17644.0295783728;17654.823451765318;17768.644627107646;41117.383239252034;41263.1747365057;41683.7915810419;42042;42729.359059614755;56807;58396.12405814001;58604.4139558599;58997.11504327524;59072.70463647654;8678.78303042429;8701.086385929386;8807.383483156118;8908.86636700437;8926.196642301964;9801.754956126153;12708.046896482985;12722;12931.28877911724;12984;11100.555977761122;11538.82691759641;11551.942240288745;11970.700732481757;11991.82012269834;10893.400862952614;10955.56177752881;11079.50142243585;11267.887321126684;11548.94225528867;11533.88466115328;11545.36500492481;11734.589289374831;12101.455434505644;12230.388480576114;8674.015277812287;8784.121587841164;8802.383833131875;8856.512891791013;8962.775930601787;10826.458677066274;11329.660110196708;11488.19582629208;11617.767644647229;11726.00328972047 23:07:06 INFO - PROCESS | 502 | |3;mootools.html;1357.7759669654508;1517.4537166620014;1577.9605509862256;1780.6171673090291;1871.9344822931191;8223.054348749896;8427.662893484261;8440.282575981033;8442.029166645838;8447.113053129426;8187.38594605404;8385;8385.077641459435;8387.538685372301;8399.572072747633;2076.636588596997;2114.4925217947734;2316.8609883406966;2387.904483820645;2422.588160012802;2351.282858728096;2363.0665886974634;2369.431336479241;2370.0282884017556;2370.3126093432884;2320.477892474197;2332.4052366646483;2400.867952262625;2401.939951501209;2403.6034054381007;2070.2650559051544;2309.7574754650773;2320.535892821434;2351.5296940611947;2356.5169140326193;2311.780380863815;2330.1611419888827;2345.2729653807205;2352.188494969233;2353.729321128075;8055.718049868226;8070.798230044237;8099.473534220257;8117.675292988273;8137.186281371815;4928.408590969107;5072.264521644378;5079.898402031976;5081.771320290596;5083.974580127076;3305.619853716805;3325.0523600773663;3346.1300061983816;3372.7133193678565;3384.6615338466204;1055.6832950114936;1142.2689478733616;1143.1540659911689;1144.090448093759;1161.1581603337597;11444.828327575093;11509.827352589718;11519.42402879861;11536.711582210428;11550.768984620345;4417.293233082692;4442.53353397895;4494.52807455219;4517.457905051349;4535.387722657399;9863.704088877344;9864.704058878102;9878.16035636979;9883.209343252522;9891.604335826487;5095.719735414587;5146.382434107931;5151.0470562945975;5154.329937108227;5164.715940623302;4152.314868046798;4711.175544279738;4738.3129446230105;4795.376601041842;4798.712077275374;4126.979365103215;4131.194417088699;4165.166966606691;4198.6221240088535;4296.9570304297185;1365.9726805463836;1390.332640332646;1391.1792042694656;1418.08558446099;1419.7657386531107;910.3809409601535;1025.9281850270409;1037.8339465685453;1046.042870773234;1060.9098226650667;5926.170336152942;5984.700764961734;5998.040313549811;6003.279606447254;6116.785912493041;899.9820003599891;934.6121359635811;969.7721035556639;1050.9018076110483;1081.0540776820283;4011.2980228460488;4086.1214838809206;4100.6924480664065;4105.8973525662095;4153.252414565407;10486.842697359545;10891.128709703205;10891.564337426573;10915.290506117077;10932.508037138348;10063.295569310225;10706.036456718777;10769.569217231223;10771.946140269405;10778.353298802096;8248;8397.496150230883;8441.15588441151;8447.070822209553;8460.746177614681;5787.739551720267;5922.348541660328;5964.373740757158;5975.641461512323;6007;9465.66870159541;9527.904720952702;9691;9697.127258546765;9712.805743884941;9506.47714375716;9831.410115393099;9845.950770246389;9864.210863131077;9888.258380621626;6743.831404214934;7099.680514376762;7329.596872172082;7626.3898888089925;7745.612719363897;8268.627911744106;8270.875936860832;8298.668053278043;8327.292180164754;8338.416310858423;7101.644917754195;7272.309130632581;7421.183669796426;7483.476156668981;7640.121386040454;7385.593792341473;7483.513571617827;7489.176190618919;7585.924140758521;7593.088829340514;6900.447964162955;6921.377076063179;6959.130108736408;6973.860522789617;6981.650917454005;4958.57852082577;4998.025385050026;5033.597312214941;5043.167877300204;5107.668001579886;5033.39599248078;5119.539241468286;5194.636375453682;5211.921821172761;5306.946930530646 23:07:06 INFO - PROCESS | 502 | |4;prototype.html;357.5119961252889;362.22483884487184;362.3369234301228;366.0975694912041;367.7646306363928;6194.411530904563;6262.592931459458;6330.65181415022;6333.683315834213;6344.936550634492;5934.940650593493;6079.63522188669;6213.378662133796;6236.656983865885;6293.0875023121735;4801.759912004403;4807.18277892759;4826.589739872106;4841.757912104398;4841.830535931225;4807.110684523374;4819.204831202847;4821.590164835993;4823.42118945727;4847.636427267951;4564.7945842437;4662.230731929245;4671.719696818202;4671.85984420468;4795.400574928134;4801.831935882227;4819.891424972276;4822.63830212732;4828.396450443694;4836.588889944376;4241.660667146621;4261.083866968585;4269.978650106761;4270.316749320125;4270.850520231808;5952.601138732438;5987.431194036603;6001.66990815505;6003.579749417542;6028.909566356509;5628.521575666074;5629.80295689653;5632.098864181711;5633.211350410946;5638.111232737038;6453.612783233021;6582;6586.27550969393;6587.176602924635;6616.4376028037195;4733.360996265495;4746.572808447257;4747.382840230783;4763.69036012658;4764.737939413331;6895.827604309882;6900.585964842076;6901.1718593769065;6904.758333458305;6909.7581584644295;4863.975680121577;4865.270209468537;4868.367112275381;4871.683340582851;4872.610191184696;4934.1611925972675;4935.925961110586;4939.456659767423;4941.085899108676;4941.48114447985;5466.398696143421;5533.474319939599;5533.474319939599;5537.723113844291;5615.438456154352;6578.736850525926;6604.174478190226;6609.306022867626;6622.86754264912;6629.03878937561;1627.788387509616;1703.3186725309727;1737.4700716281654;1739.9826001740073;1743.015196414022;1143.822707480342;1174.3775798826637;1183.5739133911784;1188.3048416676168;1191.4995701805262;6385.936140638627;6388.648624325614;6397.168368112209;6399.264084630234;6411.551191416649;6748.628825414551;6753.054572359873;6766.966165169143;6769.966150169218;6773.356531129535;6359.523035772336;6362.459190968727;6369.331220221903;6372.267189273293;6374.936250637527;3617.565892092913;3648.8175591220865;3651.9634803652157;3659.304732100892;3664.0656632558525;6795.762148324785;6922.134733158356;6995.4753393494675;6997.635461085039;7010.894836577456;6786.660666966632;6826.488013399015;6842.349976752201;6859.108315918898;6864.519483636098;6955.791326260221;6986.9650651746415;6990.405815505739;6992.580445173306;7002.649867506604;6745.325467453215;6752.662366881735;6760.797176084725;6762.053312536347;6767.492438067066;6602.316409315594;6662.267150613332;6676.99845023231;6846.554973926679;6863.725450981905;7009.7897063088185;7054.506184567031;7113.0753002109395;7143.82140446493;7192.029076074872;4730.716157030589;4771.427428708577;4774.546418090275;4777.737224452689;4779.259214821708;6623.437007854193;6914.481413893877;6917.481188910952;6923.273056329214;6932.202796678446;6587.4071333580205;6696.933030669826;6737.854564724107;6747.325267473409;6767.323267673193;6603.537752357289;6683.264840867598;6691.263960964193;6704.765333213314;6716.83207919806;6589.571677840925;6601.933980660132;6603.537752357289;6606.405423511907;6607.108040414675;6608.207015158212;6736;6739.59562426256;6743.055972163803;6760.1211842462135;6478.643674597943;6556.63938483388;6586.604803711793;6588.934110659024;6589.17635295588 23:07:06 INFO - PROCESS | 502 | |5;yui.html;826.8635675113607;838.4759525296694;888.4047688049006;909.0818273543719;910.2763303173977;13926.442942282309;13994.650133746662;14294;14299.356528956196;14309.642258943531;12992.675183120427;13038.60884173474;13039.087263891532;13056.869431305684;13087.1493352932;747.9887801682979;754.2645920227789;754.6981207517009;901.7970956534776;908.2506931781273;762.9580373079478;876.3909083187187;888.1074520107284;889.5774507109136;889.8086911314066;932.2868005975434;944.4239014201331;944.4710961861346;944.5560586524323;946.5125460387906;790.4980337485681;938.366602543284;940.3041749105681;942.0532364973193;942.8679984802134;680.1701923653135;691.5815931361554;692.069166970424;692.3491917597443;692.3526502719923;13485.662858428519;13515.729685406335;13546.864531354757;13586.456541738318;13599.864001359958;13411.195328280237;14074.929625351808;14104.858951410457;14218.360173792204;14352;10950;11112.388818614972;11469.483873225725;11481.770364592745;11558.133140014532;3901.2977664020464;3972.503437070366;4014.2573623879384;4087.4073259377224;4101.589841015904;56617.71691141559;56660;56719;57125.14312285277;57274.42725572774;10520.842187367196;10686.679399618024;10757.139428845674;10801.24391292602;10922.344659320308;18850.24599016024;18966.43100706981;18987.43037708871;19015.524611884535;19017.80982190188;8090.878636820453;8180.877286840702;8407.45351552147;8501.14988501145;8502.319814414832;4631.258998560282;4771.66598338113;4842.612590992712;4852.441969173519;5009.0482808266315;3331.816750078769;3373.2916087621384;3374.5950485941353;3374.6794054564775;3378;599.7331187621554;604.431834075976;607.5929127484596;612.9938700612937;621.471749013344;578.7800635758385;631.7378288010424;649.5420728386571;658.134553062721;662.9138212032404;8906.910930890737;9135.451872887515;9326.906730932604;9364.014858766841;9516.857247141299;688.8828899087167;702.2591166319581;719.4352433339803;743.2344684974485;784.8312612788278;4208.768517731554;4365.847195348148;4375.387445757597;4707.929381059287;4799.352087468147;63488;63840;68929.31070689228;69675.65162174258;69762.65118674374;56711;57631.42368576261;58192.12711809326;58597.70701146467;58840.411595883495;50578.747106264236;51276.74361628168;51281.48718512767;51675.99999999925;52310.21534676983;9337.906620933703;9445.811083778424;9517.381370210915;9582.520873956135;9655.758606034624;35659.82170089133;36984.50065726045;37109.07227319231;37377.81311093427;39509.80245098871;48206.27690584714;48987.265191022874;48999;49322.50677493323;49877.50122498874;12122.393880305774;12165.69585760363;12169.39153042362;12328.07539434564;12546.686332841751;13716;13860;13874.306284685523;14031.719365612835;14040.578782636538;12637.747245054863;12849.807252891402;12870.292133932724;12888.162269452456;13056.34718264064;12126.393680316125;12168.634940951786;12283;12647.494100235888;12845.165064270792;12542.623721288375;12568.371581421075;12624.74750505003;12879.093111287148;12977.286249256003;9571.33000689945;9630.47032413224;9813.9018609813;10242.334248273839;11082.944585277022;10400.375977441377;10437.21720870953;10564.366138031743;10579.94710026445;10615.89384106149 23:07:06 INFO - PROCESS | 502 | __end_tp_report 23:07:06 INFO - PROCESS | 502 | __start_cc_report 23:07:06 INFO - PROCESS | 502 | _x_x_mozilla_cycle_collect,860 23:07:06 INFO - PROCESS | 502 | __end_cc_report 23:07:06 INFO - PROCESS | 502 | __startTimestamp1464588426922__endTimestamp 23:07:06 INFO - PROCESS | 502 | 23:07:06 INFO - PROCESS | 502 | ------- Summary: start ------- 23:07:06 INFO - PROCESS | 502 | Number of tests: 6 23:07:06 INFO - PROCESS | 502 | 23:07:06 INFO - PROCESS | 502 | [#0] dojo.html Cycles:165 Average:5356.05 Median:5543.11 stddev:572.34 (10.3%) stddev-sans-first:548.77 23:07:06 INFO - PROCESS | 502 | Values: 3209.7 3294.6 3306.6 3324.2 3357.0 5292.2 5304.0 5334.2 5335.4 5339.5 5347.3 5357.8 5360.1 5370.5 5377.7 4833.6 4873.8 4927.3 4999.5 5016.3 4831.7 4908.9 4910.4 4939.7 5022.4 5009.9 5017.6 5020.1 5021.4 5050.6 5008.1 5019.3 5022.5 5024.1 5051.2 4852.7 4912.6 4930.5 4963.2 4965.4 5285.3 5287.6 5288.9 5302.1 5325.4 5742.0 5744.3 5745.5 5745.9 5748.1 5576.8 5684.7 5722.5 5774.9 5806.2 5305.3 5307.6 5316.7 5318.4 5324.1 5728.2 5744.4 5745.3 5745.7 5764.2 5461.9 5632.5 5645.5 5698.8 5753.2 5777.6 5799.2 5805.2 5807.3 5808.8 5635.7 5736.1 5778.4 5794.1 5796.4 5597.5 5626.1 5650.1 5684.3 5708.5 4413.6 4414.6 4415.3 4417.0 4444.6 3915.3 3959.4 3961.3 3975.9 3995.8 5496.0 5522.6 5541.9 5541.9 5577.8 5801.5 5805.9 5809.3 5816.2 5817.8 5333.6 5431.8 5514.1 5522.9 5551.3 4957.6 4972.0 4974.0 4978.5 4986.9 5913.6 5937.7 5948.6 5951.7 5994.6 5651.9 5758.3 5780.7 5857.4 5880.2 5969.8 6007.4 6012.5 6018.5 6020.4 5690.0 5704.9 5706.7 5707.7 5713.5 5593.6 5690.2 5741.2 5758.9 5767.2 5661.3 5672.3 5677.8 5680.7 5687.7 5508.4 5628.0 5632.2 5636.1 5637.0 5460.3 5516.4 5527.0 5531.9 5566.8 5609.2 5640.7 5641.5 5646.6 5649.4 5458.4 5491.0 5533.9 5543.1 5545.4 23:07:06 INFO - PROCESS | 502 | 23:07:06 INFO - PROCESS | 502 | [#1] ext.html Cycles:180 Average:53258.30 Median:35479.29 stddev:97441.15 (274.6%) stddev-sans-first:97634.32 23:07:06 INFO - PROCESS | 502 | Values: 611.4 643.2 672.9 674.5 757.6 39472.2 39901.0 39987.6 40387.6 40435.4 39514.0 39978.0 39985.4 40057.6 40059.8 7778.6 8693.7 8907.8 8909.8 10194.3 10502.8 10683.4 10687.4 10693.8 10694.4 10703.4 10823.6 10824.9 10834.5 10843.1 8032.0 10503.7 10715.6 10785.2 10920.3 10218.3 10335.7 10356.8 10365.7 10384.6 40294.4 40670.8 40739.6 40806.8 40822.0 3714.2 3793.0 3811.6 3902.2 4043.9 32035.8 33383.5 33421.7 33481.0 33638.2 4355.1 4457.2 4457.8 4466.7 4473.3 348213.0 348318.0 349451.0 350118.0 351381.0 35558.1 62230.4 62587.4 62611.4 62634.0 37180.8 37345.3 37359.6 37387.7 37399.6 16423.6 16639.9 16652.7 16838.7 16862.3 12666.4 12910.2 13847.0 14155.3 14390.9 8558.4 8591.1 8620.7 8631.4 8643.8 3464.6 3504.5 3506.6 3531.8 3538.9 1115.3 1149.5 1179.6 1234.8 1253.5 33242.5 33425.8 33564.5 34352.5 34404.5 1187.5 1189.6 1196.8 1231.3 1315.3 17809.6 17888.6 18066.9 18143.8 18153.5 438235.0 443561.0 444038.0 444242.0 446084.0 61821.0 62598.4 62615.0 62642.0 62701.4 1420.9 1487.6 1489.8 1496.9 1549.1 30329.7 31254.4 31886.7 33133.3 34569.0 49989.8 50050.7 50298.7 50397.7 50453.0 301126.0 302830.0 303571.0 303769.0 304113.0 26969.3 29866.9 30121.5 30313.8 30459.8 48345.0 49094.3 49096.3 50104.5 50501.2 40394.0 41026.4 41090.2 41567.6 42767.1 40069.4 40869.8 41202.4 41798.4 42102.4 42459.4 43123.8 43279.0 43605.6 43749.0 35400.5 36696.3 37295.3 37481.8 37808.8 28212.2 28375.7 28617.0 28787.3 28928.0 23:07:06 INFO - PROCESS | 502 | 23:07:06 INFO - PROCESS | 502 | [#2] jquery.html Cycles:180 Average:29286.32 Median:2127.00 stddev:84231.26 (3960.1%) stddev-sans-first:84439.68 23:07:06 INFO - PROCESS | 502 | Values: 431.4 433.0 435.3 442.2 446.3 18467.7 18622.5 18965.5 18986.1 19287.3 16738.4 17160.8 17371.3 17408.4 17437.7 5297.4 5408.7 5460.9 5552.5 5824.1 5776.5 5796.3 5828.7 5829.5 5837.4 5622.2 5743.8 5807.7 5810.7 5892.4 5903.0 5920.5 5923.3 5958.6 5961.2 5742.7 5776.1 5787.7 5792.7 5810.5 13671.0 14228.9 14305.5 14346.9 14557.3 2412.9 2499.5 2509.8 2579.7 2586.7 10305.4 10749.8 12407.4 12937.7 14550.6 2030.6 2052.6 2054.4 2142.5 2167.9 67584.7 68833.0 78328.0 79743.0 83401.0 10508.2 10509.7 10540.3 10614.7 10699.7 14354.6 14363.5 14381.4 14403.8 14411.3 8366.7 8695.9 8744.8 8769.6 8811.9 8118.9 8404.2 8654.0 8905.8 8986.2 4450.6 4539.5 4596.6 4640.0 4706.1 1872.7 2027.5 2072.9 2111.5 2174.2 1008.3 1010.6 1069.3 1122.8 1197.1 18454.2 18742.0 19181.9 19200.5 19439.4 1024.2 1039.3 1072.2 1106.2 1135.9 10549.5 10612.5 10938.6 10951.7 11117.5 501340.0 505611.0 511628.0 512977.0 525288.0 93797.5 95416.0 95697.0 95818.5 96298.0 1141.4 1160.4 1170.2 1184.6 1185.4 17207.5 17457.7 17644.0 17654.8 17768.6 41117.4 41263.2 41683.8 42042.0 42729.4 56807.0 58396.1 58604.4 58997.1 59072.7 8678.8 8701.1 8807.4 8908.9 8926.2 9801.8 12708.0 12722.0 12931.3 12984.0 11100.6 11538.8 11551.9 11970.7 11991.8 10893.4 10955.6 11079.5 11267.9 11548.9 11533.9 11545.4 11734.6 12101.5 12230.4 8674.0 8784.1 8802.4 8856.5 8962.8 10826.5 11329.7 11488.2 11617.8 11726.0 23:07:06 INFO - PROCESS | 502 | 23:07:06 INFO - PROCESS | 502 | [#3] mootools.html Cycles:180 Average:5660.25 Median:5038.38 stddev:3128.16 (62.1%) stddev-sans-first:3120.22 23:07:06 INFO - PROCESS | 502 | Values: 1357.8 1517.5 1578.0 1780.6 1871.9 8223.1 8427.7 8440.3 8442.0 8447.1 8187.4 8385.0 8385.1 8387.5 8399.6 2076.6 2114.5 2316.9 2387.9 2422.6 2351.3 2363.1 2369.4 2370.0 2370.3 2320.5 2332.4 2400.9 2401.9 2403.6 2070.3 2309.8 2320.5 2351.5 2356.5 2311.8 2330.2 2345.3 2352.2 2353.7 8055.7 8070.8 8099.5 8117.7 8137.2 4928.4 5072.3 5079.9 5081.8 5084.0 3305.6 3325.1 3346.1 3372.7 3384.7 1055.7 1142.3 1143.2 1144.1 1161.2 11444.8 11509.8 11519.4 11536.7 11550.8 4417.3 4442.5 4494.5 4517.5 4535.4 9863.7 9864.7 9878.2 9883.2 9891.6 5095.7 5146.4 5151.0 5154.3 5164.7 4152.3 4711.2 4738.3 4795.4 4798.7 4127.0 4131.2 4165.2 4198.6 4297.0 1366.0 1390.3 1391.2 1418.1 1419.8 910.4 1025.9 1037.8 1046.0 1060.9 5926.2 5984.7 5998.0 6003.3 6116.8 900.0 934.6 969.8 1050.9 1081.1 4011.3 4086.1 4100.7 4105.9 4153.3 10486.8 10891.1 10891.6 10915.3 10932.5 10063.3 10706.0 10769.6 10771.9 10778.4 8248.0 8397.5 8441.2 8447.1 8460.7 5787.7 5922.3 5964.4 5975.6 6007.0 9465.7 9527.9 9691.0 9697.1 9712.8 9506.5 9831.4 9846.0 9864.2 9888.3 6743.8 7099.7 7329.6 7626.4 7745.6 8268.6 8270.9 8298.7 8327.3 8338.4 7101.6 7272.3 7421.2 7483.5 7640.1 7385.6 7483.5 7489.2 7585.9 7593.1 6900.4 6921.4 6959.1 6973.9 6981.7 4958.6 4998.0 5033.6 5043.2 5107.7 5033.4 5119.5 5194.6 5211.9 5306.9 23:07:06 INFO - PROCESS | 502 | 23:07:06 INFO - PROCESS | 502 | [#4] prototype.html Cycles:180 Average:5564.60 Median:6360.99 stddev:1648.36 (25.9%) stddev-sans-first:1605.98 23:07:06 INFO - PROCESS | 502 | Values: 357.5 362.2 362.3 366.1 367.8 6194.4 6262.6 6330.7 6333.7 6344.9 5934.9 6079.6 6213.4 6236.7 6293.1 4801.8 4807.2 4826.6 4841.8 4841.8 4807.1 4819.2 4821.6 4823.4 4847.6 4564.8 4662.2 4671.7 4671.9 4795.4 4801.8 4819.9 4822.6 4828.4 4836.6 4241.7 4261.1 4270.0 4270.3 4270.9 5952.6 5987.4 6001.7 6003.6 6028.9 5628.5 5629.8 5632.1 5633.2 5638.1 6453.6 6582.0 6586.3 6587.2 6616.4 4733.4 4746.6 4747.4 4763.7 4764.7 6895.8 6900.6 6901.2 6904.8 6909.8 4864.0 4865.3 4868.4 4871.7 4872.6 4934.2 4935.9 4939.5 4941.1 4941.5 5466.4 5533.5 5533.5 5537.7 5615.4 6578.7 6604.2 6609.3 6622.9 6629.0 1627.8 1703.3 1737.5 1740.0 1743.0 1143.8 1174.4 1183.6 1188.3 1191.5 6385.9 6388.6 6397.2 6399.3 6411.6 6748.6 6753.1 6767.0 6770.0 6773.4 6359.5 6362.5 6369.3 6372.3 6374.9 3617.6 3648.8 3652.0 3659.3 3664.1 6795.8 6922.1 6995.5 6997.6 7010.9 6786.7 6826.5 6842.3 6859.1 6864.5 6955.8 6987.0 6990.4 6992.6 7002.6 6745.3 6752.7 6760.8 6762.1 6767.5 6602.3 6662.3 6677.0 6846.6 6863.7 7009.8 7054.5 7113.1 7143.8 7192.0 4730.7 4771.4 4774.5 4777.7 4779.3 6623.4 6914.5 6917.5 6923.3 6932.2 6587.4 6696.9 6737.9 6747.3 6767.3 6603.5 6683.3 6691.3 6704.8 6716.8 6589.6 6601.9 6603.5 6606.4 6607.1 6608.2 6736.0 6739.6 6743.1 6760.1 6478.6 6556.6 6586.6 6588.9 6589.2 23:07:06 INFO - PROCESS | 502 | 23:07:06 INFO - PROCESS | 502 | [#5] yui.html Cycles:180 Average:15312.70 Median:4847.53 stddev:18183.44 (375.1%) stddev-sans-first:18201.91 23:07:06 INFO - PROCESS | 502 | Values: 826.9 838.5 888.4 909.1 910.3 13926.4 13994.7 14294.0 14299.4 14309.6 12992.7 13038.6 13039.1 13056.9 13087.1 748.0 754.3 754.7 901.8 908.3 763.0 876.4 888.1 889.6 889.8 932.3 944.4 944.5 944.6 946.5 790.5 938.4 940.3 942.1 942.9 680.2 691.6 692.1 692.3 692.4 13485.7 13515.7 13546.9 13586.5 13599.9 13411.2 14074.9 14104.9 14218.4 14352.0 10950.0 11112.4 11469.5 11481.8 11558.1 3901.3 3972.5 4014.3 4087.4 4101.6 56617.7 56660.0 56719.0 57125.1 57274.4 10520.8 10686.7 10757.1 10801.2 10922.3 18850.2 18966.4 18987.4 19015.5 19017.8 8090.9 8180.9 8407.5 8501.1 8502.3 4631.3 4771.7 4842.6 4852.4 5009.0 3331.8 3373.3 3374.6 3374.7 3378.0 599.7 604.4 607.6 613.0 621.5 578.8 631.7 649.5 658.1 662.9 8906.9 9135.5 9326.9 9364.0 9516.9 688.9 702.3 719.4 743.2 784.8 4208.8 4365.8 4375.4 4707.9 4799.4 63488.0 63840.0 68929.3 69675.7 69762.7 56711.0 57631.4 58192.1 58597.7 58840.4 50578.7 51276.7 51281.5 51676.0 52310.2 9337.9 9445.8 9517.4 9582.5 9655.8 35659.8 36984.5 37109.1 37377.8 39509.8 48206.3 48987.3 48999.0 49322.5 49877.5 12122.4 12165.7 12169.4 12328.1 12546.7 13716.0 13860.0 13874.3 14031.7 14040.6 12637.7 12849.8 12870.3 12888.2 13056.3 12126.4 12168.6 12283.0 12647.5 12845.2 12542.6 12568.4 12624.7 12879.1 12977.3 9571.3 9630.5 9813.9 10242.3 11082.9 10400.4 10437.2 10564.4 10579.9 10615.9 23:07:06 INFO - PROCESS | 502 | -------- Summary: end -------- 23:07:06 INFO - PROCESS | 502 | 23:07:07 INFO - TEST-INFO | 502: exit 0 23:07:07 INFO - TEST-OK | dromaeo_css | took 1111058ms 23:07:07 INFO - TEST-START | kraken 23:07:07 INFO - operating with platform_type : linux_ 23:07:07 INFO - Initialising browser for kraken test... 23:07:07 INFO - TEST-INFO | started process 703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphhNbDN/profile http://localhost:54868/getInfo.html) 23:07:11 INFO - PROCESS | 703 | __metrics Screen width/height:1600/1200 23:07:11 INFO - PROCESS | 703 | colorDepth:24 23:07:11 INFO - PROCESS | 703 | Browser inner width/height: 1024/697 23:07:11 INFO - PROCESS | 703 | __metrics 23:07:12 ERROR - PROCESS | 703 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:07:13 INFO - TEST-INFO | 703: exit 0 23:07:13 INFO - Browser initialized. 23:07:13 INFO - Running cycle 1/1 for kraken test... 23:07:13 INFO - TEST-INFO | started process 796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphhNbDN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:07:25 INFO - PROCESS | 796 | RSS: Main: 141967360 23:07:25 INFO - PROCESS | 796 | 23:07:27 INFO - PROCESS | 796 | Cycle 1(1): loaded http://localhost:54868/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54868/tests/kraken/driver.html?testName=audio-beat-detection) 23:07:28 INFO - PROCESS | 796 | RSS: Main: 197029888 23:07:28 INFO - PROCESS | 796 | 23:07:31 INFO - PROCESS | 796 | Cycle 1(1): loaded http://localhost:54868/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54868/tests/kraken/driver.html?testName=audio-dft) 23:07:31 INFO - PROCESS | 796 | RSS: Main: 181452800 23:07:31 INFO - PROCESS | 796 | 23:07:34 INFO - PROCESS | 796 | Cycle 1(1): loaded http://localhost:54868/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54868/tests/kraken/driver.html?testName=audio-fft) 23:07:35 INFO - PROCESS | 796 | RSS: Main: 272728064 23:07:35 INFO - PROCESS | 796 | 23:07:37 INFO - PROCESS | 796 | Cycle 1(1): loaded http://localhost:54868/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54868/tests/kraken/driver.html?testName=audio-oscillator) 23:07:37 INFO - PROCESS | 796 | RSS: Main: 178073600 23:07:37 INFO - PROCESS | 796 | 23:07:40 INFO - PROCESS | 796 | Cycle 1(1): loaded http://localhost:54868/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54868/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:07:40 INFO - PROCESS | 796 | RSS: Main: 176873472 23:07:40 INFO - PROCESS | 796 | 23:07:43 INFO - PROCESS | 796 | Cycle 1(1): loaded http://localhost:54868/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54868/tests/kraken/driver.html?testName=imaging-darkroom) 23:07:44 INFO - PROCESS | 796 | RSS: Main: 211668992 23:07:44 INFO - PROCESS | 796 | 23:07:47 INFO - PROCESS | 796 | Cycle 1(1): loaded http://localhost:54868/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54868/tests/kraken/driver.html?testName=imaging-desaturate) 23:07:48 INFO - PROCESS | 796 | RSS: Main: 211873792 23:07:48 INFO - PROCESS | 796 | 23:07:50 INFO - PROCESS | 796 | Cycle 1(1): loaded http://localhost:54868/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54868/tests/kraken/driver.html?testName=json-parse-financial) 23:07:51 INFO - PROCESS | 796 | RSS: Main: 211394560 23:07:51 INFO - PROCESS | 796 | 23:07:53 INFO - PROCESS | 796 | Cycle 1(1): loaded http://localhost:54868/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54868/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:07:53 INFO - PROCESS | 796 | RSS: Main: 191279104 23:07:53 INFO - PROCESS | 796 | 23:07:55 INFO - PROCESS | 796 | Cycle 1(1): loaded http://localhost:54868/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54868/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:07:55 INFO - PROCESS | 796 | RSS: Main: 194678784 23:07:55 INFO - PROCESS | 796 | 23:07:57 INFO - PROCESS | 796 | Cycle 1(1): loaded http://localhost:54868/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54868/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:07:58 INFO - PROCESS | 796 | RSS: Main: 207097856 23:07:58 INFO - PROCESS | 796 | 23:08:00 INFO - PROCESS | 796 | Cycle 1(1): loaded http://localhost:54868/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:08:01 INFO - PROCESS | 796 | RSS: Main: 209346560 23:08:01 INFO - PROCESS | 796 | 23:08:04 INFO - PROCESS | 796 | Cycle 1(1): loaded http://localhost:54868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:08:04 INFO - PROCESS | 796 | RSS: Main: 207147008 23:08:04 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | Cycle 1(1): loaded http://localhost:54868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54868/tests/kraken/driver.html?testName=ai-astar) 23:08:06 INFO - PROCESS | 796 | RSS: Main: 270614528 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | __start_tp_report 23:08:06 INFO - PROCESS | 796 | _x_x_mozilla_page_load 23:08:06 INFO - PROCESS | 796 | _x_x_mozilla_page_load_details 23:08:06 INFO - PROCESS | 796 | |i|pagename|runs| 23:08:06 INFO - PROCESS | 796 | |0;ai-astar;109;110;110;109;109;110;105;111;109;111 23:08:06 INFO - PROCESS | 796 | |1;audio-beat-detection;155;126;160;175;128;156;155;130;194;127 23:08:06 INFO - PROCESS | 796 | |2;audio-dft;162;161;160;160;161;160;160;160;160;158 23:08:06 INFO - PROCESS | 796 | |3;audio-fft;76;76;77;165;76;76;77;77;166;76 23:08:06 INFO - PROCESS | 796 | |4;audio-oscillator;91;92;153;92;92;92;152;93;94;148 23:08:06 INFO - PROCESS | 796 | |5;imaging-gaussian-blur;116;116;116;116;117;117;116;116;116;116 23:08:06 INFO - PROCESS | 796 | |6;imaging-darkroom;144;146;145;145;145;146;146;146;146;146 23:08:06 INFO - PROCESS | 796 | |7;imaging-desaturate;95;95;95;94;95;94;94;95;94;95 23:08:06 INFO - PROCESS | 796 | |8;json-parse-financial;54;55;56;55;55;54;56;75;53;52 23:08:06 INFO - PROCESS | 796 | |9;json-stringify-tinderbox;58;57;58;59;57;58;58;58;59;57 23:08:06 INFO - PROCESS | 796 | |10;stanford-crypto-aes;71;80;71;73;71;73;72;73;72;74 23:08:06 INFO - PROCESS | 796 | |11;stanford-crypto-ccm;114;117;112;116;131;125;111;117;160;132 23:08:06 INFO - PROCESS | 796 | |12;stanford-crypto-pbkdf2;160;158;157;164;155;161;157;157;166;157 23:08:06 INFO - PROCESS | 796 | |13;stanford-crypto-sha256-iterative;65;65;65;67;67;66;64;65;64;67 23:08:06 INFO - PROCESS | 796 | __end_tp_report 23:08:06 INFO - PROCESS | 796 | __start_cc_report 23:08:06 INFO - PROCESS | 796 | _x_x_mozilla_cycle_collect,1591 23:08:06 INFO - PROCESS | 796 | __end_cc_report 23:08:06 INFO - PROCESS | 796 | __startTimestamp1464588486823__endTimestamp 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | ------- Summary: start ------- 23:08:06 INFO - PROCESS | 796 | Number of tests: 14 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:1.70 (1.5%) stddev-sans-first:1.80 23:08:06 INFO - PROCESS | 796 | Values: 109.0 110.0 110.0 109.0 109.0 110.0 105.0 111.0 109.0 111.0 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:155.50 stddev:22.93 (14.7%) stddev-sans-first:24.27 23:08:06 INFO - PROCESS | 796 | Values: 155.0 126.0 160.0 175.0 128.0 156.0 155.0 130.0 194.0 127.0 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:1.03 (0.6%) stddev-sans-first:0.87 23:08:06 INFO - PROCESS | 796 | Values: 162.0 161.0 160.0 160.0 161.0 160.0 160.0 160.0 160.0 158.0 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:37.58 (49.4%) stddev-sans-first:39.28 23:08:06 INFO - PROCESS | 796 | Values: 76.0 76.0 77.0 165.0 76.0 76.0 77.0 77.0 166.0 76.0 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.00 stddev:28.40 (30.9%) stddev-sans-first:29.29 23:08:06 INFO - PROCESS | 796 | Values: 91.0 92.0 153.0 92.0 92.0 92.0 152.0 93.0 94.0 148.0 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | [#5] imaging-gaussian-blur Cycles:10 Average:116.20 Median:116.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:08:06 INFO - PROCESS | 796 | Values: 116.0 116.0 116.0 116.0 117.0 117.0 116.0 116.0 116.0 116.0 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.71 (0.5%) stddev-sans-first:0.50 23:08:06 INFO - PROCESS | 796 | Values: 144.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 146.0 146.0 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:08:06 INFO - PROCESS | 796 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:55.00 stddev:6.62 (12.0%) stddev-sans-first:6.96 23:08:06 INFO - PROCESS | 796 | Values: 54.0 55.0 56.0 55.0 55.0 54.0 56.0 75.0 53.0 52.0 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 23:08:06 INFO - PROCESS | 796 | Values: 58.0 57.0 58.0 59.0 57.0 58.0 58.0 58.0 59.0 57.0 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:73.00 stddev:2.67 (3.7%) stddev-sans-first:2.73 23:08:06 INFO - PROCESS | 796 | Values: 71.0 80.0 71.0 73.0 71.0 73.0 72.0 73.0 72.0 74.0 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:121.00 stddev:14.84 (12.3%) stddev-sans-first:15.34 23:08:06 INFO - PROCESS | 796 | Values: 114.0 117.0 112.0 116.0 131.0 125.0 111.0 117.0 160.0 132.0 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:159.00 stddev:3.52 (2.2%) stddev-sans-first:3.72 23:08:06 INFO - PROCESS | 796 | Values: 160.0 158.0 157.0 164.0 155.0 161.0 157.0 157.0 166.0 157.0 23:08:06 INFO - PROCESS | 796 | 23:08:06 INFO - PROCESS | 796 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.18 (1.8%) stddev-sans-first:1.24 23:08:06 INFO - PROCESS | 796 | Values: 65.0 65.0 65.0 67.0 67.0 66.0 64.0 65.0 64.0 67.0 23:08:06 INFO - PROCESS | 796 | -------- Summary: end -------- 23:08:06 INFO - PROCESS | 796 | 23:08:07 INFO - TEST-INFO | 796: exit 0 23:08:07 INFO - TEST-OK | kraken | took 60223ms 23:08:07 INFO - SUITE-END | took 1171s 23:08:07 INFO - Completed test suite (00:19:31) 23:08:07 INFO - javascript benchmark 23:08:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3209.7432205423565, 3294.5717056782614, 3306.5866766654167, 3324.202191474047, 3357.043242675838, 5292.206169074636, 5304.0, 5334.226537152111, 5335.439778823226, 5339.5461385782255, 5347.331583552056, 5357.812476563321, 5360.115580929142, 5370.5435038021815, 5377.704226267554, 4833.637477189207, 4873.756312184385, 4927.334809800667, 4999.475055119196, 5016.347874776274, 4831.734254615994, 4908.852734417973, 4910.386201724785, 4939.67892087015, 5022.447530771612, 5009.924851127236, 5017.573506251973, 5020.0712868119335, 5021.422536408305, 5050.621203409741, 5008.1486147355035, 5019.347484826949, 5022.547970682656, 5024.120778863702, 5051.191809310511, 4852.684575502581, 4912.606991440712, 4930.457649658535, 4963.230699241623, 4965.4041515018425, 5285.339332583427, 5287.629865909388, 5288.894222115575, 5302.0721373759825, 5325.360956685184, 5741.971290143564, 5744.253247077853, 5745.454181852718, 5745.913811292792, 5748.080307150836, 5576.776928922838, 5684.658920464744, 5722.513586345124, 5774.913376299359, 5806.158107074492, 5305.257263983007, 5307.601929855237, 5316.73416329182, 5318.388385335697, 5324.094903866313, 5728.169415434739, 5744.425557444222, 5745.3105627324985, 5745.683987380734, 5764.193012978187, 5461.918071228934, 5632.549396048306, 5645.491905728504, 5698.800541981011, 5753.194552762617, 5777.566682498829, 5799.159121927297, 5805.216295800097, 5807.303123625107, 5808.82573522795, 5635.6618602883955, 5736.139579063174, 5778.422157784188, 5794.1308803679785, 5796.42035796417, 5597.524210442077, 5626.099824028218, 5650.0959846424375, 5684.317881854204, 5708.543316534668, 4413.558644135625, 4414.580614841585, 4415.27148020573, 4417.028253784162, 4444.599986001275, 3915.256101340736, 3959.425883246971, 3961.3463778476803, 3975.860844870416, 3995.820188091543, 5496.0, 5522.585806064561, 5541.861453463695, 5541.944580554224, 5577.832665020056, 5801.477866991991, 5805.94194058054, 5809.2738407699035, 5816.1566572846705, 5817.825465236049, 5333.57331413486, 5431.837044888581, 5514.117741161395, 5522.889542209134, 5551.306086739158, 4957.553820156131, 4971.975140124277, 4973.975130124326, 4978.502149785065, 4986.90026199474, 5913.58604897653, 5937.732802023919, 5948.643081415129, 5951.672658003765, 5994.580379373489, 5651.858703532444, 5758.3090029196765, 5780.653160810365, 5857.355690874086, 5880.235569376125, 5969.761209551743, 6007.3992600739575, 6012.488938440281, 6018.458338749533, 6020.367861374492, 5689.971550142222, 5704.914426283526, 5706.714664266853, 5707.743151558273, 5713.542916566747, 5593.608447408642, 5690.203371527907, 5741.196232527366, 5758.942410575841, 5767.192593037062, 5661.264035675335, 5672.319321681424, 5677.829665110054, 5680.68756218412, 5687.715614219355, 5508.394076651645, 5628.0, 5632.183333416549, 5636.098224284095, 5637.041702910597, 5460.31746031746, 5516.393196748274, 5526.972365138148, 5531.917021244604, 5566.805161819317, 5609.214709940693, 5640.689762063126, 5641.464060914206, 5646.604737668488, 5649.37856835756, 5458.399576046552, 5490.972545137249, 5533.916991245054, 5543.113101903676, 5545.417731138173], "value": 5320.331484270857, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.3855575146979, 643.2313385504323, 672.8654269146172, 674.4536925090677, 757.5833291689569, 39472.210555788864, 39901.0, 39987.60012399879, 40387.59612403875, 40435.39346909799, 39514.0, 39978.0, 39985.400218996736, 40057.59942400582, 40059.799701001524, 7778.64996075178, 8693.69572064978, 8907.821843563157, 8909.777255568597, 10194.337368071088, 10502.842457363146, 10683.412412317319, 10687.412192329419, 10693.83959240612, 10694.411807350592, 10703.357798532074, 10823.621173258938, 10824.891751082507, 10834.458277086114, 10843.07833834125, 8031.95984020082, 10503.73740656482, 10715.571377144905, 10785.191110666692, 10920.2901811382, 10218.335808172445, 10335.689929302132, 10356.79286414275, 10365.740856478573, 10384.584616615326, 40294.39558406626, 40670.796646016875, 40739.59260407388, 40806.795966020276, 40822.0, 3714.220013797106, 3793.0, 3811.6378944000276, 3902.180542086165, 4043.939340909889, 32035.839820800746, 33383.49924751131, 33421.6657833421, 33481.0, 33638.15904602405, 4355.1072030234045, 4457.153140903218, 4457.821687132511, 4466.70966387187, 4473.261911784584, 348213.0, 348318.0, 349451.0, 350118.0, 351381.0, 35558.111047224025, 62230.37769622246, 62587.37412625906, 62611.37388626146, 62634.0, 37180.81409592989, 37345.25309493849, 37359.626403735616, 37387.69143080033, 37399.62600373961, 16423.5894102646, 16639.916800416162, 16652.666946661, 16838.747418788727, 16862.325506979585, 12666.430010649543, 12910.225386476654, 13847.0, 14155.29223538819, 14390.85609143895, 8558.400911936105, 8591.05498395176, 8620.655173792979, 8631.352648551383, 8643.78390540229, 3464.5842498899788, 3504.491848681927, 3506.63180366063, 3531.8410671519327, 3538.9469157962653, 1115.2694984784978, 1149.51720277482, 1179.6343133628602, 1234.8456442944632, 1253.5424570031873, 33242.50136247958, 33425.83287083549, 33564.49653255203, 34352.48471272933, 34404.48393274103, 1187.4597058338609, 1189.5717541684987, 1196.8085106382937, 1231.3166192762924, 1315.3160356614508, 17809.643807123786, 17888.642227155644, 18066.90966545159, 18143.818561814478, 18153.546161346072, 438235.0, 443561.0, 444038.0, 444242.0, 446084.0, 61821.0, 62598.37401625925, 62615.0, 62642.0, 62701.372986270464, 1420.8953436740549, 1487.5611694550134, 1489.7541905585674, 1496.895217334798, 1549.147968617256, 30329.69670303357, 31254.374912502077, 31886.681133188373, 33133.33733325368, 34569.0, 49989.75005124951, 50050.74974625104, 50298.74850625724, 50397.74801125971, 50453.0, 301126.0, 302830.0, 303571.0, 303769.0, 304113.0, 26969.303069692873, 29866.850665746533, 30121.548176776927, 30313.848430757706, 30459.847700761355, 48345.03309933852, 49094.26358604695, 49096.2635560474, 50104.498955009985, 50501.2124090702, 40394.0, 41026.38460423036, 41090.1781964365, 41567.58432415758, 42767.14465710606, 40069.398959016224, 40869.79565102155, 41202.38196427116, 41798.373024405264, 42102.36846447244, 42459.36310955277, 43123.784381077894, 43279.0, 43605.56394436015, 43749.0, 35400.46899296564, 36696.26607467782, 37295.25409491849, 37481.81259093687, 37808.810955945046, 28212.153635390972, 28375.71624283731, 28617.0, 28787.28031799222, 28928.0], "value": 19505.42251579999, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.4434379650251, 432.99134017319636, 435.27309393313175, 442.1863770661982, 446.32381941358824, 18467.722984155233, 18622.53443663909, 18965.52586185346, 18986.145623446944, 19287.324943626976, 16738.41415550456, 17160.82839171608, 17371.30514779407, 17408.390706325248, 17437.651246975052, 5297.417284098756, 5408.702521361323, 5460.945390546083, 5552.500274975251, 5824.126381042835, 5776.508996735282, 5796.275465566804, 5828.737706803204, 5829.475347218749, 5837.387074357174, 5622.240997465331, 5743.798967036155, 5807.651540907538, 5810.680412577307, 5892.351841297454, 5903.0, 5920.526357891358, 5923.348431672513, 5958.6424814511265, 5961.225040744697, 5742.712864356808, 5776.104703770922, 5787.681677507735, 5792.68140252286, 5810.535157187415, 13671.0, 14228.92885535576, 14305.499307524187, 14346.928265358607, 14557.344919478648, 2412.9396765080837, 2499.487605040962, 2509.836860604055, 2579.729128441524, 2586.702529209146, 10305.381677099398, 10749.83875241872, 12407.379631018413, 12937.741245175044, 14550.636234094127, 2030.5735795482967, 2052.640787862118, 2054.3734161080865, 2142.517933464958, 2167.9241226556996, 67584.6620766898, 68833.0, 78327.99999999943, 79743.0, 83401.0, 10508.159347252202, 10509.737256568647, 10540.262181647211, 10614.734631634117, 10699.73250668724, 14354.56936291892, 14363.497277595234, 14381.352839122264, 14403.78394324086, 14411.279436028157, 8366.665333386596, 8695.913040869636, 8744.825103498022, 8769.649214031368, 8811.867821982676, 8118.903947967067, 8404.159584041547, 8654.0, 8905.777355566033, 8986.236169925629, 4450.621697155713, 4539.455265368177, 4596.609288210473, 4640.0, 4706.10583989041, 1872.6816441205028, 2027.5336672565393, 2072.896355182235, 2111.4826867417582, 2174.173813950689, 1008.2740426892625, 1010.6058637131524, 1069.316582364729, 1122.7810576937582, 1197.1021733699724, 18454.169562369727, 18742.0, 19181.904090479737, 19200.519987000436, 19439.416817495498, 1024.2318261304022, 1039.34521251611, 1072.1529991306936, 1106.2145876427826, 1135.9318440893574, 10549.47252637365, 10612.522436490377, 10938.56245750177, 10951.705396926864, 11117.499712512956, 501340.0, 505611.0, 511628.0, 512977.0, 525288.0, 93797.5310123445, 95416.0, 95697.0, 95818.52090739501, 96298.0, 1141.372245265101, 1160.3733983648904, 1170.163333216737, 1184.5972369394447, 1185.4013723069968, 17207.46116475731, 17457.738133928255, 17644.0295783728, 17654.823451765318, 17768.644627107646, 41117.383239252034, 41263.1747365057, 41683.7915810419, 42042.0, 42729.359059614755, 56807.0, 58396.12405814001, 58604.4139558599, 58997.11504327524, 59072.70463647654, 8678.78303042429, 8701.086385929386, 8807.383483156118, 8908.86636700437, 8926.196642301964, 9801.754956126153, 12708.046896482985, 12722.0, 12931.28877911724, 12984.0, 11100.555977761122, 11538.82691759641, 11551.942240288745, 11970.700732481757, 11991.82012269834, 10893.400862952614, 10955.56177752881, 11079.50142243585, 11267.887321126684, 11548.94225528867, 11533.88466115328, 11545.36500492481, 11734.589289374831, 12101.455434505644, 12230.388480576114, 8674.015277812287, 8784.121587841164, 8802.383833131875, 8856.512891791013, 8962.775930601787, 10826.458677066274, 11329.660110196708, 11488.19582629208, 11617.767644647229, 11726.00328972047], "value": 9268.204404543487, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.7759669654508, 1517.4537166620014, 1577.9605509862256, 1780.6171673090291, 1871.9344822931191, 8223.054348749896, 8427.662893484261, 8440.282575981033, 8442.029166645838, 8447.113053129426, 8187.38594605404, 8385.0, 8385.077641459435, 8387.538685372301, 8399.572072747633, 2076.636588596997, 2114.4925217947734, 2316.8609883406966, 2387.904483820645, 2422.588160012802, 2351.282858728096, 2363.0665886974634, 2369.431336479241, 2370.0282884017556, 2370.3126093432884, 2320.477892474197, 2332.4052366646483, 2400.867952262625, 2401.939951501209, 2403.6034054381007, 2070.2650559051544, 2309.7574754650773, 2320.535892821434, 2351.5296940611947, 2356.5169140326193, 2311.780380863815, 2330.1611419888827, 2345.2729653807205, 2352.188494969233, 2353.729321128075, 8055.718049868226, 8070.798230044237, 8099.473534220257, 8117.675292988273, 8137.186281371815, 4928.408590969107, 5072.264521644378, 5079.898402031976, 5081.771320290596, 5083.974580127076, 3305.619853716805, 3325.0523600773663, 3346.1300061983816, 3372.7133193678565, 3384.6615338466204, 1055.6832950114936, 1142.2689478733616, 1143.1540659911689, 1144.090448093759, 1161.1581603337597, 11444.828327575093, 11509.827352589718, 11519.42402879861, 11536.711582210428, 11550.768984620345, 4417.293233082692, 4442.53353397895, 4494.52807455219, 4517.457905051349, 4535.387722657399, 9863.704088877344, 9864.704058878102, 9878.16035636979, 9883.209343252522, 9891.604335826487, 5095.719735414587, 5146.382434107931, 5151.0470562945975, 5154.329937108227, 5164.715940623302, 4152.314868046798, 4711.175544279738, 4738.3129446230105, 4795.376601041842, 4798.712077275374, 4126.979365103215, 4131.194417088699, 4165.166966606691, 4198.6221240088535, 4296.9570304297185, 1365.9726805463836, 1390.332640332646, 1391.1792042694656, 1418.08558446099, 1419.7657386531107, 910.3809409601535, 1025.9281850270409, 1037.8339465685453, 1046.042870773234, 1060.9098226650667, 5926.170336152942, 5984.700764961734, 5998.040313549811, 6003.279606447254, 6116.785912493041, 899.9820003599891, 934.6121359635811, 969.7721035556639, 1050.9018076110483, 1081.0540776820283, 4011.2980228460488, 4086.1214838809206, 4100.6924480664065, 4105.8973525662095, 4153.252414565407, 10486.842697359545, 10891.128709703205, 10891.564337426573, 10915.290506117077, 10932.508037138348, 10063.295569310225, 10706.036456718777, 10769.569217231223, 10771.946140269405, 10778.353298802096, 8248.0, 8397.496150230883, 8441.15588441151, 8447.070822209553, 8460.746177614681, 5787.739551720267, 5922.348541660328, 5964.373740757158, 5975.641461512323, 6007.0, 9465.66870159541, 9527.904720952702, 9691.0, 9697.127258546765, 9712.805743884941, 9506.47714375716, 9831.410115393099, 9845.950770246389, 9864.210863131077, 9888.258380621626, 6743.831404214934, 7099.680514376762, 7329.596872172082, 7626.3898888089925, 7745.612719363897, 8268.627911744106, 8270.875936860832, 8298.668053278043, 8327.292180164754, 8338.416310858423, 7101.644917754195, 7272.309130632581, 7421.183669796426, 7483.476156668981, 7640.121386040454, 7385.593792341473, 7483.513571617827, 7489.176190618919, 7585.924140758521, 7593.088829340514, 6900.447964162955, 6921.377076063179, 6959.130108736408, 6973.860522789617, 6981.650917454005, 4958.57852082577, 4998.025385050026, 5033.597312214941, 5043.167877300204, 5107.668001579886, 5033.39599248078, 5119.539241468286, 5194.636375453682, 5211.921821172761, 5306.946930530646], "value": 4592.942942552299, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.5119961252889, 362.22483884487184, 362.3369234301228, 366.0975694912041, 367.7646306363928, 6194.411530904563, 6262.592931459458, 6330.65181415022, 6333.683315834213, 6344.936550634492, 5934.940650593493, 6079.63522188669, 6213.378662133796, 6236.656983865885, 6293.0875023121735, 4801.759912004403, 4807.18277892759, 4826.589739872106, 4841.757912104398, 4841.830535931225, 4807.110684523374, 4819.204831202847, 4821.590164835993, 4823.42118945727, 4847.636427267951, 4564.7945842437, 4662.230731929245, 4671.719696818202, 4671.85984420468, 4795.400574928134, 4801.831935882227, 4819.891424972276, 4822.63830212732, 4828.396450443694, 4836.588889944376, 4241.660667146621, 4261.083866968585, 4269.978650106761, 4270.316749320125, 4270.850520231808, 5952.601138732438, 5987.431194036603, 6001.66990815505, 6003.579749417542, 6028.909566356509, 5628.521575666074, 5629.80295689653, 5632.098864181711, 5633.211350410946, 5638.111232737038, 6453.612783233021, 6582.0, 6586.27550969393, 6587.176602924635, 6616.4376028037195, 4733.360996265495, 4746.572808447257, 4747.382840230783, 4763.69036012658, 4764.737939413331, 6895.827604309882, 6900.585964842076, 6901.1718593769065, 6904.758333458305, 6909.7581584644295, 4863.975680121577, 4865.270209468537, 4868.367112275381, 4871.683340582851, 4872.610191184696, 4934.1611925972675, 4935.925961110586, 4939.456659767423, 4941.085899108676, 4941.48114447985, 5466.398696143421, 5533.474319939599, 5533.474319939599, 5537.723113844291, 5615.438456154352, 6578.736850525926, 6604.174478190226, 6609.306022867626, 6622.86754264912, 6629.03878937561, 1627.788387509616, 1703.3186725309727, 1737.4700716281654, 1739.9826001740073, 1743.015196414022, 1143.822707480342, 1174.3775798826637, 1183.5739133911784, 1188.3048416676168, 1191.4995701805262, 6385.936140638627, 6388.648624325614, 6397.168368112209, 6399.264084630234, 6411.551191416649, 6748.628825414551, 6753.054572359873, 6766.966165169143, 6769.966150169218, 6773.356531129535, 6359.523035772336, 6362.459190968727, 6369.331220221903, 6372.267189273293, 6374.936250637527, 3617.565892092913, 3648.8175591220865, 3651.9634803652157, 3659.304732100892, 3664.0656632558525, 6795.762148324785, 6922.134733158356, 6995.4753393494675, 6997.635461085039, 7010.894836577456, 6786.660666966632, 6826.488013399015, 6842.349976752201, 6859.108315918898, 6864.519483636098, 6955.791326260221, 6986.9650651746415, 6990.405815505739, 6992.580445173306, 7002.649867506604, 6745.325467453215, 6752.662366881735, 6760.797176084725, 6762.053312536347, 6767.492438067066, 6602.316409315594, 6662.267150613332, 6676.99845023231, 6846.554973926679, 6863.725450981905, 7009.7897063088185, 7054.506184567031, 7113.0753002109395, 7143.82140446493, 7192.029076074872, 4730.716157030589, 4771.427428708577, 4774.546418090275, 4777.737224452689, 4779.259214821708, 6623.437007854193, 6914.481413893877, 6917.481188910952, 6923.273056329214, 6932.202796678446, 6587.4071333580205, 6696.933030669826, 6737.854564724107, 6747.325267473409, 6767.323267673193, 6603.537752357289, 6683.264840867598, 6691.263960964193, 6704.765333213314, 6716.83207919806, 6589.571677840925, 6601.933980660132, 6603.537752357289, 6606.405423511907, 6607.108040414675, 6608.207015158212, 6736.0, 6739.59562426256, 6743.055972163803, 6760.1211842462135, 6478.643674597943, 6556.63938483388, 6586.604803711793, 6588.934110659024, 6589.17635295588], "value": 5034.285342101425, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.8635675113607, 838.4759525296694, 888.4047688049006, 909.0818273543719, 910.2763303173977, 13926.442942282309, 13994.650133746662, 14294.0, 14299.356528956196, 14309.642258943531, 12992.675183120427, 13038.60884173474, 13039.087263891532, 13056.869431305684, 13087.1493352932, 747.9887801682979, 754.2645920227789, 754.6981207517009, 901.7970956534776, 908.2506931781273, 762.9580373079478, 876.3909083187187, 888.1074520107284, 889.5774507109136, 889.8086911314066, 932.2868005975434, 944.4239014201331, 944.4710961861346, 944.5560586524323, 946.5125460387906, 790.4980337485681, 938.366602543284, 940.3041749105681, 942.0532364973193, 942.8679984802134, 680.1701923653135, 691.5815931361554, 692.069166970424, 692.3491917597443, 692.3526502719923, 13485.662858428519, 13515.729685406335, 13546.864531354757, 13586.456541738318, 13599.864001359958, 13411.195328280237, 14074.929625351808, 14104.858951410457, 14218.360173792204, 14352.0, 10950.0, 11112.388818614972, 11469.483873225725, 11481.770364592745, 11558.133140014532, 3901.2977664020464, 3972.503437070366, 4014.2573623879384, 4087.4073259377224, 4101.589841015904, 56617.71691141559, 56660.0, 56719.0, 57125.14312285277, 57274.42725572774, 10520.842187367196, 10686.679399618024, 10757.139428845674, 10801.24391292602, 10922.344659320308, 18850.24599016024, 18966.43100706981, 18987.43037708871, 19015.524611884535, 19017.80982190188, 8090.878636820453, 8180.877286840702, 8407.45351552147, 8501.14988501145, 8502.319814414832, 4631.258998560282, 4771.66598338113, 4842.612590992712, 4852.441969173519, 5009.0482808266315, 3331.816750078769, 3373.2916087621384, 3374.5950485941353, 3374.6794054564775, 3378.0, 599.7331187621554, 604.431834075976, 607.5929127484596, 612.9938700612937, 621.471749013344, 578.7800635758385, 631.7378288010424, 649.5420728386571, 658.134553062721, 662.9138212032404, 8906.910930890737, 9135.451872887515, 9326.906730932604, 9364.014858766841, 9516.857247141299, 688.8828899087167, 702.2591166319581, 719.4352433339803, 743.2344684974485, 784.8312612788278, 4208.768517731554, 4365.847195348148, 4375.387445757597, 4707.929381059287, 4799.352087468147, 63488.0, 63840.0, 68929.31070689228, 69675.65162174258, 69762.65118674374, 56711.0, 57631.42368576261, 58192.12711809326, 58597.70701146467, 58840.411595883495, 50578.747106264236, 51276.74361628168, 51281.48718512767, 51675.99999999925, 52310.21534676983, 9337.906620933703, 9445.811083778424, 9517.381370210915, 9582.520873956135, 9655.758606034624, 35659.82170089133, 36984.50065726045, 37109.07227319231, 37377.81311093427, 39509.80245098871, 48206.27690584714, 48987.265191022874, 48999.0, 49322.50677493323, 49877.50122498874, 12122.393880305774, 12165.69585760363, 12169.39153042362, 12328.07539434564, 12546.686332841751, 13716.0, 13860.0, 13874.306284685523, 14031.719365612835, 14040.578782636538, 12637.747245054863, 12849.807252891402, 12870.292133932724, 12888.162269452456, 13056.34718264064, 12126.393680316125, 12168.634940951786, 12283.0, 12647.494100235888, 12845.165064270792, 12542.623721288375, 12568.371581421075, 12624.74750505003, 12879.093111287148, 12977.286249256003, 9571.33000689945, 9630.47032413224, 9813.9018609813, 10242.334248273839, 11082.944585277022, 10400.375977441377, 10437.21720870953, 10564.366138031743, 10579.94710026445, 10615.89384106149], "value": 6873.137420297016, "unit": "score"}], "name": "dromaeo_css", "value": 7312.266204865607, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 105.0, 111.0, 109.0, 111.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 160.0, 175.0, 128.0, 156.0, 155.0, 130.0, 194.0, 127.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 160.0, 161.0, 160.0, 160.0, 160.0, 160.0, 158.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 165.0, 76.0, 76.0, 77.0, 77.0, 166.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 153.0, 92.0, 92.0, 92.0, 152.0, 93.0, 94.0, 148.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0], "value": 116.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 55.0, 55.0, 54.0, 56.0, 75.0, 53.0, 52.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 58.0, 59.0, 57.0, 58.0, 58.0, 58.0, 59.0, 57.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 80.0, 71.0, 73.0, 71.0, 73.0, 72.0, 73.0, 72.0, 74.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 112.0, 116.0, 131.0, 125.0, 111.0, 117.0, 160.0, 132.0], "value": 123.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 157.0, 164.0, 155.0, 161.0, 157.0, 157.0, 166.0, 157.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 67.0, 67.0, 66.0, 64.0, 65.0, 64.0, 67.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1516.1000000000001, "alertThreshold": 2.0}]} 23:08:08 INFO - Return code: 0 23:08:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:08:08 ERROR - # TBPL SUCCESS # 23:08:08 INFO - Running post-action listener: _resource_record_post_action 23:08:08 INFO - Running post-run listener: _resource_record_post_run 23:08:09 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 499994624; Read time: 32; Write time: 512564 23:08:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 215777280; Read time: 0; Write time: 285852 23:08:09 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250941440; Read time: 32; Write time: 213560 23:08:09 INFO - Running post-run listener: _upload_blobber_files 23:08:09 INFO - Blob upload gear active. 23:08:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:08:09 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 23:08:09 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'] 23:08:09 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 23:08:09 INFO - (blobuploader) - INFO - Open directory for files ... 23:08:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:08:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:08:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:08:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:08:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:08:10 INFO - (blobuploader) - INFO - Done attempting. 23:08:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:08:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:08:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:08:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:08:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:08:11 INFO - (blobuploader) - INFO - Done attempting. 23:08:11 INFO - (blobuploader) - INFO - Iteration through files over. 23:08:11 INFO - Return code: 0 23:08:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:08:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:08:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad12f20ad72708a633ff5c641189e3b71c8be007d9d5a3d8d4474673a3987e07d54e0be0395701ec2b0174a17b29fbd48c54c8c45805a98c16ac0c2a86c474b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e935b11117aac82f4b13d1e29379beb8eac5b2f4c42c00d78020a094e4a6bdeb465487d450819783766e036120cba1f4722fc1299c0f427b50b3bfbaac795e2"} 23:08:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:08:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:08:11 INFO - Contents: 23:08:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad12f20ad72708a633ff5c641189e3b71c8be007d9d5a3d8d4474673a3987e07d54e0be0395701ec2b0174a17b29fbd48c54c8c45805a98c16ac0c2a86c474b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e935b11117aac82f4b13d1e29379beb8eac5b2f4c42c00d78020a094e4a6bdeb465487d450819783766e036120cba1f4722fc1299c0f427b50b3bfbaac795e2"} 23:08:11 INFO - Running post-run listener: copy_logs_to_upload_dir 23:08:11 INFO - Copying logs to upload dir... 23:08:11 INFO - mkdir: /builds/slave/test/build/upload/logs 23:08:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.789538 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-29 23:08:11.458125) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 23:08:11.461574) ========= 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=232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722 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/ad12f20ad72708a633ff5c641189e3b71c8be007d9d5a3d8d4474673a3987e07d54e0be0395701ec2b0174a17b29fbd48c54c8c45805a98c16ac0c2a86c474b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e935b11117aac82f4b13d1e29379beb8eac5b2f4c42c00d78020a094e4a6bdeb465487d450819783766e036120cba1f4722fc1299c0f427b50b3bfbaac795e2"} build_url:https://queue.taskcluster.net/v1/task/EMEDIQFwQl6M51gRvfBfHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011465 build_url: 'https://queue.taskcluster.net/v1/task/EMEDIQFwQl6M51gRvfBfHg/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/ad12f20ad72708a633ff5c641189e3b71c8be007d9d5a3d8d4474673a3987e07d54e0be0395701ec2b0174a17b29fbd48c54c8c45805a98c16ac0c2a86c474b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e935b11117aac82f4b13d1e29379beb8eac5b2f4c42c00d78020a094e4a6bdeb465487d450819783766e036120cba1f4722fc1299c0f427b50b3bfbaac795e2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 23:08:11.487010) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 23:08:11.487345) ========= 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=232498196343f89f466a4a9a000001c8-1464586233.662989-1453589722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 23:08:11.570278) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 23:08:11.570604) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 23:08:11.570886) ========= ========= Total master_lag: 0.16 =========