builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1464517698.41 results: success (0) buildid: 20160529004021 builduid: f1aac556b1aa4f1abc2d74496b3d3628 revision: bfea62662298a8400d559abd40ec7d4d12fbd97d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 03:28:18.410504) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 03:28:18.410959) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 03:28:18.411315) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 03:28:18.480694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 03:28:18.481080) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-29 03:28:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-05-29 03:28:20 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.377865 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 03:28:18.873103) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 03:28:18.873453) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017950 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 03:28:18.927080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-29 03:28:18.927447) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bfea62662298a8400d559abd40ec7d4d12fbd97d --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 bfea62662298a8400d559abd40ec7d4d12fbd97d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-29 03:28:20,199 truncating revision to first 12 chars 2016-05-29 03:28:20,199 Setting DEBUG logging. 2016-05-29 03:28:20,200 attempt 1/10 2016-05-29 03:28:20,200 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bfea62662298?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-29 03:28:20,644 unpacking tar archive at: mozilla-aurora-bfea62662298/testing/mozharness/ program finished with exit code 0 elapsedTime=1.542022 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-29 03:28:20.487311) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 03:28:20.487759) ========= script_repo_revision: bfea62662298a8400d559abd40ec7d4d12fbd97d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 03:28:20.488277) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 03:28:20.488633) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 03:28:20.498351) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-29 03:28:20.498747) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:28:21 INFO - MultiFileLogger online at 20160529 03:28:21 in /builds/slave/test 03:28:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:28:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:28:21 INFO - {'append_to_log': False, 03:28:21 INFO - 'base_work_dir': '/builds/slave/test', 03:28:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:28:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:28:21 INFO - 'branch': 'Mozilla-Aurora', 03:28:21 INFO - 'buildbot_json_path': 'buildprops.json', 03:28:21 INFO - 'config_files': ('talos/linux_config.py',), 03:28:21 INFO - 'default_actions': ('clobber', 03:28:21 INFO - 'read-buildbot-config', 03:28:21 INFO - 'download-and-extract', 03:28:21 INFO - 'populate-webroot', 03:28:21 INFO - 'create-virtualenv', 03:28:21 INFO - 'install', 03:28:21 INFO - 'run-tests'), 03:28:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:28:21 INFO - 'download_minidump_stackwalk': True, 03:28:21 INFO - 'download_symbols': 'ondemand', 03:28:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:28:21 INFO - 'tooltool.py': '/tools/tooltool.py', 03:28:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:28:21 INFO - '/tools/misc-python/virtualenv.py')}, 03:28:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:28:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:28:21 INFO - 'installer_path': 'installer.exe', 03:28:21 INFO - 'log_level': 'info', 03:28:21 INFO - 'log_name': 'talos', 03:28:21 INFO - 'log_to_console': True, 03:28:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:28:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:28:21 INFO - 'opt_config_files': (), 03:28:21 INFO - 'pip_index': False, 03:28:21 INFO - 'sps_profile': False, 03:28:21 INFO - 'sps_profile_interval': 0, 03:28:21 INFO - 'suite': 'dromaeojs', 03:28:21 INFO - 'system_bits': '32', 03:28:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:28:21 INFO - 'title': 'talos-linux64-ix-044', 03:28:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:28:21 INFO - 'use_talos_json': True, 03:28:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:28:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:28:21 INFO - 'work_dir': 'build'} 03:28:21 INFO - ##### 03:28:21 INFO - ##### Running clobber step. 03:28:21 INFO - ##### 03:28:21 INFO - Running pre-action listener: _resource_record_pre_action 03:28:21 INFO - Running main action method: clobber 03:28:21 INFO - rmtree: /builds/slave/test/build 03:28:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:28:22 INFO - Running post-action listener: _resource_record_post_action 03:28:22 INFO - ##### 03:28:22 INFO - ##### Running read-buildbot-config step. 03:28:22 INFO - ##### 03:28:22 INFO - Running pre-action listener: _resource_record_pre_action 03:28:22 INFO - Running main action method: read_buildbot_config 03:28:22 INFO - Using buildbot properties: 03:28:22 INFO - { 03:28:22 INFO - "project": "", 03:28:22 INFO - "product": "firefox", 03:28:22 INFO - "script_repo_revision": "production", 03:28:22 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:28:22 INFO - "repository": "", 03:28:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:28:22 INFO - "buildid": "20160529004021", 03:28:22 INFO - "stage_platform": "linux64-pgo", 03:28:22 INFO - "basedir": "/builds/slave/test", 03:28:22 INFO - "nightly_build": "True", 03:28:22 INFO - "buildnumber": 266, 03:28:22 INFO - "slavename": "talos-linux64-ix-044", 03:28:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:28:22 INFO - "platform": "ubuntu64_hw", 03:28:22 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:28:22 INFO - "branch": "mozilla-aurora", 03:28:22 INFO - "repo_path": "releases/mozilla-aurora", 03:28:22 INFO - "revision": "bfea62662298a8400d559abd40ec7d4d12fbd97d", 03:28:22 INFO - "pgo_build": "True", 03:28:22 INFO - "builduid": "f1aac556b1aa4f1abc2d74496b3d3628", 03:28:22 INFO - "slavebuilddir": "test" 03:28:22 INFO - } 03:28:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:28:22 INFO - Running post-action listener: _resource_record_post_action 03:28:22 INFO - ##### 03:28:22 INFO - ##### Running download-and-extract step. 03:28:22 INFO - ##### 03:28:22 INFO - Running pre-action listener: _resource_record_pre_action 03:28:22 INFO - Running main action method: download_and_extract 03:28:22 INFO - mkdir: /builds/slave/test/build/tests 03:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:22 INFO - https://queue.taskcluster.net/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:28:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:28:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:28:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:28:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:28:23 INFO - Downloaded 1361 bytes. 03:28:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:28:23 INFO - Using the following test package requirements: 03:28:23 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:28:23 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:28:23 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:28:23 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:23 INFO - u'jsshell-linux-x86_64.zip'], 03:28:23 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:28:23 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:28:23 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:28:23 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:28:23 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:28:23 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:23 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:28:23 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:23 INFO - https://queue.taskcluster.net/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:28:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:28:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:28:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:28:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:28:24 INFO - Downloaded 24136957 bytes. 03:28:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:28:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:28:25 INFO - Return code: 0 03:28:25 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:25 INFO - https://queue.taskcluster.net/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:28:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:28:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:28:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:28:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:28:27 INFO - Downloaded 24136957 bytes. 03:28:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:28:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:28:29 INFO - Return code: 0 03:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:29 INFO - https://queue.taskcluster.net/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:28:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:28:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:28:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:28:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:28:30 INFO - Downloaded 10840145 bytes. 03:28:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:28:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:28:30 INFO - Return code: 0 03:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:30 INFO - https://queue.taskcluster.net/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:28:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:28:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:28:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:28:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:28:32 INFO - Downloaded 62781255 bytes. 03:28:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:28:32 INFO - mkdir: /builds/slave/test/properties 03:28:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:32 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:32 INFO - Contents: 03:28:32 INFO - build_url:https://queue.taskcluster.net/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:28:33 INFO - Running post-action listener: _resource_record_post_action 03:28:33 INFO - Running post-action listener: set_extra_try_arguments 03:28:33 INFO - ##### 03:28:33 INFO - ##### Running populate-webroot step. 03:28:33 INFO - ##### 03:28:33 INFO - Running pre-action listener: _resource_record_pre_action 03:28:33 INFO - Running main action method: populate_webroot 03:28:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:28:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:28:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:28:33 INFO - '--tppagecycles', 03:28:33 INFO - '7'], 03:28:33 INFO - 'tests': ['tsvgm']}}, 03:28:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:28:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:28:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:28:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:28:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:28:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:28:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:33 INFO - 'talos_options': ['--disable-e10s'], 03:28:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:33 INFO - 'talos_options': ['--disable-e10s'], 03:28:33 INFO - 'tests': ['damp', 'tps']}, 03:28:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:33 INFO - 'tests': ['damp', 'tps']}, 03:28:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:28:33 INFO - 'tests': ['dromaeo_dom']}, 03:28:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:28:33 INFO - 'tests': ['a11yr', 03:28:33 INFO - 'ts_paint', 03:28:33 INFO - 'tpaint', 03:28:33 INFO - 'sessionrestore', 03:28:33 INFO - 'sessionrestore_no_auto_restore', 03:28:33 INFO - 'tabpaint']}, 03:28:33 INFO - 'other-e10s': {'tests': ['a11yr', 03:28:33 INFO - 'ts_paint', 03:28:33 INFO - 'tpaint', 03:28:33 INFO - 'sessionrestore', 03:28:33 INFO - 'sessionrestore_no_auto_restore', 03:28:33 INFO - 'tabpaint']}, 03:28:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:28:33 INFO - 'ts_paint', 03:28:33 INFO - 'tpaint', 03:28:33 INFO - 'sessionrestore', 03:28:33 INFO - 'sessionrestore_no_auto_restore', 03:28:33 INFO - 'tabpaint']}, 03:28:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:28:33 INFO - 'ts_paint', 03:28:33 INFO - 'tpaint', 03:28:33 INFO - 'sessionrestore', 03:28:33 INFO - 'sessionrestore_no_auto_restore', 03:28:33 INFO - 'tabpaint']}, 03:28:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:28:33 INFO - 'tests': ['a11yr', 03:28:33 INFO - 'ts_paint', 03:28:33 INFO - 'tpaint', 03:28:33 INFO - 'sessionrestore', 03:28:33 INFO - 'sessionrestore_no_auto_restore', 03:28:33 INFO - 'tabpaint']}, 03:28:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:28:33 INFO - 'tests': ['a11yr', 03:28:33 INFO - 'ts_paint', 03:28:33 INFO - 'tpaint', 03:28:33 INFO - 'sessionrestore', 03:28:33 INFO - 'sessionrestore_no_auto_restore', 03:28:33 INFO - 'tabpaint']}, 03:28:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:28:33 INFO - 'tests': ['tsvgx', 03:28:33 INFO - 'tsvgr_opacity', 03:28:33 INFO - 'tart', 03:28:33 INFO - 'tscrollx', 03:28:33 INFO - 'cart']}, 03:28:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:28:33 INFO - 'tsvgr_opacity', 03:28:33 INFO - 'tart', 03:28:33 INFO - 'tscrollx', 03:28:33 INFO - 'cart']}, 03:28:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:33 INFO - 'talos_options': ['--disable-e10s'], 03:28:33 INFO - 'tests': ['tp5o']}, 03:28:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:33 INFO - 'tests': ['tp5o']}, 03:28:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:33 INFO - 'talos_options': ['--disable-e10s', 03:28:33 INFO - '--xperf_path', 03:28:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:33 INFO - 'tests': ['tp5n']}, 03:28:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:33 INFO - 'talos_options': ['--xperf_path', 03:28:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:33 INFO - 'tests': ['tp5n']}}, 03:28:33 INFO - 'talos.zip': {'path': '', 03:28:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:28:33 INFO - Running post-action listener: _resource_record_post_action 03:28:33 INFO - ##### 03:28:33 INFO - ##### Running create-virtualenv step. 03:28:33 INFO - ##### 03:28:33 INFO - Running pre-action listener: _resource_record_pre_action 03:28:33 INFO - Running main action method: create_virtualenv 03:28:33 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:28:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:33 INFO - Using real prefix '/usr' 03:28:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:34 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:35 INFO - Installing pip.................done. 03:28:36 INFO - Return code: 0 03:28:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:36 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 0x7fd9bf972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884410>, '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 0x2885310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:28:36 INFO - Using env: {'DISPLAY': ':0', 03:28:36 INFO - 'HOME': '/home/cltbld', 03:28:36 INFO - 'LANG': 'en_US.UTF-8', 03:28:36 INFO - 'LANGUAGE': 'en_US:en', 03:28:36 INFO - 'LOGNAME': 'cltbld', 03:28:36 INFO - 'MAIL': '/var/mail/cltbld', 03:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:36 INFO - 'MOZ_NO_REMOTE': '1', 03:28:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:36 INFO - 'NO_EM_RESTART': '1', 03:28:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:36 INFO - 'PWD': '/builds/slave/test', 03:28:36 INFO - 'SHELL': '/bin/bash', 03:28:36 INFO - 'SHLVL': '1', 03:28:36 INFO - 'TERM': 'linux', 03:28:36 INFO - 'TMOUT': '86400', 03:28:36 INFO - 'USER': 'cltbld', 03:28:36 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 03:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:36 INFO - '_': '/tools/buildbot/bin/python'} 03:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:28:36 INFO - Cleaning up... 03:28:36 INFO - Return code: 0 03:28:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:36 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 0x7fd9bf972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884410>, '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 0x2885310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:28:36 INFO - Using env: {'DISPLAY': ':0', 03:28:36 INFO - 'HOME': '/home/cltbld', 03:28:36 INFO - 'LANG': 'en_US.UTF-8', 03:28:36 INFO - 'LANGUAGE': 'en_US:en', 03:28:36 INFO - 'LOGNAME': 'cltbld', 03:28:36 INFO - 'MAIL': '/var/mail/cltbld', 03:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:36 INFO - 'MOZ_NO_REMOTE': '1', 03:28:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:36 INFO - 'NO_EM_RESTART': '1', 03:28:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:36 INFO - 'PWD': '/builds/slave/test', 03:28:36 INFO - 'SHELL': '/bin/bash', 03:28:36 INFO - 'SHLVL': '1', 03:28:36 INFO - 'TERM': 'linux', 03:28:36 INFO - 'TMOUT': '86400', 03:28:36 INFO - 'USER': 'cltbld', 03:28:36 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 03:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:36 INFO - '_': '/tools/buildbot/bin/python'} 03:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:36 INFO - Downloading/unpacking psutil>=0.7.1 03:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:38 INFO - Installing collected packages: psutil 03:28:38 INFO - Running setup.py install for psutil 03:28:38 INFO - building 'psutil._psutil_linux' extension 03:28:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:28:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:28:38 INFO - building 'psutil._psutil_posix' extension 03:28:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:28:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:28:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:38 INFO - Successfully installed psutil 03:28:38 INFO - Cleaning up... 03:28:39 INFO - Return code: 0 03:28:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:39 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 0x7fd9bf972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884410>, '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 0x2885310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:28:39 INFO - Using env: {'DISPLAY': ':0', 03:28:39 INFO - 'HOME': '/home/cltbld', 03:28:39 INFO - 'LANG': 'en_US.UTF-8', 03:28:39 INFO - 'LANGUAGE': 'en_US:en', 03:28:39 INFO - 'LOGNAME': 'cltbld', 03:28:39 INFO - 'MAIL': '/var/mail/cltbld', 03:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:39 INFO - 'MOZ_NO_REMOTE': '1', 03:28:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:39 INFO - 'NO_EM_RESTART': '1', 03:28:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:39 INFO - 'PWD': '/builds/slave/test', 03:28:39 INFO - 'SHELL': '/bin/bash', 03:28:39 INFO - 'SHLVL': '1', 03:28:39 INFO - 'TERM': 'linux', 03:28:39 INFO - 'TMOUT': '86400', 03:28:39 INFO - 'USER': 'cltbld', 03:28:39 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 03:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:39 INFO - '_': '/tools/buildbot/bin/python'} 03:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:28:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:28:41 INFO - Installing collected packages: mozsystemmonitor 03:28:41 INFO - Running setup.py install for mozsystemmonitor 03:28:41 INFO - Successfully installed mozsystemmonitor 03:28:41 INFO - Cleaning up... 03:28:41 INFO - Return code: 0 03:28:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:41 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 0x7fd9bf972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884410>, '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 0x2885310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:28:41 INFO - Using env: {'DISPLAY': ':0', 03:28:41 INFO - 'HOME': '/home/cltbld', 03:28:41 INFO - 'LANG': 'en_US.UTF-8', 03:28:41 INFO - 'LANGUAGE': 'en_US:en', 03:28:41 INFO - 'LOGNAME': 'cltbld', 03:28:41 INFO - 'MAIL': '/var/mail/cltbld', 03:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:41 INFO - 'MOZ_NO_REMOTE': '1', 03:28:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:41 INFO - 'NO_EM_RESTART': '1', 03:28:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:41 INFO - 'PWD': '/builds/slave/test', 03:28:41 INFO - 'SHELL': '/bin/bash', 03:28:41 INFO - 'SHLVL': '1', 03:28:41 INFO - 'TERM': 'linux', 03:28:41 INFO - 'TMOUT': '86400', 03:28:41 INFO - 'USER': 'cltbld', 03:28:41 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 03:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:41 INFO - '_': '/tools/buildbot/bin/python'} 03:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:41 INFO - Downloading/unpacking blobuploader==1.2.4 03:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:43 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:44 INFO - Downloading docopt-0.6.1.tar.gz 03:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:44 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:44 INFO - Running setup.py install for blobuploader 03:28:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:44 INFO - Running setup.py install for requests 03:28:44 INFO - Running setup.py install for docopt 03:28:44 INFO - Successfully installed blobuploader requests docopt 03:28:44 INFO - Cleaning up... 03:28:44 INFO - Return code: 0 03:28:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:44 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 0x7fd9bf972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884410>, '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 0x2885310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:44 INFO - Using env: {'DISPLAY': ':0', 03:28:44 INFO - 'HOME': '/home/cltbld', 03:28:44 INFO - 'LANG': 'en_US.UTF-8', 03:28:44 INFO - 'LANGUAGE': 'en_US:en', 03:28:44 INFO - 'LOGNAME': 'cltbld', 03:28:44 INFO - 'MAIL': '/var/mail/cltbld', 03:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:44 INFO - 'MOZ_NO_REMOTE': '1', 03:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:44 INFO - 'NO_EM_RESTART': '1', 03:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:44 INFO - 'PWD': '/builds/slave/test', 03:28:44 INFO - 'SHELL': '/bin/bash', 03:28:44 INFO - 'SHLVL': '1', 03:28:44 INFO - 'TERM': 'linux', 03:28:44 INFO - 'TMOUT': '86400', 03:28:44 INFO - 'USER': 'cltbld', 03:28:44 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 03:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:44 INFO - '_': '/tools/buildbot/bin/python'} 03:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:45 INFO - Running setup.py (path:/tmp/pip-T68Tvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:45 INFO - Running setup.py (path:/tmp/pip-EAETPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:45 INFO - Running setup.py (path:/tmp/pip-G4acK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:45 INFO - Running setup.py (path:/tmp/pip-jOjNZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:45 INFO - Running setup.py (path:/tmp/pip-sCInMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:45 INFO - Running setup.py (path:/tmp/pip-mHI7Du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:45 INFO - Running setup.py (path:/tmp/pip-aR6KOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:45 INFO - Running setup.py (path:/tmp/pip-HWb8Yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:45 INFO - Running setup.py (path:/tmp/pip-qPYjwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:45 INFO - Running setup.py (path:/tmp/pip-5lIsuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:45 INFO - Running setup.py (path:/tmp/pip-aW3ius-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:45 INFO - Running setup.py (path:/tmp/pip-8GyySp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:45 INFO - Running setup.py (path:/tmp/pip-IIxntS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:45 INFO - Running setup.py (path:/tmp/pip-wWvg3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:46 INFO - Running setup.py (path:/tmp/pip-Bm33AM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:46 INFO - Running setup.py (path:/tmp/pip-QsizkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:46 INFO - Running setup.py (path:/tmp/pip-vOVPJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:46 INFO - Running setup.py install for manifestparser 03:28:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:46 INFO - Running setup.py install for mozcrash 03:28:46 INFO - Running setup.py install for mozdebug 03:28:46 INFO - Running setup.py install for mozdevice 03:28:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:28:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:46 INFO - Running setup.py install for mozfile 03:28:46 INFO - Running setup.py install for mozhttpd 03:28:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:46 INFO - Running setup.py install for mozinfo 03:28:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:46 INFO - Running setup.py install for mozInstall 03:28:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:47 INFO - Running setup.py install for mozleak 03:28:47 INFO - Running setup.py install for mozlog 03:28:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:47 INFO - Running setup.py install for moznetwork 03:28:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:47 INFO - Running setup.py install for mozprocess 03:28:47 INFO - Running setup.py install for mozprofile 03:28:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:47 INFO - Running setup.py install for mozrunner 03:28:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:47 INFO - Running setup.py install for mozscreenshot 03:28:47 INFO - Running setup.py install for moztest 03:28:47 INFO - Running setup.py install for mozversion 03:28:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:48 INFO - Cleaning up... 03:28:48 INFO - Return code: 0 03:28:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:48 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 0x7fd9bf972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884410>, '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 0x2885310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:48 INFO - Using env: {'DISPLAY': ':0', 03:28:48 INFO - 'HOME': '/home/cltbld', 03:28:48 INFO - 'LANG': 'en_US.UTF-8', 03:28:48 INFO - 'LANGUAGE': 'en_US:en', 03:28:48 INFO - 'LOGNAME': 'cltbld', 03:28:48 INFO - 'MAIL': '/var/mail/cltbld', 03:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:48 INFO - 'MOZ_NO_REMOTE': '1', 03:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:48 INFO - 'NO_EM_RESTART': '1', 03:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:48 INFO - 'PWD': '/builds/slave/test', 03:28:48 INFO - 'SHELL': '/bin/bash', 03:28:48 INFO - 'SHLVL': '1', 03:28:48 INFO - 'TERM': 'linux', 03:28:48 INFO - 'TMOUT': '86400', 03:28:48 INFO - 'USER': 'cltbld', 03:28:48 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 03:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:48 INFO - '_': '/tools/buildbot/bin/python'} 03:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:48 INFO - Running setup.py (path:/tmp/pip-SBXsYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:48 INFO - Running setup.py (path:/tmp/pip-PIq0l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:48 INFO - Running setup.py (path:/tmp/pip-rjGhgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:48 INFO - Running setup.py (path:/tmp/pip-6g0J3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:48 INFO - Running setup.py (path:/tmp/pip-FmCriD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:48 INFO - Running setup.py (path:/tmp/pip-RMiZ6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:48 INFO - Running setup.py (path:/tmp/pip-HJauuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:48 INFO - Running setup.py (path:/tmp/pip-cpqZXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:48 INFO - Running setup.py (path:/tmp/pip-F4hDEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:48 INFO - Running setup.py (path:/tmp/pip-QjXHHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:48 INFO - Running setup.py (path:/tmp/pip-wgu_ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:49 INFO - Running setup.py (path:/tmp/pip-FFtVLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:49 INFO - Running setup.py (path:/tmp/pip-S8jaXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:49 INFO - Running setup.py (path:/tmp/pip-SfPWOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:49 INFO - Running setup.py (path:/tmp/pip-ogv5Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:49 INFO - Running setup.py (path:/tmp/pip-nrINoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:49 INFO - Running setup.py (path:/tmp/pip-pG28K_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:51 INFO - Downloading blessings-1.6.tar.gz 03:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:51 INFO - Installing collected packages: blessings 03:28:51 INFO - Running setup.py install for blessings 03:28:51 INFO - Successfully installed blessings 03:28:51 INFO - Cleaning up... 03:28:51 INFO - Return code: 0 03:28:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:51 INFO - Reading from file tmpfile_stdout 03:28:51 INFO - Current package versions: 03:28:51 INFO - argparse == 1.2.1 03:28:51 INFO - blessings == 1.6 03:28:51 INFO - blobuploader == 1.2.4 03:28:51 INFO - docopt == 0.6.1 03:28:51 INFO - manifestparser == 1.1 03:28:51 INFO - mozInstall == 1.12 03:28:51 INFO - mozcrash == 0.17 03:28:51 INFO - mozdebug == 0.1 03:28:51 INFO - mozdevice == 0.48 03:28:51 INFO - mozfile == 1.2 03:28:51 INFO - mozhttpd == 0.7 03:28:51 INFO - mozinfo == 0.9 03:28:51 INFO - mozleak == 0.1 03:28:51 INFO - mozlog == 3.1 03:28:51 INFO - moznetwork == 0.27 03:28:51 INFO - mozprocess == 0.22 03:28:51 INFO - mozprofile == 0.28 03:28:51 INFO - mozrunner == 6.11 03:28:51 INFO - mozscreenshot == 0.1 03:28:51 INFO - mozsystemmonitor == 0.0 03:28:51 INFO - moztest == 0.7 03:28:51 INFO - mozversion == 1.4 03:28:51 INFO - psutil == 3.1.1 03:28:51 INFO - requests == 1.2.3 03:28:51 INFO - wsgiref == 0.1.2 03:28:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:51 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 0x7fd9bf972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884410>, '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 0x2885310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:28:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:51 INFO - Using env: {'DISPLAY': ':0', 03:28:51 INFO - 'HOME': '/home/cltbld', 03:28:51 INFO - 'LANG': 'en_US.UTF-8', 03:28:51 INFO - 'LANGUAGE': 'en_US:en', 03:28:51 INFO - 'LOGNAME': 'cltbld', 03:28:51 INFO - 'MAIL': '/var/mail/cltbld', 03:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:51 INFO - 'MOZ_NO_REMOTE': '1', 03:28:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:51 INFO - 'NO_EM_RESTART': '1', 03:28:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:51 INFO - 'PWD': '/builds/slave/test', 03:28:51 INFO - 'SHELL': '/bin/bash', 03:28:51 INFO - 'SHLVL': '1', 03:28:51 INFO - 'TERM': 'linux', 03:28:51 INFO - 'TMOUT': '86400', 03:28:51 INFO - 'USER': 'cltbld', 03:28:51 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 03:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:51 INFO - '_': '/tools/buildbot/bin/python'} 03:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:28:52 INFO - Cleaning up... 03:28:52 INFO - Return code: 0 03:28:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:52 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 0x7fd9bf972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884410>, '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 0x2885310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:28:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:28:52 INFO - Using env: {'DISPLAY': ':0', 03:28:52 INFO - 'HOME': '/home/cltbld', 03:28:52 INFO - 'LANG': 'en_US.UTF-8', 03:28:52 INFO - 'LANGUAGE': 'en_US:en', 03:28:52 INFO - 'LOGNAME': 'cltbld', 03:28:52 INFO - 'MAIL': '/var/mail/cltbld', 03:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:52 INFO - 'MOZ_NO_REMOTE': '1', 03:28:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:52 INFO - 'NO_EM_RESTART': '1', 03:28:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:52 INFO - 'PWD': '/builds/slave/test', 03:28:52 INFO - 'SHELL': '/bin/bash', 03:28:52 INFO - 'SHLVL': '1', 03:28:52 INFO - 'TERM': 'linux', 03:28:52 INFO - 'TMOUT': '86400', 03:28:52 INFO - 'USER': 'cltbld', 03:28:52 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 03:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:52 INFO - '_': '/tools/buildbot/bin/python'} 03:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:52 INFO - Downloading/unpacking jsonschema 03:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:54 INFO - Downloading/unpacking functools32 (from jsonschema) 03:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:54 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:54 INFO - warning: no files found matching '*.txt' 03:28:54 INFO - no previously-included directories found matching 'build' 03:28:54 INFO - no previously-included directories found matching 'dist' 03:28:54 INFO - no previously-included directories found matching '.git*' 03:28:54 INFO - Installing collected packages: jsonschema, functools32 03:28:54 INFO - Running setup.py install for functools32 03:28:54 INFO - warning: no files found matching '*.txt' 03:28:54 INFO - no previously-included directories found matching 'build' 03:28:54 INFO - no previously-included directories found matching 'dist' 03:28:54 INFO - no previously-included directories found matching '.git*' 03:28:54 INFO - Successfully installed jsonschema functools32 03:28:54 INFO - Cleaning up... 03:28:54 INFO - Return code: 0 03:28:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:54 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 0x7fd9bf972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884410>, '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 0x2885310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28857a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:28:54 INFO - Using env: {'DISPLAY': ':0', 03:28:54 INFO - 'HOME': '/home/cltbld', 03:28:54 INFO - 'LANG': 'en_US.UTF-8', 03:28:54 INFO - 'LANGUAGE': 'en_US:en', 03:28:54 INFO - 'LOGNAME': 'cltbld', 03:28:54 INFO - 'MAIL': '/var/mail/cltbld', 03:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:54 INFO - 'MOZ_NO_REMOTE': '1', 03:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:54 INFO - 'NO_EM_RESTART': '1', 03:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:54 INFO - 'PWD': '/builds/slave/test', 03:28:54 INFO - 'SHELL': '/bin/bash', 03:28:54 INFO - 'SHLVL': '1', 03:28:54 INFO - 'TERM': 'linux', 03:28:54 INFO - 'TMOUT': '86400', 03:28:54 INFO - 'USER': 'cltbld', 03:28:54 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 03:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:54 INFO - '_': '/tools/buildbot/bin/python'} 03:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:54 INFO - Downloading/unpacking flake8 03:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:28:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:28:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:28:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:28:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:28:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:28:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:28:57 INFO - no previously-included directories found matching 'docs/_build' 03:28:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:28:57 INFO - Running setup.py install for pep8 03:28:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:28:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:28:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:28:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:28:57 INFO - no previously-included directories found matching 'docs/_build' 03:28:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:28:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:28:57 INFO - Cleaning up... 03:28:57 INFO - Return code: 0 03:28:57 INFO - Running post-action listener: _resource_record_post_action 03:28:57 INFO - Running post-action listener: _start_resource_monitoring 03:28:57 INFO - Starting resource monitoring. 03:28:57 INFO - ##### 03:28:57 INFO - ##### Running install step. 03:28:57 INFO - ##### 03:28:57 INFO - Running pre-action listener: _resource_record_pre_action 03:28:57 INFO - Running main action method: install 03:28:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:57 INFO - Reading from file tmpfile_stdout 03:28:57 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:58 INFO - Reading from file tmpfile_stdout 03:28:58 INFO - Output received: 03:28:58 INFO - Usage: mozinstall [options] installer 03:28:58 INFO - Options: 03:28:58 INFO - -h, --help show this help message and exit 03:28:58 INFO - -d DEST, --destination=DEST 03:28:58 INFO - Directory to install application into. [default: 03:28:58 INFO - "/builds/slave/test"] 03:28:58 INFO - --app=APP Application being installed. [default: firefox] 03:28:58 INFO - mkdir: /builds/slave/test/build/application 03:28:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:29:13 INFO - Reading from file tmpfile_stdout 03:29:13 INFO - Output received: 03:29:13 INFO - /builds/slave/test/build/application/firefox/firefox 03:29:13 INFO - Running post-action listener: _resource_record_post_action 03:29:13 INFO - ##### 03:29:13 INFO - ##### Running run-tests step. 03:29:13 INFO - ##### 03:29:13 INFO - Running pre-action listener: _resource_record_pre_action 03:29:13 INFO - Running main action method: run_tests 03:29:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:29:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:29:13 INFO - Python 2.7.3 03:29:13 INFO - Return code: 0 03:29:13 INFO - grabbing minidump binary from tooltool 03:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:13 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 0x2884410>, '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 0x2885310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28857a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:29:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:29:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:29:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:29:13 INFO - Return code: 0 03:29:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:29:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:29:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:29:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:29:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:29:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:29:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:29:14 INFO - Return code: 0 03:29:14 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/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:29:14 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/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:29:14 INFO - Using env: {'DISPLAY': ':0', 03:29:14 INFO - 'HOME': '/home/cltbld', 03:29:14 INFO - 'LANG': 'en_US.UTF-8', 03:29:14 INFO - 'LANGUAGE': 'en_US:en', 03:29:14 INFO - 'LOGNAME': 'cltbld', 03:29:14 INFO - 'MAIL': '/var/mail/cltbld', 03:29:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:14 INFO - 'MOZ_NO_REMOTE': '1', 03:29:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:14 INFO - 'NO_EM_RESTART': '1', 03:29:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:14 INFO - 'PWD': '/builds/slave/test', 03:29:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:14 INFO - 'SHELL': '/bin/bash', 03:29:14 INFO - 'SHLVL': '1', 03:29:14 INFO - 'TERM': 'linux', 03:29:14 INFO - 'TMOUT': '86400', 03:29:14 INFO - 'USER': 'cltbld', 03:29:14 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004', 03:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:14 INFO - '_': '/tools/buildbot/bin/python'} 03:29:14 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/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:29:14 INFO - mozversion application_buildid: 20160529004021 03:29:14 INFO - mozversion application_changeset: bfea62662298a8400d559abd40ec7d4d12fbd97d 03:29:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:29:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:29:14 INFO - mozversion application_name: Firefox 03:29:14 INFO - mozversion application_remotingname: firefox-dev 03:29:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:29:14 INFO - mozversion application_vendor: Mozilla 03:29:14 INFO - mozversion application_version: 48.0a2 03:29:14 INFO - mozversion platform_buildid: 20160529004021 03:29:14 INFO - mozversion platform_changeset: bfea62662298a8400d559abd40ec7d4d12fbd97d 03:29:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:29:14 INFO - mozversion platform_version: 48.0a2 03:29:14 INFO - using testdate: 1464517754 03:29:14 INFO - actual date: 1464517754 03:29:14 INFO - starting webserver on 'localhost:48686' 03:29:14 INFO - SUITE-START | Running 2 tests 03:29:14 INFO - TEST-START | dromaeo_css 03:29:14 INFO - operating with platform_type : linux_ 03:29:14 INFO - Initialising browser for dromaeo_css test... 03:29:14 INFO - TEST-INFO | started process 27683 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpONelD6/profile http://localhost:48686/getInfo.html) 03:29:18 INFO - PROCESS | 27683 | __metrics Screen width/height:1600/1200 03:29:18 INFO - PROCESS | 27683 | colorDepth:24 03:29:18 INFO - PROCESS | 27683 | Browser inner width/height: 1024/697 03:29:18 INFO - PROCESS | 27683 | __metrics 03:29:19 ERROR - PROCESS | 27683 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:29:20 INFO - TEST-INFO | 27683: exit 0 03:29:20 INFO - Browser initialized. 03:29:20 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:20 INFO - TEST-INFO | started process 27773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpONelD6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:32 INFO - PROCESS | 27773 | RSS: Main: 141881344 03:29:32 INFO - PROCESS | 27773 | 03:30:24 INFO - PROCESS | 27773 | 1464517824651 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:32:31 INFO - PROCESS | 27773 | Cycle 1(1): loaded http://localhost:48686/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48686/tests/dromaeo/cssquery-ext.html) 03:32:32 INFO - PROCESS | 27773 | RSS: Main: 251858944 03:32:32 INFO - PROCESS | 27773 | 03:35:34 INFO - PROCESS | 27773 | Cycle 1(1): loaded http://localhost:48686/tests/dromaeo/cssquery-ext.html (next: http://localhost:48686/tests/dromaeo/cssquery-jquery.html) 03:35:35 INFO - PROCESS | 27773 | RSS: Main: 221958144 03:35:35 INFO - PROCESS | 27773 | 03:38:36 INFO - PROCESS | 27773 | Cycle 1(1): loaded http://localhost:48686/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48686/tests/dromaeo/cssquery-mootools.html) 03:38:37 INFO - PROCESS | 27773 | RSS: Main: 222453760 03:38:37 INFO - PROCESS | 27773 | 03:41:39 INFO - PROCESS | 27773 | Cycle 1(1): loaded http://localhost:48686/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48686/tests/dromaeo/cssquery-prototype.html) 03:41:39 INFO - PROCESS | 27773 | RSS: Main: 215801856 03:41:39 INFO - PROCESS | 27773 | 03:44:42 INFO - PROCESS | 27773 | Cycle 1(1): loaded http://localhost:48686/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48686/tests/dromaeo/cssquery-yui.html) 03:44:42 INFO - PROCESS | 27773 | RSS: Main: 210214912 03:44:42 INFO - PROCESS | 27773 | 03:47:45 INFO - PROCESS | 27773 | Cycle 1(1): loaded http://localhost:48686/tests/dromaeo/cssquery-yui.html (next: http://localhost:48686/tests/dromaeo/cssquery-dojo.html) 03:47:45 INFO - PROCESS | 27773 | RSS: Main: 259239936 03:47:45 INFO - PROCESS | 27773 | 03:47:45 INFO - PROCESS | 27773 | __start_tp_report 03:47:45 INFO - PROCESS | 27773 | _x_x_mozilla_page_load 03:47:45 INFO - PROCESS | 27773 | _x_x_mozilla_page_load_details 03:47:45 INFO - PROCESS | 27773 | |i|pagename|runs| 03:47:45 INFO - PROCESS | 27773 | |0;dojo.html;3251.235959549506;3304.636489986101;3308.619508756494;3329.2509185433296;3342.715869151122;5411.3506379234495;5412.107002344608;5417.6478528895595;5418.4310647382;5421.051316019691;5397.649152805065;5398.750990585082;5430.456954304567;5437.945620543794;5455.890882182364;4853.0779151961015;4899.999999999991;4913.803447862081;4998.700077995332;5033.974830125844;4877.317175595419;4897.853064408056;4947.925781113268;4948.084604348207;5042.647014708953;4933.851984440473;4947.282644016615;4958.826441074563;4973.129702302101;4990.900181996358;4845.951540484585;4850.175470170045;4915.45929947709;4958.727270000149;4978.950210497903;4904.5340692634145;4910.508949105097;4914.066327397783;4931.65478416511;4956.752162391866;5314.707691076989;5329.440408757064;5354.571634269288;5362.490563396471;5377.892442151174;5642.802501912454;5698.914516282259;5726.31284245889;5772.3938986406665;5777.682227477487;5824;5828.358880523139;5857.4435428634215;5873.618214816023;5899.262592175978;5447.536959358459;5454.645448045864;5455.8363249102595;5456.263404440389;5457.645253058538;5801.216835727208;5890.1164825276555;5924.259467566554;6034.336223015464;6040;5700.515456186187;5717.371089180187;5718.313802343662;5722.2561067061015;5724.656520608777;5756.309242890796;5803.216565763652;5813.7383817728305;5822.970885145547;5835.4748072673665;5672.489475947102;5759.1649210865025;5806.970965145148;5845.1232315153065;5846.941530584725;5742.942570574324;5771.394003629643;5798.362180160179;5801.564882633819;5807.0998995155815;4372.191144638252;4449.9555004450185;4460.531644177379;4463.754493502888;4497.775111244425;3990.940135897964;4012.117334186474;4036.6972477064337;4053.6757059435176;4063.5326937401987;5498.505134537911;5498.560115190855;5516.062269414209;5524.14375771756;5538.501534861882;5713;5726.255586773693;5829.5336373090895;5855.648661080349;5858.297004359419;5578.86052848682;5582.385937546866;5588.413216612278;5610;5623.156526520973;4960.652754307164;4972.801087956441;4974.552290293891;4978.6017118630425;5010.974945125251;5919.141724449931;5966.970165149147;6121.173641558333;6121.969390153021;6135.018397056449;5873.911891321719;5874.118882167709;5881.5588830838715;5886.411358864165;5918.704064796829;6046.486048685735;6091.786787462417;6101.542384321282;6101.877962440815;6126;5642.040853055072;5676.063449530781;5721.313442386941;5735.7418916148035;5773.509251713652;5826;5841.1238314253205;5865.266841644794;5882.176495290748;5911.467967882912;5704.458076482728;5708.971455142698;5715.371309155907;5718.571107166896;5725.312962444534;5574.414686458026;5667.801626943037;5687.71561421919;5710.65736055838;5747.453991870766;5627.7467513961155;5629.211910332639;5634.85912852182;5648.23748793924;5656.264685591012;5733.885322293614;5740.827775166752;5754.53963682896;5758.654480731002;5763.7406316715005;5491.313585801775;5503.972480137573;5568.443155684399;5637.661740295595;5655.915161272502 03:47:45 INFO - PROCESS | 27773 | |1;ext.html;607.7994261893573;657.3262406033817;667.1160712056525;669.4008862068448;685.7359916432172;34099.31801363974;39777.60222397775;40882.795586022105;41431.378529322006;41657.58342416575;45091.54908450915;45548.772256138756;45651.08697826041;45714.542854571446;45775.54224457755;8187.754367368989;9056.230220431255;9294;9295.745074414936;10523.52644131016;10831;11005.559777608885;11006.944965275163;11007.394593297366;11008;11058.170637202202;11135.33188008722;11144.108471322275;11151.275167114152;11151.721206969809;8423.873641895376;8728.345374096905;10719;10969.341839489616;11038.17213708967;10500.159987201005;10637.36175829445;10642;10666.14670826332;10666.36001839892;40731.7963410184;41384.58615413837;41417.792911035554;41428.1714365711;41436.79281603603;3826.024363787244;3896.649301562845;3911.3546264866263;3935.9016024599327;3992.500937382827;34044.48933266003;34918.476222856676;34929.82535087334;35014.12464688378;35183.82408087943;4574.245249533823;4580.083983203373;4654.650901182425;4670.182718024332;4675.929861052087;317721;317846;319753;320104;320575;63036.684816575624;63111.684441578414;63580;63664;63672.36327636665;66185.66907165434;70021;71452.2854771456;71458;71509.64245178741;16961.40635077791;17101.914490427716;17112.315507379815;17112.57218569546;17125.57186070358;11876.584319548947;14692.926535367254;15121;15160.696786064438;15176.317065732068;19973.900130499256;20187.091580878896;20250.797492025187;20295.391138265877;20343.79656203419;6986.685599148051;7240;7328.743493977685;7355.007074045043;7544;1117.9888201117885;1127.9548818047351;1220.7436438348047;1224.7060705430633;1234.493857518431;32773.83613081967;34311.485327720104;35746.64253357485;37140.62859371426;37410.8129459351;1171.1333613126226;1173.7359094203737;1255.3409460033556;1264.595329494553;1275.8660340664096;16968.23642936071;17475.427211550767;17539.473815785546;17539.473815785546;17629;490882;493114;494058;497982;498167;60507;60829.39170608326;61115;61166.38833611696;61284.38715612876;1383.522684673786;1426.5078547900957;1466.5013895275445;1485.3167542930157;1520.0271826031349;29913.9060265788;31798.841005795748;32909.83545082259;33589.49615755815;33727;51021.23468148055;51795.223071654706;52080.09399294992;52235;52237.216441754164;349507;353013;354042;354101;354458;30274.004789210416;30700.232494187825;30758.384832303676;30960.535591965687;31050.534241985937;49138.262926055424;51566.22650660168;52025.7398713004;52255.21617175669;53105.7344713274;38399.80800095982;38888.22223555457;40124.799376002935;40908.795456022526;42596.57403425926;40022.1995560093;40212.59255926029;41196.33766052581;41373;41996.580034199265;42957.35563966606;43276.78361608172;49163;49311.75344123256;49959.75020124876;34104.31791364209;36189.457158143174;36757.44863827098;37390.439143412324;37621.62378376181;28563.714362856106;29090.709092909645;29354;29376.26559336034;29613.407731845673 03:47:45 INFO - PROCESS | 27773 | |2;jquery.html;432.5436664319146;439.7845055922598;440.77961019490255;442.250897699598;452.8437688997297;18020;18423;19151.808481915177;19221.615567688637;19225.423237302904;19298.51753706158;19592.314269000588;20503.282385116523;20544.589108217864;20564.691529627067;5560.6941618211085;5597.412271711452;5815.970920145393;5827.941720582803;5841.240638716961;5725.770969161229;5727.914081288784;5783.768649254025;5789.536837053047;5801.129830525434;5582.553395728332;5705.65766054036;5730;5743.770249190027;5781.479666829984;5676.035074037403;5685.715714214272;5693.886122277573;5701.401352857932;5701.71491425427;4977.676451030671;5148.459411761749;5230.110881150214;5254.08053590624;5266.183741520071;23767.524649507086;23912;24062;24529.754702453105;24532.264032079067;2555.3611597100726;2635.262126604554;2723.986380068107;2734.357515504465;2823.308289469073;14761.261936903113;14999.925000374928;15237.61905952349;15566.766498502531;15701.057936523845;2058.5265388960474;2101.9385210468768;2341.555104530134;2402.2072716003677;2419.6491508731137;67012.66493667549;71700.64149679219;79327.60336198397;83230;87233.56383218107;18238.361657342193;18299.451016469528;18406.723899141525;18607.34874279421;18716.344927927457;33456.330873382394;33577.83211083978;33927.4910876337;34161.31677366488;34179.316413671586;9618.51907404627;10158.746031349128;10191.286609937233;10294.279400441897;10356.792864142675;8596.914030859736;8612.18184272493;8615.22462978335;8683.435576687496;8694.217520423192;9214.308926830514;9355.859662105075;9384.296177786693;9547.90452095484;9644.469554174588;3292.654271301527;3297.378584025705;3495.178633021238;3548.0242933193063;3608.476770868262;996.5117092624706;1059.7774467361787;1079.4818487126224;1082.4966390628394;1098.7033500954697;18254;18464.446066618024;19055.333063342718;19332.323368682028;19923.402297931087;1035.5495359518634;1046.8959534978671;1100.14738577603;1108.695108845074;1133.0878642692546;9976.002399760111;11142.61000864982;11189.72025699364;11239.775204496027;11322.094232461382;525478;537144;544302;547765;549269;84510.57744711237;89414;89464;92419.53790231005;94295;1039.8908114648004;1061.9734506637396;1070.9357438553711;1078.2021304234809;1086.842407850873;17033.31866725317;17171.65656686884;17265.913670431568;17273;17367;38681.99999999887;38998.80500597479;39524.604753952095;40096.7995160034;40207;53112;56120;56788.43211567831;56890.715546422005;56914.430855690916;9051.637934482547;9268.814623707623;9332.533373331442;9543.713688589354;9677.903220967983;13540.661483462993;13969.51106711301;14043.08719933201;14092.295385230493;14272.215028173136;6054.122152287981;7872;11886.28682279066;12200.084993625336;12572.371381431074;11118.555257789598;11668.766624667289;11798.233114847508;12067;12259;9926.858411282506;9992.300538962494;11979.401029948292;12022.33877136731;13105.737885242432;8991.55042247898;9082.818343632958;9353.11145441182;9369.953150234205;9481.383710058824;9137.417849908436;12490.87509124897;12512.624621261377;12538.122331436713;12761.93619031899 03:47:45 INFO - PROCESS | 27773 | |3;mootools.html;1371.8079468874353;1545.7835902973582;1560.056166019558;1721.7675613792135;1846.870719049667;8199;8387.832243355137;8392.91607083929;8403;8409;8087.757367278977;8185.427020108595;8256.050554186271;8258.545779982098;8263.049749278834;2467.062516243825;2482.156066937241;2489.2781093482868;2500.112460076674;2501.6247562865533;2481.702195736514;2552.8595927223996;2560.359910022494;2561.884715187821;2566.47387285606;2430.890609922558;2533.7086235083016;2552.336392537944;2554.7317531659187;2556.028709090543;2444.2667199840066;2455.8894849731714;2460.4832985073067;2526.5325914705836;2533.1007492340136;2500.1249562652924;2528.190978886757;2548.1845809341016;2548.413864811085;2549.120553409071;8183.140770219101;8363.456375335583;8395.286400655952;8445;8450.87323690145;5288.524032837063;5321.148616221386;5322.20166974953;5364.544013758835;5368.248445217672;3565.3047655706887;3573.5175751273505;3579.480975258599;3596.8381422835773;3608.4046132388125;1126.633844000703;1136.6476392318407;1142.4973011874831;1159.8956093951585;1179.9233049851732;11589.6523104307;11670.708232294175;11709.414529273503;11747.47136378865;11772.587959421378;4720.905581888412;4804.975975120102;4814.0743702518575;4839.879003024882;4909.68087074339;9339.206167475704;9393.953030234941;9414.623415063457;9435.481048542259;9439.772829532254;5488.9725551371985;5494.587905907073;5498.532624726943;5501.724913754377;5505.669659820343;4387.780610969438;4925.064237794808;4994.775235114428;5038.521340472649;5126.256692779526;3984.4820173377275;4013.13717550728;4050.5341885682933;4067.9389809152885;4082.183563287295;1210.7820592293472;1250.6998320403038;1253.7367152897812;1269.60642200918;1283.3903895649678;808.7925174287321;872.5462759365095;1017.9389236645825;1020.3418794877263;1038.3562191441354;5661.575381846378;5699.715014249354;5768.884622307531;5783.797567085132;6158.969205153946;943.778212120165;975.8048390321964;988.7182153086336;1026.38416949831;1042.5777560088177;4102.446169767103;4118.423420721101;4119;4125.051238215227;4135.400366946776;9912.107910288109;10084.848727269096;10238.59045638181;10266.691999240034;10270.127039201752;10417.791644167226;10445.791084178274;10452.477376131163;10458.477076146162;10469.581216751398;7840.09838868526;8055.234752698367;8116.107228204893;8161.143079976517;8240.670373185005;5939.316978547349;5995.46040856325;6039.698015099139;6076.8784624308155;6120.143179954899;9329.860052099088;9358.485283309483;9495.47774872361;9646.710598682052;9745.561449734638;9121.908780912107;9644.662436814679;9818.214542836698;9873.555689993824;9908.405495670282;6756.4257038150345;6905.447564194752;7282.198958114497;7522.661480233293;7669.846603068019;7926.167752385916;7934.404919630935;7958.1643927389105;7996.440249182501;8010.078840933134;7181.892271616034;7319.34125928669;7343.1555371133;7442.479026468095;7451.813704657427;6840.452763778985;6882.070920425678;6996.860062798613;7101.538400003983;7211.3870321023305;6620.205575330799;6655.467562594884;6660.833479162866;6668.566543174678;6680;5059.291699162194;5129.2819005340025;5181.870453238699;5190.532852043334;5212.478752124909;4956.6778159420965;5035.345405097314;5056.646034777677;5128.79484820603;5141.53726164647 03:47:45 INFO - PROCESS | 27773 | |4;prototype.html;366.95046168767215;367.0914486645553;367.92825399047194;368.4804425759678;376.16679055891194;6013.27840659121;6025.548083893709;6114.1745864308305;6122.051082082273;6123;5869.530437564995;6001.2498437695285;6001.459868611824;6008.639481631105;6011.849703757408;4637.304404339351;4691.132140554008;4711.952880471185;4735.337052812609;4773.379460670108;4724.338592597022;4750.786214620333;4754.575166664991;4760.452547956995;4766.189747742875;4551.385562949009;4708.364370809948;4718.19790635591;4722.315264286676;4728.763561821896;4570.405847239854;4651.069786042788;4663.973925736333;4667.369905062807;4671.439427268716;4188.497380314351;4188.769617671027;4198.223328684203;4202.327627579603;4204.096119334327;5859.154366374579;5861.150133230701;5862.38444963277;5870.354261031283;5884.705764711747;5485.835424937259;5486.753096110685;5494.642848214853;5496.065668836308;5496.80761173357;6315.052742088677;6431.517636177258;6437.645929473877;6450.290468048511;6451.967740161316;4647.442306923157;4663.253879379317;4663.533646635343;4665.066986602659;4668.696534725266;6676.93323066768;6689.464842812612;6709.966450167767;6729.831754206135;6756.763513277061;4765.213739732905;4771.06964141989;4771.73755443454;4777.235642297285;4777.784999674954;4838.419389673191;4842.055799119138;4846.36997190363;4848.539388758062;4848.927266091011;5475.206095116186;5482.068048431776;5490.258815059916;5491.615586908958;5498.477644623755;6341.492680585542;6439.54923155384;6467.51493637979;6472.708728107246;6483.610983341015;1670.4571014420362;1699.3202718912287;1700.4558541266676;1706.2492503298508;1710.1962077823403;1070.5985255529176;1129.203911242572;1142.9771404571861;1149.7010777197822;1160.3907948327196;6210.968945155245;6277.8744425111245;6280.685965701697;6283.08895210192;6291;6634.13756211699;6642.335766423319;6642.966785166043;6643.269240383554;6653.334666533405;6273.937260627426;6278.372162783777;6280.685965701697;6282.246130464374;6288.496920246369;3547.7161827053774;3565.8038807865814;3576.0523461282783;3577.6601222883783;3582.46263060543;6785.5151554026625;6851.931480685229;6906.792796216121;6925.3074692530345;6935.167779866348;6693.899591506131;6720.4287635550545;6724.29394913527;6736.730530778812;6741.595504269661;6897.862042759117;6899.448044156456;6905.482088843256;6911.03245545624;6921.204061532988;6575.046618240424;6591.571547849375;6593.967030164818;6604.801855944329;6614.206295244601;6395.488360931207;6494.350564943468;6495.707693153725;6639.103720997797;6641.402273795382;6994.055802466602;7031.683574239274;7039.648017598997;7047.154341479055;7048.506604537838;4607.170709272363;4640;4650.488446270975;4652.790624421977;4655.022445286528;6619.040239165198;6669.53313268086;6669.966650166718;6677.899831502628;6678.799636010927;6358.268799088164;6491.772787952399;6493.512986526124;6498.090267362479;6513.837154071186;6420.518461115342;6453.354664533509;6461.160049193575;6468.6442245676935;6471.385218404244;6351.841203969938;6352.237731472068;6352.618842869442;6352.872942541216;6356.650384228912;6505.349465053457;6507.577007494498;6512.446442052478;6516.869662606816;6519.152510173647;6042.244719410074;6111.388861113853;6266.592671476339;6353.36466353361;6363 03:47:45 INFO - PROCESS | 27773 | |5;yui.html;873.6287077991852;885.2608072259662;892.2193081054073;909.095450027223;923.2873020546883;13448.731025379486;13558.525451609195;13564;13577;13644.863551364495;13157.276349800757;13266.93366533166;13291.468341266338;13298.202107873534;13310.933445332785;766.9961650191769;893.3567831161586;907.8048219632777;919.4345477531336;923.7182659288948;901.0403919825397;909.2680392284209;909.5588639509865;909.6497848328409;909.9363044586881;947.8151760406723;950.771814764455;953.408886490377;953.9713808585753;955.6702937486556;801.9198080192022;929.4005366538612;944.6929747831948;945.1493655709882;951.8143961927427;700.6496751624188;701.7263267325746;701.9964900175518;702.034702284359;702.199492578461;12840.61478155657;13213.867861321456;13248.536301229507;13281.933590332083;13285.601431957057;13464.326783660777;13939.16365018102;14090.506832260822;14099.577012689635;14186.43254269828;12081.791820817936;12241.143119981605;12372.07209459294;12425.130240883142;12491.188072775241;4039.97980010101;4043.433919251307;4048.3725022621543;4054.2499637567144;4094.754314741125;56499;59761.40238597602;59821.401785982016;59981.10028349578;60062.39937600612;11204.15968802343;11437.485313160927;11564.248323858923;11623;11709.355985420883;20391.592168156552;20509.17963281452;20584.485387865425;21127.683084753742;21142.57714845725;8478.8502172787;8555.61499732501;8619.051904290523;8698.695545655872;8726;4903.754812259444;4949.880597163122;4972.801087956514;5045.646804723708;5048.848534543969;3574.767640103385;3631.6731494165124;3636.56361236648;3637.6907962823457;3637.909052273714;652.4617190817595;663.4824836627438;677.8237658208901;692.5809885019592;693.7051753005054;782.7025730222479;783.5494590610422;787.7676085554775;790.4387884601997;800.1758189065272;9384.5307734613;9471.857922131174;9501.667441639509;9903.306768526134;10094.798104037878;736.5654263984275;747.6859718918067;754.4718696912183;769.1846642558905;794.4002278279862;4540.160070386989;4556.681032327705;4557.339185818038;4634.95365046352;4636.049609829976;61013.38986610166;61397.38602614006;61676;61832.69083654553;61992.69003655043;55036.72481637566;55475.16787248194;55587.166192507146;55924.16113758297;56288.5927851807;48171;50093.74953125284;50336.49663503392;50669.239961400606;50727;9260.351775375659;9322;9394.389364691273;9416.95291523538;9549.331546791936;35458.822705886305;35744.28511429705;37660;40005.19989600134;40036.399454008795;44593.55406446024;47910.28134578054;48063;48326.27510587274;48994.26508602303;11988.520459181535;12120.696982575153;12303.815442768187;12548.24710517372;12552.686182845136;13901.860981390057;13967.092139010932;14331.498397556035;14418.279086045446;14589.635259118182;12605.180663256859;13071.346432678518;13173.736525269633;13488;13677.931610341884;12912.548060817826;12934;12941.935290323489;12975.935120324339;13017.349132543146;12688.429020693906;13291.933540332237;13664.65838354049;13802.654933626338;13907.165570065828;10965.725856853642;11370.715732106764;11467.827982580102;11470.82793758111;11682.532698691957;10926.50830712604;11100.167487438635;11712.180147389941;11873.465694043962;11951.282923024646 03:47:45 INFO - PROCESS | 27773 | __end_tp_report 03:47:45 INFO - PROCESS | 27773 | __start_cc_report 03:47:45 INFO - PROCESS | 27773 | _x_x_mozilla_cycle_collect,894 03:47:45 INFO - PROCESS | 27773 | __end_cc_report 03:47:45 INFO - PROCESS | 27773 | __startTimestamp1464518865543__endTimestamp 03:47:45 INFO - PROCESS | 27773 | 03:47:45 INFO - PROCESS | 27773 | ------- Summary: start ------- 03:47:45 INFO - PROCESS | 27773 | Number of tests: 6 03:47:45 INFO - PROCESS | 27773 | 03:47:45 INFO - PROCESS | 27773 | [#0] dojo.html Cycles:165 Average:5411.14 Median:5637.66 stddev:597.04 (10.6%) stddev-sans-first:574.32 03:47:45 INFO - PROCESS | 27773 | Values: 3251.2 3304.6 3308.6 3329.3 3342.7 5411.4 5412.1 5417.6 5418.4 5421.1 5397.6 5398.8 5430.5 5437.9 5455.9 4853.1 4900.0 4913.8 4998.7 5034.0 4877.3 4897.9 4947.9 4948.1 5042.6 4933.9 4947.3 4958.8 4973.1 4990.9 4846.0 4850.2 4915.5 4958.7 4979.0 4904.5 4910.5 4914.1 4931.7 4956.8 5314.7 5329.4 5354.6 5362.5 5377.9 5642.8 5698.9 5726.3 5772.4 5777.7 5824.0 5828.4 5857.4 5873.6 5899.3 5447.5 5454.6 5455.8 5456.3 5457.6 5801.2 5890.1 5924.3 6034.3 6040.0 5700.5 5717.4 5718.3 5722.3 5724.7 5756.3 5803.2 5813.7 5823.0 5835.5 5672.5 5759.2 5807.0 5845.1 5846.9 5742.9 5771.4 5798.4 5801.6 5807.1 4372.2 4450.0 4460.5 4463.8 4497.8 3990.9 4012.1 4036.7 4053.7 4063.5 5498.5 5498.6 5516.1 5524.1 5538.5 5713.0 5726.3 5829.5 5855.6 5858.3 5578.9 5582.4 5588.4 5610.0 5623.2 4960.7 4972.8 4974.6 4978.6 5011.0 5919.1 5967.0 6121.2 6122.0 6135.0 5873.9 5874.1 5881.6 5886.4 5918.7 6046.5 6091.8 6101.5 6101.9 6126.0 5642.0 5676.1 5721.3 5735.7 5773.5 5826.0 5841.1 5865.3 5882.2 5911.5 5704.5 5709.0 5715.4 5718.6 5725.3 5574.4 5667.8 5687.7 5710.7 5747.5 5627.7 5629.2 5634.9 5648.2 5656.3 5733.9 5740.8 5754.5 5758.7 5763.7 5491.3 5504.0 5568.4 5637.7 5655.9 03:47:45 INFO - PROCESS | 27773 | 03:47:45 INFO - PROCESS | 27773 | [#1] ext.html Cycles:180 Average:57223.95 Median:36949.04 stddev:104493.16 (282.8%) stddev-sans-first:104699.83 03:47:45 INFO - PROCESS | 27773 | Values: 607.8 657.3 667.1 669.4 685.7 34099.3 39777.6 40882.8 41431.4 41657.6 45091.5 45548.8 45651.1 45714.5 45775.5 8187.8 9056.2 9294.0 9295.7 10523.5 10831.0 11005.6 11006.9 11007.4 11008.0 11058.2 11135.3 11144.1 11151.3 11151.7 8423.9 8728.3 10719.0 10969.3 11038.2 10500.2 10637.4 10642.0 10666.1 10666.4 40731.8 41384.6 41417.8 41428.2 41436.8 3826.0 3896.6 3911.4 3935.9 3992.5 34044.5 34918.5 34929.8 35014.1 35183.8 4574.2 4580.1 4654.7 4670.2 4675.9 317721.0 317846.0 319753.0 320104.0 320575.0 63036.7 63111.7 63580.0 63664.0 63672.4 66185.7 70021.0 71452.3 71458.0 71509.6 16961.4 17101.9 17112.3 17112.6 17125.6 11876.6 14692.9 15121.0 15160.7 15176.3 19973.9 20187.1 20250.8 20295.4 20343.8 6986.7 7240.0 7328.7 7355.0 7544.0 1118.0 1128.0 1220.7 1224.7 1234.5 32773.8 34311.5 35746.6 37140.6 37410.8 1171.1 1173.7 1255.3 1264.6 1275.9 16968.2 17475.4 17539.5 17539.5 17629.0 490882.0 493114.0 494058.0 497982.0 498167.0 60507.0 60829.4 61115.0 61166.4 61284.4 1383.5 1426.5 1466.5 1485.3 1520.0 29913.9 31798.8 32909.8 33589.5 33727.0 51021.2 51795.2 52080.1 52235.0 52237.2 349507.0 353013.0 354042.0 354101.0 354458.0 30274.0 30700.2 30758.4 30960.5 31050.5 49138.3 51566.2 52025.7 52255.2 53105.7 38399.8 38888.2 40124.8 40908.8 42596.6 40022.2 40212.6 41196.3 41373.0 41996.6 42957.4 43276.8 49163.0 49311.8 49959.8 34104.3 36189.5 36757.4 37390.4 37621.6 28563.7 29090.7 29354.0 29376.3 29613.4 03:47:45 INFO - PROCESS | 27773 | 03:47:45 INFO - PROCESS | 27773 | [#2] jquery.html Cycles:180 Average:31332.09 Median:33752.66 stddev:88639.30 (262.6%) stddev-sans-first:88857.59 03:47:45 INFO - PROCESS | 27773 | Values: 432.5 439.8 440.8 442.3 452.8 18020.0 18423.0 19151.8 19221.6 19225.4 19298.5 19592.3 20503.3 20544.6 20564.7 5560.7 5597.4 5816.0 5827.9 5841.2 5725.8 5727.9 5783.8 5789.5 5801.1 5582.6 5705.7 5730.0 5743.8 5781.5 5676.0 5685.7 5693.9 5701.4 5701.7 4977.7 5148.5 5230.1 5254.1 5266.2 23767.5 23912.0 24062.0 24529.8 24532.3 2555.4 2635.3 2724.0 2734.4 2823.3 14761.3 14999.9 15237.6 15566.8 15701.1 2058.5 2101.9 2341.6 2402.2 2419.6 67012.7 71700.6 79327.6 83230.0 87233.6 18238.4 18299.5 18406.7 18607.3 18716.3 33456.3 33577.8 33927.5 34161.3 34179.3 9618.5 10158.7 10191.3 10294.3 10356.8 8596.9 8612.2 8615.2 8683.4 8694.2 9214.3 9355.9 9384.3 9547.9 9644.5 3292.7 3297.4 3495.2 3548.0 3608.5 996.5 1059.8 1079.5 1082.5 1098.7 18254.0 18464.4 19055.3 19332.3 19923.4 1035.5 1046.9 1100.1 1108.7 1133.1 9976.0 11142.6 11189.7 11239.8 11322.1 525478.0 537144.0 544302.0 547765.0 549269.0 84510.6 89414.0 89464.0 92419.5 94295.0 1039.9 1062.0 1070.9 1078.2 1086.8 17033.3 17171.7 17265.9 17273.0 17367.0 38682.0 38998.8 39524.6 40096.8 40207.0 53112.0 56120.0 56788.4 56890.7 56914.4 9051.6 9268.8 9332.5 9543.7 9677.9 13540.7 13969.5 14043.1 14092.3 14272.2 6054.1 7872.0 11886.3 12200.1 12572.4 11118.6 11668.8 11798.2 12067.0 12259.0 9926.9 9992.3 11979.4 12022.3 13105.7 8991.6 9082.8 9353.1 9370.0 9481.4 9137.4 12490.9 12512.6 12538.1 12761.9 03:47:45 INFO - PROCESS | 27773 | 03:47:45 INFO - PROCESS | 27773 | [#3] mootools.html Cycles:180 Average:5639.11 Median:5161.70 stddev:3020.02 (58.5%) stddev-sans-first:3011.46 03:47:45 INFO - PROCESS | 27773 | Values: 1371.8 1545.8 1560.1 1721.8 1846.9 8199.0 8387.8 8392.9 8403.0 8409.0 8087.8 8185.4 8256.1 8258.5 8263.0 2467.1 2482.2 2489.3 2500.1 2501.6 2481.7 2552.9 2560.4 2561.9 2566.5 2430.9 2533.7 2552.3 2554.7 2556.0 2444.3 2455.9 2460.5 2526.5 2533.1 2500.1 2528.2 2548.2 2548.4 2549.1 8183.1 8363.5 8395.3 8445.0 8450.9 5288.5 5321.1 5322.2 5364.5 5368.2 3565.3 3573.5 3579.5 3596.8 3608.4 1126.6 1136.6 1142.5 1159.9 1179.9 11589.7 11670.7 11709.4 11747.5 11772.6 4720.9 4805.0 4814.1 4839.9 4909.7 9339.2 9394.0 9414.6 9435.5 9439.8 5489.0 5494.6 5498.5 5501.7 5505.7 4387.8 4925.1 4994.8 5038.5 5126.3 3984.5 4013.1 4050.5 4067.9 4082.2 1210.8 1250.7 1253.7 1269.6 1283.4 808.8 872.5 1017.9 1020.3 1038.4 5661.6 5699.7 5768.9 5783.8 6159.0 943.8 975.8 988.7 1026.4 1042.6 4102.4 4118.4 4119.0 4125.1 4135.4 9912.1 10084.8 10238.6 10266.7 10270.1 10417.8 10445.8 10452.5 10458.5 10469.6 7840.1 8055.2 8116.1 8161.1 8240.7 5939.3 5995.5 6039.7 6076.9 6120.1 9329.9 9358.5 9495.5 9646.7 9745.6 9121.9 9644.7 9818.2 9873.6 9908.4 6756.4 6905.4 7282.2 7522.7 7669.8 7926.2 7934.4 7958.2 7996.4 8010.1 7181.9 7319.3 7343.2 7442.5 7451.8 6840.5 6882.1 6996.9 7101.5 7211.4 6620.2 6655.5 6660.8 6668.6 6680.0 5059.3 5129.3 5181.9 5190.5 5212.5 4956.7 5035.3 5056.6 5128.8 5141.5 03:47:45 INFO - PROCESS | 27773 | 03:47:45 INFO - PROCESS | 27773 | [#4] prototype.html Cycles:180 Average:5436.08 Median:6122.53 stddev:1603.79 (26.2%) stddev-sans-first:1562.50 03:47:45 INFO - PROCESS | 27773 | Values: 367.0 367.1 367.9 368.5 376.2 6013.3 6025.5 6114.2 6122.1 6123.0 5869.5 6001.2 6001.5 6008.6 6011.8 4637.3 4691.1 4712.0 4735.3 4773.4 4724.3 4750.8 4754.6 4760.5 4766.2 4551.4 4708.4 4718.2 4722.3 4728.8 4570.4 4651.1 4664.0 4667.4 4671.4 4188.5 4188.8 4198.2 4202.3 4204.1 5859.2 5861.2 5862.4 5870.4 5884.7 5485.8 5486.8 5494.6 5496.1 5496.8 6315.1 6431.5 6437.6 6450.3 6452.0 4647.4 4663.3 4663.5 4665.1 4668.7 6676.9 6689.5 6710.0 6729.8 6756.8 4765.2 4771.1 4771.7 4777.2 4777.8 4838.4 4842.1 4846.4 4848.5 4848.9 5475.2 5482.1 5490.3 5491.6 5498.5 6341.5 6439.5 6467.5 6472.7 6483.6 1670.5 1699.3 1700.5 1706.2 1710.2 1070.6 1129.2 1143.0 1149.7 1160.4 6211.0 6277.9 6280.7 6283.1 6291.0 6634.1 6642.3 6643.0 6643.3 6653.3 6273.9 6278.4 6280.7 6282.2 6288.5 3547.7 3565.8 3576.1 3577.7 3582.5 6785.5 6851.9 6906.8 6925.3 6935.2 6693.9 6720.4 6724.3 6736.7 6741.6 6897.9 6899.4 6905.5 6911.0 6921.2 6575.0 6591.6 6594.0 6604.8 6614.2 6395.5 6494.4 6495.7 6639.1 6641.4 6994.1 7031.7 7039.6 7047.2 7048.5 4607.2 4640.0 4650.5 4652.8 4655.0 6619.0 6669.5 6670.0 6677.9 6678.8 6358.3 6491.8 6493.5 6498.1 6513.8 6420.5 6453.4 6461.2 6468.6 6471.4 6351.8 6352.2 6352.6 6352.9 6356.7 6505.3 6507.6 6512.4 6516.9 6519.2 6042.2 6111.4 6266.6 6353.4 6363.0 03:47:45 INFO - PROCESS | 27773 | 03:47:45 INFO - PROCESS | 27773 | [#5] yui.html Cycles:180 Average:15329.09 Median:4635.50 stddev:17577.56 (379.2%) stddev-sans-first:17593.35 03:47:45 INFO - PROCESS | 27773 | Values: 873.6 885.3 892.2 909.1 923.3 13448.7 13558.5 13564.0 13577.0 13644.9 13157.3 13266.9 13291.5 13298.2 13310.9 767.0 893.4 907.8 919.4 923.7 901.0 909.3 909.6 909.6 909.9 947.8 950.8 953.4 954.0 955.7 801.9 929.4 944.7 945.1 951.8 700.6 701.7 702.0 702.0 702.2 12840.6 13213.9 13248.5 13281.9 13285.6 13464.3 13939.2 14090.5 14099.6 14186.4 12081.8 12241.1 12372.1 12425.1 12491.2 4040.0 4043.4 4048.4 4054.2 4094.8 56499.0 59761.4 59821.4 59981.1 60062.4 11204.2 11437.5 11564.2 11623.0 11709.4 20391.6 20509.2 20584.5 21127.7 21142.6 8478.9 8555.6 8619.1 8698.7 8726.0 4903.8 4949.9 4972.8 5045.6 5048.8 3574.8 3631.7 3636.6 3637.7 3637.9 652.5 663.5 677.8 692.6 693.7 782.7 783.5 787.8 790.4 800.2 9384.5 9471.9 9501.7 9903.3 10094.8 736.6 747.7 754.5 769.2 794.4 4540.2 4556.7 4557.3 4635.0 4636.0 61013.4 61397.4 61676.0 61832.7 61992.7 55036.7 55475.2 55587.2 55924.2 56288.6 48171.0 50093.7 50336.5 50669.2 50727.0 9260.4 9322.0 9394.4 9417.0 9549.3 35458.8 35744.3 37660.0 40005.2 40036.4 44593.6 47910.3 48063.0 48326.3 48994.3 11988.5 12120.7 12303.8 12548.2 12552.7 13901.9 13967.1 14331.5 14418.3 14589.6 12605.2 13071.3 13173.7 13488.0 13677.9 12912.5 12934.0 12941.9 12975.9 13017.3 12688.4 13291.9 13664.7 13802.7 13907.2 10965.7 11370.7 11467.8 11470.8 11682.5 10926.5 11100.2 11712.2 11873.5 11951.3 03:47:45 INFO - PROCESS | 27773 | -------- Summary: end -------- 03:47:45 INFO - PROCESS | 27773 | 03:47:46 INFO - TEST-INFO | 27773: exit 0 03:47:46 INFO - TEST-OK | dromaeo_css | took 1111375ms 03:47:46 INFO - TEST-START | kraken 03:47:46 INFO - operating with platform_type : linux_ 03:47:46 INFO - Initialising browser for kraken test... 03:47:46 INFO - TEST-INFO | started process 27964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfONc0Q/profile http://localhost:48686/getInfo.html) 03:47:50 INFO - PROCESS | 27964 | __metrics Screen width/height:1600/1200 03:47:50 INFO - PROCESS | 27964 | colorDepth:24 03:47:50 INFO - PROCESS | 27964 | Browser inner width/height: 1024/697 03:47:50 INFO - PROCESS | 27964 | __metrics 03:47:51 ERROR - PROCESS | 27964 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:47:52 INFO - TEST-INFO | 27964: exit 0 03:47:52 INFO - Browser initialized. 03:47:52 INFO - Running cycle 1/1 for kraken test... 03:47:52 INFO - TEST-INFO | started process 28054 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfONc0Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:04 INFO - PROCESS | 28054 | RSS: Main: 141946880 03:48:04 INFO - PROCESS | 28054 | 03:48:06 INFO - PROCESS | 28054 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48686/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:07 INFO - PROCESS | 28054 | RSS: Main: 196452352 03:48:07 INFO - PROCESS | 28054 | 03:48:10 INFO - PROCESS | 28054 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48686/tests/kraken/driver.html?testName=audio-dft) 03:48:10 INFO - PROCESS | 28054 | RSS: Main: 182251520 03:48:10 INFO - PROCESS | 28054 | 03:48:13 INFO - PROCESS | 28054 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48686/tests/kraken/driver.html?testName=audio-fft) 03:48:14 INFO - PROCESS | 28054 | RSS: Main: 272998400 03:48:14 INFO - PROCESS | 28054 | 03:48:16 INFO - PROCESS | 28054 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48686/tests/kraken/driver.html?testName=audio-oscillator) 03:48:16 INFO - PROCESS | 28054 | RSS: Main: 179630080 03:48:16 INFO - PROCESS | 28054 | 03:48:18 INFO - PROCESS | 28054 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48686/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:48:19 INFO - PROCESS | 28054 | RSS: Main: 178683904 03:48:19 INFO - PROCESS | 28054 | 03:48:22 INFO - PROCESS | 28054 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48686/tests/kraken/driver.html?testName=imaging-darkroom) 03:48:23 INFO - PROCESS | 28054 | RSS: Main: 212348928 03:48:23 INFO - PROCESS | 28054 | 03:48:26 INFO - PROCESS | 28054 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48686/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:26 INFO - PROCESS | 28054 | RSS: Main: 212832256 03:48:26 INFO - PROCESS | 28054 | 03:48:29 INFO - PROCESS | 28054 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48686/tests/kraken/driver.html?testName=json-parse-financial) 03:48:30 INFO - PROCESS | 28054 | RSS: Main: 212926464 03:48:30 INFO - PROCESS | 28054 | 03:48:31 INFO - PROCESS | 28054 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48686/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:32 INFO - PROCESS | 28054 | RSS: Main: 192299008 03:48:32 INFO - PROCESS | 28054 | 03:48:34 INFO - PROCESS | 28054 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:34 INFO - PROCESS | 28054 | RSS: Main: 196653056 03:48:34 INFO - PROCESS | 28054 | 03:48:36 INFO - PROCESS | 28054 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:37 INFO - PROCESS | 28054 | RSS: Main: 210104320 03:48:37 INFO - PROCESS | 28054 | 03:48:39 INFO - PROCESS | 28054 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:40 INFO - PROCESS | 28054 | RSS: Main: 211050496 03:48:40 INFO - PROCESS | 28054 | 03:48:43 INFO - PROCESS | 28054 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:48:43 INFO - PROCESS | 28054 | RSS: Main: 208257024 03:48:43 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48686/tests/kraken/driver.html?testName=ai-astar) 03:48:45 INFO - PROCESS | 28054 | RSS: Main: 272293888 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | __start_tp_report 03:48:45 INFO - PROCESS | 28054 | _x_x_mozilla_page_load 03:48:45 INFO - PROCESS | 28054 | _x_x_mozilla_page_load_details 03:48:45 INFO - PROCESS | 28054 | |i|pagename|runs| 03:48:45 INFO - PROCESS | 28054 | |0;ai-astar;111;111;111;109;110;110;105;108;110;109 03:48:45 INFO - PROCESS | 28054 | |1;audio-beat-detection;156;130;158;192;127;159;150;127;184;134 03:48:45 INFO - PROCESS | 28054 | |2;audio-dft;161;161;160;162;162;162;162;161;161;160 03:48:45 INFO - PROCESS | 28054 | |3;audio-fft;76;76;76;177;76;75;76;77;161;76 03:48:45 INFO - PROCESS | 28054 | |4;audio-oscillator;93;92;150;91;91;90;155;93;93;152 03:48:45 INFO - PROCESS | 28054 | |5;imaging-gaussian-blur;116;116;117;116;116;117;117;117;117;117 03:48:45 INFO - PROCESS | 28054 | |6;imaging-darkroom;145;146;145;147;146;147;145;145;144;145 03:48:45 INFO - PROCESS | 28054 | |7;imaging-desaturate;94;95;94;97;95;94;95;94;94;94 03:48:45 INFO - PROCESS | 28054 | |8;json-parse-financial;56;56;57;55;58;55;57;77;55;54 03:48:45 INFO - PROCESS | 28054 | |9;json-stringify-tinderbox;57;58;58;58;58;57;58;57;57;58 03:48:45 INFO - PROCESS | 28054 | |10;stanford-crypto-aes;72;75;75;72;73;74;73;74;74;75 03:48:45 INFO - PROCESS | 28054 | |11;stanford-crypto-ccm;120;117;127;113;117;117;113;111;163;134 03:48:45 INFO - PROCESS | 28054 | |12;stanford-crypto-pbkdf2;161;163;158;166;158;157;160;160;158;156 03:48:45 INFO - PROCESS | 28054 | |13;stanford-crypto-sha256-iterative;65;67;66;66;66;65;64;66;65;67 03:48:45 INFO - PROCESS | 28054 | __end_tp_report 03:48:45 INFO - PROCESS | 28054 | __start_cc_report 03:48:45 INFO - PROCESS | 28054 | _x_x_mozilla_cycle_collect,1587 03:48:45 INFO - PROCESS | 28054 | __end_cc_report 03:48:45 INFO - PROCESS | 28054 | __startTimestamp1464518925622__endTimestamp 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | ------- Summary: start ------- 03:48:45 INFO - PROCESS | 28054 | Number of tests: 14 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.84 (1.7%) stddev-sans-first:1.86 03:48:45 INFO - PROCESS | 28054 | Values: 111.0 111.0 111.0 109.0 110.0 110.0 105.0 108.0 110.0 109.0 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:157.00 stddev:23.06 (14.7%) stddev-sans-first:24.41 03:48:45 INFO - PROCESS | 28054 | Values: 156.0 130.0 158.0 192.0 127.0 159.0 150.0 127.0 184.0 134.0 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 03:48:45 INFO - PROCESS | 28054 | Values: 161.0 161.0 160.0 162.0 162.0 162.0 162.0 161.0 161.0 160.0 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:39.40 (51.8%) stddev-sans-first:41.21 03:48:45 INFO - PROCESS | 28054 | Values: 76.0 76.0 76.0 177.0 76.0 75.0 76.0 77.0 161.0 76.0 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:91.50 stddev:29.25 (32.0%) stddev-sans-first:30.37 03:48:45 INFO - PROCESS | 28054 | Values: 93.0 92.0 150.0 91.0 91.0 90.0 155.0 93.0 93.0 152.0 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:48:45 INFO - PROCESS | 28054 | Values: 116.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 03:48:45 INFO - PROCESS | 28054 | Values: 145.0 146.0 145.0 147.0 146.0 147.0 145.0 145.0 144.0 145.0 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.50 stddev:0.97 (1.0%) stddev-sans-first:1.00 03:48:45 INFO - PROCESS | 28054 | Values: 94.0 95.0 94.0 97.0 95.0 94.0 95.0 94.0 94.0 94.0 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:56.50 stddev:6.78 (12.0%) stddev-sans-first:7.16 03:48:45 INFO - PROCESS | 28054 | Values: 56.0 56.0 57.0 55.0 58.0 55.0 57.0 77.0 55.0 54.0 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:58.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 03:48:45 INFO - PROCESS | 28054 | Values: 57.0 58.0 58.0 58.0 58.0 57.0 58.0 57.0 57.0 58.0 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:74.00 stddev:1.16 (1.6%) stddev-sans-first:1.05 03:48:45 INFO - PROCESS | 28054 | Values: 72.0 75.0 75.0 72.0 73.0 74.0 73.0 74.0 74.0 75.0 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:118.50 stddev:15.63 (13.2%) stddev-sans-first:16.53 03:48:45 INFO - PROCESS | 28054 | Values: 120.0 117.0 127.0 113.0 117.0 117.0 113.0 111.0 163.0 134.0 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:160.00 stddev:3.02 (1.9%) stddev-sans-first:3.17 03:48:45 INFO - PROCESS | 28054 | Values: 161.0 163.0 158.0 166.0 158.0 157.0 160.0 160.0 158.0 156.0 03:48:45 INFO - PROCESS | 28054 | 03:48:45 INFO - PROCESS | 28054 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 03:48:45 INFO - PROCESS | 28054 | Values: 65.0 67.0 66.0 66.0 66.0 65.0 64.0 66.0 65.0 67.0 03:48:45 INFO - PROCESS | 28054 | -------- Summary: end -------- 03:48:45 INFO - PROCESS | 28054 | 03:48:46 INFO - TEST-INFO | 28054: exit 0 03:48:46 INFO - TEST-OK | kraken | took 60393ms 03:48:46 INFO - SUITE-END | took 1171s 03:48:46 INFO - Completed test suite (00:19:31) 03:48:46 INFO - javascript benchmark 03:48:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3251.235959549506, 3304.636489986101, 3308.619508756494, 3329.2509185433296, 3342.715869151122, 5411.3506379234495, 5412.107002344608, 5417.6478528895595, 5418.4310647382, 5421.051316019691, 5397.649152805065, 5398.750990585082, 5430.456954304567, 5437.945620543794, 5455.890882182364, 4853.0779151961015, 4899.999999999991, 4913.803447862081, 4998.700077995332, 5033.974830125844, 4877.317175595419, 4897.853064408056, 4947.925781113268, 4948.084604348207, 5042.647014708953, 4933.851984440473, 4947.282644016615, 4958.826441074563, 4973.129702302101, 4990.900181996358, 4845.951540484585, 4850.175470170045, 4915.45929947709, 4958.727270000149, 4978.950210497903, 4904.5340692634145, 4910.508949105097, 4914.066327397783, 4931.65478416511, 4956.752162391866, 5314.707691076989, 5329.440408757064, 5354.571634269288, 5362.490563396471, 5377.892442151174, 5642.802501912454, 5698.914516282259, 5726.31284245889, 5772.3938986406665, 5777.682227477487, 5824.0, 5828.358880523139, 5857.4435428634215, 5873.618214816023, 5899.262592175978, 5447.536959358459, 5454.645448045864, 5455.8363249102595, 5456.263404440389, 5457.645253058538, 5801.216835727208, 5890.1164825276555, 5924.259467566554, 6034.336223015464, 6040.0, 5700.515456186187, 5717.371089180187, 5718.313802343662, 5722.2561067061015, 5724.656520608777, 5756.309242890796, 5803.216565763652, 5813.7383817728305, 5822.970885145547, 5835.4748072673665, 5672.489475947102, 5759.1649210865025, 5806.970965145148, 5845.1232315153065, 5846.941530584725, 5742.942570574324, 5771.394003629643, 5798.362180160179, 5801.564882633819, 5807.0998995155815, 4372.191144638252, 4449.9555004450185, 4460.531644177379, 4463.754493502888, 4497.775111244425, 3990.940135897964, 4012.117334186474, 4036.6972477064337, 4053.6757059435176, 4063.5326937401987, 5498.505134537911, 5498.560115190855, 5516.062269414209, 5524.14375771756, 5538.501534861882, 5713.0, 5726.255586773693, 5829.5336373090895, 5855.648661080349, 5858.297004359419, 5578.86052848682, 5582.385937546866, 5588.413216612278, 5610.0, 5623.156526520973, 4960.652754307164, 4972.801087956441, 4974.552290293891, 4978.6017118630425, 5010.974945125251, 5919.141724449931, 5966.970165149147, 6121.173641558333, 6121.969390153021, 6135.018397056449, 5873.911891321719, 5874.118882167709, 5881.5588830838715, 5886.411358864165, 5918.704064796829, 6046.486048685735, 6091.786787462417, 6101.542384321282, 6101.877962440815, 6126.0, 5642.040853055072, 5676.063449530781, 5721.313442386941, 5735.7418916148035, 5773.509251713652, 5826.0, 5841.1238314253205, 5865.266841644794, 5882.176495290748, 5911.467967882912, 5704.458076482728, 5708.971455142698, 5715.371309155907, 5718.571107166896, 5725.312962444534, 5574.414686458026, 5667.801626943037, 5687.71561421919, 5710.65736055838, 5747.453991870766, 5627.7467513961155, 5629.211910332639, 5634.85912852182, 5648.23748793924, 5656.264685591012, 5733.885322293614, 5740.827775166752, 5754.53963682896, 5758.654480731002, 5763.7406316715005, 5491.313585801775, 5503.972480137573, 5568.443155684399, 5637.661740295595, 5655.915161272502], "value": 5372.8808600710745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.7994261893573, 657.3262406033817, 667.1160712056525, 669.4008862068448, 685.7359916432172, 34099.31801363974, 39777.60222397775, 40882.795586022105, 41431.378529322006, 41657.58342416575, 45091.54908450915, 45548.772256138756, 45651.08697826041, 45714.542854571446, 45775.54224457755, 8187.754367368989, 9056.230220431255, 9294.0, 9295.745074414936, 10523.52644131016, 10831.0, 11005.559777608885, 11006.944965275163, 11007.394593297366, 11008.0, 11058.170637202202, 11135.33188008722, 11144.108471322275, 11151.275167114152, 11151.721206969809, 8423.873641895376, 8728.345374096905, 10719.0, 10969.341839489616, 11038.17213708967, 10500.159987201005, 10637.36175829445, 10642.0, 10666.14670826332, 10666.36001839892, 40731.7963410184, 41384.58615413837, 41417.792911035554, 41428.1714365711, 41436.79281603603, 3826.024363787244, 3896.649301562845, 3911.3546264866263, 3935.9016024599327, 3992.500937382827, 34044.48933266003, 34918.476222856676, 34929.82535087334, 35014.12464688378, 35183.82408087943, 4574.245249533823, 4580.083983203373, 4654.650901182425, 4670.182718024332, 4675.929861052087, 317721.0, 317846.0, 319753.0, 320104.0, 320575.0, 63036.684816575624, 63111.684441578414, 63580.0, 63664.0, 63672.36327636665, 66185.66907165434, 70021.0, 71452.2854771456, 71458.0, 71509.64245178741, 16961.40635077791, 17101.914490427716, 17112.315507379815, 17112.57218569546, 17125.57186070358, 11876.584319548947, 14692.926535367254, 15121.0, 15160.696786064438, 15176.317065732068, 19973.900130499256, 20187.091580878896, 20250.797492025187, 20295.391138265877, 20343.79656203419, 6986.685599148051, 7240.0, 7328.743493977685, 7355.007074045043, 7544.0, 1117.9888201117885, 1127.9548818047351, 1220.7436438348047, 1224.7060705430633, 1234.493857518431, 32773.83613081967, 34311.485327720104, 35746.64253357485, 37140.62859371426, 37410.8129459351, 1171.1333613126226, 1173.7359094203737, 1255.3409460033556, 1264.595329494553, 1275.8660340664096, 16968.23642936071, 17475.427211550767, 17539.473815785546, 17539.473815785546, 17629.0, 490882.0, 493114.0, 494058.0, 497982.0, 498167.0, 60507.0, 60829.39170608326, 61115.0, 61166.38833611696, 61284.38715612876, 1383.522684673786, 1426.5078547900957, 1466.5013895275445, 1485.3167542930157, 1520.0271826031349, 29913.9060265788, 31798.841005795748, 32909.83545082259, 33589.49615755815, 33727.0, 51021.23468148055, 51795.223071654706, 52080.09399294992, 52235.0, 52237.216441754164, 349507.0, 353013.0, 354042.0, 354101.0, 354458.0, 30274.004789210416, 30700.232494187825, 30758.384832303676, 30960.535591965687, 31050.534241985937, 49138.262926055424, 51566.22650660168, 52025.7398713004, 52255.21617175669, 53105.7344713274, 38399.80800095982, 38888.22223555457, 40124.799376002935, 40908.795456022526, 42596.57403425926, 40022.1995560093, 40212.59255926029, 41196.33766052581, 41373.0, 41996.580034199265, 42957.35563966606, 43276.78361608172, 49163.0, 49311.75344123256, 49959.75020124876, 34104.31791364209, 36189.457158143174, 36757.44863827098, 37390.439143412324, 37621.62378376181, 28563.714362856106, 29090.709092909645, 29354.0, 29376.26559336034, 29613.407731845673], "value": 21225.96350322045, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.5436664319146, 439.7845055922598, 440.77961019490255, 442.250897699598, 452.8437688997297, 18020.0, 18423.0, 19151.808481915177, 19221.615567688637, 19225.423237302904, 19298.51753706158, 19592.314269000588, 20503.282385116523, 20544.589108217864, 20564.691529627067, 5560.6941618211085, 5597.412271711452, 5815.970920145393, 5827.941720582803, 5841.240638716961, 5725.770969161229, 5727.914081288784, 5783.768649254025, 5789.536837053047, 5801.129830525434, 5582.553395728332, 5705.65766054036, 5730.0, 5743.770249190027, 5781.479666829984, 5676.035074037403, 5685.715714214272, 5693.886122277573, 5701.401352857932, 5701.71491425427, 4977.676451030671, 5148.459411761749, 5230.110881150214, 5254.08053590624, 5266.183741520071, 23767.524649507086, 23912.0, 24062.0, 24529.754702453105, 24532.264032079067, 2555.3611597100726, 2635.262126604554, 2723.986380068107, 2734.357515504465, 2823.308289469073, 14761.261936903113, 14999.925000374928, 15237.61905952349, 15566.766498502531, 15701.057936523845, 2058.5265388960474, 2101.9385210468768, 2341.555104530134, 2402.2072716003677, 2419.6491508731137, 67012.66493667549, 71700.64149679219, 79327.60336198397, 83230.0, 87233.56383218107, 18238.361657342193, 18299.451016469528, 18406.723899141525, 18607.34874279421, 18716.344927927457, 33456.330873382394, 33577.83211083978, 33927.4910876337, 34161.31677366488, 34179.316413671586, 9618.51907404627, 10158.746031349128, 10191.286609937233, 10294.279400441897, 10356.792864142675, 8596.914030859736, 8612.18184272493, 8615.22462978335, 8683.435576687496, 8694.217520423192, 9214.308926830514, 9355.859662105075, 9384.296177786693, 9547.90452095484, 9644.469554174588, 3292.654271301527, 3297.378584025705, 3495.178633021238, 3548.0242933193063, 3608.476770868262, 996.5117092624706, 1059.7774467361787, 1079.4818487126224, 1082.4966390628394, 1098.7033500954697, 18254.0, 18464.446066618024, 19055.333063342718, 19332.323368682028, 19923.402297931087, 1035.5495359518634, 1046.8959534978671, 1100.14738577603, 1108.695108845074, 1133.0878642692546, 9976.002399760111, 11142.61000864982, 11189.72025699364, 11239.775204496027, 11322.094232461382, 525478.0, 537144.0, 544302.0, 547765.0, 549269.0, 84510.57744711237, 89414.0, 89464.0, 92419.53790231005, 94295.0, 1039.8908114648004, 1061.9734506637396, 1070.9357438553711, 1078.2021304234809, 1086.842407850873, 17033.31866725317, 17171.65656686884, 17265.913670431568, 17273.0, 17367.0, 38681.99999999887, 38998.80500597479, 39524.604753952095, 40096.7995160034, 40207.0, 53112.0, 56120.0, 56788.43211567831, 56890.715546422005, 56914.430855690916, 9051.637934482547, 9268.814623707623, 9332.533373331442, 9543.713688589354, 9677.903220967983, 13540.661483462993, 13969.51106711301, 14043.08719933201, 14092.295385230493, 14272.215028173136, 6054.122152287981, 7872.0, 11886.28682279066, 12200.084993625336, 12572.371381431074, 11118.555257789598, 11668.766624667289, 11798.233114847508, 12067.0, 12259.0, 9926.858411282506, 9992.300538962494, 11979.401029948292, 12022.33877136731, 13105.737885242432, 8991.55042247898, 9082.818343632958, 9353.11145441182, 9369.953150234205, 9481.383710058824, 9137.417849908436, 12490.87509124897, 12512.624621261377, 12538.122331436713, 12761.93619031899], "value": 10280.045981683303, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.8079468874353, 1545.7835902973582, 1560.056166019558, 1721.7675613792135, 1846.870719049667, 8199.0, 8387.832243355137, 8392.91607083929, 8403.0, 8409.0, 8087.757367278977, 8185.427020108595, 8256.050554186271, 8258.545779982098, 8263.049749278834, 2467.062516243825, 2482.156066937241, 2489.2781093482868, 2500.112460076674, 2501.6247562865533, 2481.702195736514, 2552.8595927223996, 2560.359910022494, 2561.884715187821, 2566.47387285606, 2430.890609922558, 2533.7086235083016, 2552.336392537944, 2554.7317531659187, 2556.028709090543, 2444.2667199840066, 2455.8894849731714, 2460.4832985073067, 2526.5325914705836, 2533.1007492340136, 2500.1249562652924, 2528.190978886757, 2548.1845809341016, 2548.413864811085, 2549.120553409071, 8183.140770219101, 8363.456375335583, 8395.286400655952, 8445.0, 8450.87323690145, 5288.524032837063, 5321.148616221386, 5322.20166974953, 5364.544013758835, 5368.248445217672, 3565.3047655706887, 3573.5175751273505, 3579.480975258599, 3596.8381422835773, 3608.4046132388125, 1126.633844000703, 1136.6476392318407, 1142.4973011874831, 1159.8956093951585, 1179.9233049851732, 11589.6523104307, 11670.708232294175, 11709.414529273503, 11747.47136378865, 11772.587959421378, 4720.905581888412, 4804.975975120102, 4814.0743702518575, 4839.879003024882, 4909.68087074339, 9339.206167475704, 9393.953030234941, 9414.623415063457, 9435.481048542259, 9439.772829532254, 5488.9725551371985, 5494.587905907073, 5498.532624726943, 5501.724913754377, 5505.669659820343, 4387.780610969438, 4925.064237794808, 4994.775235114428, 5038.521340472649, 5126.256692779526, 3984.4820173377275, 4013.13717550728, 4050.5341885682933, 4067.9389809152885, 4082.183563287295, 1210.7820592293472, 1250.6998320403038, 1253.7367152897812, 1269.60642200918, 1283.3903895649678, 808.7925174287321, 872.5462759365095, 1017.9389236645825, 1020.3418794877263, 1038.3562191441354, 5661.575381846378, 5699.715014249354, 5768.884622307531, 5783.797567085132, 6158.969205153946, 943.778212120165, 975.8048390321964, 988.7182153086336, 1026.38416949831, 1042.5777560088177, 4102.446169767103, 4118.423420721101, 4119.0, 4125.051238215227, 4135.400366946776, 9912.107910288109, 10084.848727269096, 10238.59045638181, 10266.691999240034, 10270.127039201752, 10417.791644167226, 10445.791084178274, 10452.477376131163, 10458.477076146162, 10469.581216751398, 7840.09838868526, 8055.234752698367, 8116.107228204893, 8161.143079976517, 8240.670373185005, 5939.316978547349, 5995.46040856325, 6039.698015099139, 6076.8784624308155, 6120.143179954899, 9329.860052099088, 9358.485283309483, 9495.47774872361, 9646.710598682052, 9745.561449734638, 9121.908780912107, 9644.662436814679, 9818.214542836698, 9873.555689993824, 9908.405495670282, 6756.4257038150345, 6905.447564194752, 7282.198958114497, 7522.661480233293, 7669.846603068019, 7926.167752385916, 7934.404919630935, 7958.1643927389105, 7996.440249182501, 8010.078840933134, 7181.892271616034, 7319.34125928669, 7343.1555371133, 7442.479026468095, 7451.813704657427, 6840.452763778985, 6882.070920425678, 6996.860062798613, 7101.538400003983, 7211.3870321023305, 6620.205575330799, 6655.467562594884, 6660.833479162866, 6668.566543174678, 6680.0, 5059.291699162194, 5129.2819005340025, 5181.870453238699, 5190.532852043334, 5212.478752124909, 4956.6778159420965, 5035.345405097314, 5056.646034777677, 5128.79484820603, 5141.53726164647], "value": 4616.675339723629, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.95046168767215, 367.0914486645553, 367.92825399047194, 368.4804425759678, 376.16679055891194, 6013.27840659121, 6025.548083893709, 6114.1745864308305, 6122.051082082273, 6123.0, 5869.530437564995, 6001.2498437695285, 6001.459868611824, 6008.639481631105, 6011.849703757408, 4637.304404339351, 4691.132140554008, 4711.952880471185, 4735.337052812609, 4773.379460670108, 4724.338592597022, 4750.786214620333, 4754.575166664991, 4760.452547956995, 4766.189747742875, 4551.385562949009, 4708.364370809948, 4718.19790635591, 4722.315264286676, 4728.763561821896, 4570.405847239854, 4651.069786042788, 4663.973925736333, 4667.369905062807, 4671.439427268716, 4188.497380314351, 4188.769617671027, 4198.223328684203, 4202.327627579603, 4204.096119334327, 5859.154366374579, 5861.150133230701, 5862.38444963277, 5870.354261031283, 5884.705764711747, 5485.835424937259, 5486.753096110685, 5494.642848214853, 5496.065668836308, 5496.80761173357, 6315.052742088677, 6431.517636177258, 6437.645929473877, 6450.290468048511, 6451.967740161316, 4647.442306923157, 4663.253879379317, 4663.533646635343, 4665.066986602659, 4668.696534725266, 6676.93323066768, 6689.464842812612, 6709.966450167767, 6729.831754206135, 6756.763513277061, 4765.213739732905, 4771.06964141989, 4771.73755443454, 4777.235642297285, 4777.784999674954, 4838.419389673191, 4842.055799119138, 4846.36997190363, 4848.539388758062, 4848.927266091011, 5475.206095116186, 5482.068048431776, 5490.258815059916, 5491.615586908958, 5498.477644623755, 6341.492680585542, 6439.54923155384, 6467.51493637979, 6472.708728107246, 6483.610983341015, 1670.4571014420362, 1699.3202718912287, 1700.4558541266676, 1706.2492503298508, 1710.1962077823403, 1070.5985255529176, 1129.203911242572, 1142.9771404571861, 1149.7010777197822, 1160.3907948327196, 6210.968945155245, 6277.8744425111245, 6280.685965701697, 6283.08895210192, 6291.0, 6634.13756211699, 6642.335766423319, 6642.966785166043, 6643.269240383554, 6653.334666533405, 6273.937260627426, 6278.372162783777, 6280.685965701697, 6282.246130464374, 6288.496920246369, 3547.7161827053774, 3565.8038807865814, 3576.0523461282783, 3577.6601222883783, 3582.46263060543, 6785.5151554026625, 6851.931480685229, 6906.792796216121, 6925.3074692530345, 6935.167779866348, 6693.899591506131, 6720.4287635550545, 6724.29394913527, 6736.730530778812, 6741.595504269661, 6897.862042759117, 6899.448044156456, 6905.482088843256, 6911.03245545624, 6921.204061532988, 6575.046618240424, 6591.571547849375, 6593.967030164818, 6604.801855944329, 6614.206295244601, 6395.488360931207, 6494.350564943468, 6495.707693153725, 6639.103720997797, 6641.402273795382, 6994.055802466602, 7031.683574239274, 7039.648017598997, 7047.154341479055, 7048.506604537838, 4607.170709272363, 4640.0, 4650.488446270975, 4652.790624421977, 4655.022445286528, 6619.040239165198, 6669.53313268086, 6669.966650166718, 6677.899831502628, 6678.799636010927, 6358.268799088164, 6491.772787952399, 6493.512986526124, 6498.090267362479, 6513.837154071186, 6420.518461115342, 6453.354664533509, 6461.160049193575, 6468.6442245676935, 6471.385218404244, 6351.841203969938, 6352.237731472068, 6352.618842869442, 6352.872942541216, 6356.650384228912, 6505.349465053457, 6507.577007494498, 6512.446442052478, 6516.869662606816, 6519.152510173647, 6042.244719410074, 6111.388861113853, 6266.592671476339, 6353.36466353361, 6363.0], "value": 4924.280155779698, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.6287077991852, 885.2608072259662, 892.2193081054073, 909.095450027223, 923.2873020546883, 13448.731025379486, 13558.525451609195, 13564.0, 13577.0, 13644.863551364495, 13157.276349800757, 13266.93366533166, 13291.468341266338, 13298.202107873534, 13310.933445332785, 766.9961650191769, 893.3567831161586, 907.8048219632777, 919.4345477531336, 923.7182659288948, 901.0403919825397, 909.2680392284209, 909.5588639509865, 909.6497848328409, 909.9363044586881, 947.8151760406723, 950.771814764455, 953.408886490377, 953.9713808585753, 955.6702937486556, 801.9198080192022, 929.4005366538612, 944.6929747831948, 945.1493655709882, 951.8143961927427, 700.6496751624188, 701.7263267325746, 701.9964900175518, 702.034702284359, 702.199492578461, 12840.61478155657, 13213.867861321456, 13248.536301229507, 13281.933590332083, 13285.601431957057, 13464.326783660777, 13939.16365018102, 14090.506832260822, 14099.577012689635, 14186.43254269828, 12081.791820817936, 12241.143119981605, 12372.07209459294, 12425.130240883142, 12491.188072775241, 4039.97980010101, 4043.433919251307, 4048.3725022621543, 4054.2499637567144, 4094.754314741125, 56499.0, 59761.40238597602, 59821.401785982016, 59981.10028349578, 60062.39937600612, 11204.15968802343, 11437.485313160927, 11564.248323858923, 11623.0, 11709.355985420883, 20391.592168156552, 20509.17963281452, 20584.485387865425, 21127.683084753742, 21142.57714845725, 8478.8502172787, 8555.61499732501, 8619.051904290523, 8698.695545655872, 8726.0, 4903.754812259444, 4949.880597163122, 4972.801087956514, 5045.646804723708, 5048.848534543969, 3574.767640103385, 3631.6731494165124, 3636.56361236648, 3637.6907962823457, 3637.909052273714, 652.4617190817595, 663.4824836627438, 677.8237658208901, 692.5809885019592, 693.7051753005054, 782.7025730222479, 783.5494590610422, 787.7676085554775, 790.4387884601997, 800.1758189065272, 9384.5307734613, 9471.857922131174, 9501.667441639509, 9903.306768526134, 10094.798104037878, 736.5654263984275, 747.6859718918067, 754.4718696912183, 769.1846642558905, 794.4002278279862, 4540.160070386989, 4556.681032327705, 4557.339185818038, 4634.95365046352, 4636.049609829976, 61013.38986610166, 61397.38602614006, 61676.0, 61832.69083654553, 61992.69003655043, 55036.72481637566, 55475.16787248194, 55587.166192507146, 55924.16113758297, 56288.5927851807, 48171.0, 50093.74953125284, 50336.49663503392, 50669.239961400606, 50727.0, 9260.351775375659, 9322.0, 9394.389364691273, 9416.95291523538, 9549.331546791936, 35458.822705886305, 35744.28511429705, 37660.0, 40005.19989600134, 40036.399454008795, 44593.55406446024, 47910.28134578054, 48063.0, 48326.27510587274, 48994.26508602303, 11988.520459181535, 12120.696982575153, 12303.815442768187, 12548.24710517372, 12552.686182845136, 13901.860981390057, 13967.092139010932, 14331.498397556035, 14418.279086045446, 14589.635259118182, 12605.180663256859, 13071.346432678518, 13173.736525269633, 13488.0, 13677.931610341884, 12912.548060817826, 12934.0, 12941.935290323489, 12975.935120324339, 13017.349132543146, 12688.429020693906, 13291.933540332237, 13664.65838354049, 13802.654933626338, 13907.165570065828, 10965.725856853642, 11370.715732106764, 11467.827982580102, 11470.82793758111, 11682.532698691957, 10926.50830712604, 11100.167487438635, 11712.180147389941, 11873.465694043962, 11951.282923024646], "value": 7100.728337208624, "unit": "score"}], "name": "dromaeo_css", "value": 7577.302432003619, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 109.0, 110.0, 110.0, 105.0, 108.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 158.0, 192.0, 127.0, 159.0, 150.0, 127.0, 184.0, 134.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 162.0, 162.0, 162.0, 161.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 177.0, 76.0, 75.0, 76.0, 77.0, 161.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 150.0, 91.0, 91.0, 90.0, 155.0, 93.0, 93.0, 152.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 147.0, 146.0, 147.0, 145.0, 145.0, 144.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 97.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 55.0, 58.0, 55.0, 57.0, 77.0, 55.0, 54.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 57.0, 58.0, 57.0, 57.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 75.0, 72.0, 73.0, 74.0, 73.0, 74.0, 74.0, 75.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 127.0, 113.0, 117.0, 117.0, 113.0, 111.0, 163.0, 134.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 158.0, 166.0, 158.0, 157.0, 160.0, 160.0, 158.0, 156.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 66.0, 66.0, 65.0, 64.0, 66.0, 65.0, 67.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1521.5, "alertThreshold": 2.0}]} 03:48:46 INFO - Return code: 0 03:48:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:48:46 ERROR - # TBPL SUCCESS # 03:48:46 INFO - Running post-action listener: _resource_record_post_action 03:48:46 INFO - Running post-run listener: _resource_record_post_run 03:48:47 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 506318848; Read time: 24; Write time: 422332 03:48:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 256487424; Read time: 0; Write time: 247904 03:48:47 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 249831424; Read time: 24; Write time: 174428 03:48:47 INFO - Running post-run listener: _upload_blobber_files 03:48:47 INFO - Blob upload gear active. 03:48:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:48:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:48:48 INFO - (blobuploader) - INFO - Open directory for files ... 03:48:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:48:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:48:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:49 INFO - (blobuploader) - INFO - Done attempting. 03:48:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:48:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:48:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:50 INFO - (blobuploader) - INFO - Done attempting. 03:48:50 INFO - (blobuploader) - INFO - Iteration through files over. 03:48:50 INFO - Return code: 0 03:48:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:48:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:48:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09b0cf0368e77b96dfa1812e07628397ff4d5ea658b577062bbefae4a02eb4be88d71c4c4a1d3333f213121d53b043ce58897c43e11f5754be5c93746c7a34d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1887186be5290a9ba59647204da5c82778a13c65ce2e136de578eae627a9a095020ad5015b37271f4653985ce658bcf5603eaa50cfa2e94ed66e5d7843cf6de"} 03:48:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:48:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:48:50 INFO - Contents: 03:48:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09b0cf0368e77b96dfa1812e07628397ff4d5ea658b577062bbefae4a02eb4be88d71c4c4a1d3333f213121d53b043ce58897c43e11f5754be5c93746c7a34d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1887186be5290a9ba59647204da5c82778a13c65ce2e136de578eae627a9a095020ad5015b37271f4653985ce658bcf5603eaa50cfa2e94ed66e5d7843cf6de"} 03:48:50 INFO - Running post-run listener: copy_logs_to_upload_dir 03:48:50 INFO - Copying logs to upload dir... 03:48:50 INFO - mkdir: /builds/slave/test/build/upload/logs 03:48:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.354558 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-29 03:48:48.875359) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 03:48:48.883042) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004 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/09b0cf0368e77b96dfa1812e07628397ff4d5ea658b577062bbefae4a02eb4be88d71c4c4a1d3333f213121d53b043ce58897c43e11f5754be5c93746c7a34d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1887186be5290a9ba59647204da5c82778a13c65ce2e136de578eae627a9a095020ad5015b37271f4653985ce658bcf5603eaa50cfa2e94ed66e5d7843cf6de"} build_url:https://queue.taskcluster.net/v1/task/D4xaBIgaT1S4XszjtEYzSQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/D4xaBIgaT1S4XszjtEYzSQ/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/09b0cf0368e77b96dfa1812e07628397ff4d5ea658b577062bbefae4a02eb4be88d71c4c4a1d3333f213121d53b043ce58897c43e11f5754be5c93746c7a34d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1887186be5290a9ba59647204da5c82778a13c65ce2e136de578eae627a9a095020ad5015b37271f4653985ce658bcf5603eaa50cfa2e94ed66e5d7843cf6de"}' ========= master_lag: 0.29 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 03:48:49.186891) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 03:48:49.187217) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1464513770.125719-1752054004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 03:48:49.275614) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 03:48:49.275980) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 03:48:49.276327) ========= ========= Total master_lag: 0.47 =========