builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1461368953.4 results: success (0) buildid: 20160422141954 builduid: a8fa92f486c841e2a62a6cc39bf9290a revision: c0be14550a2b77f8f8b4aab158fc3525ffc82828 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:13.400960) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:13.401388) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:13.401670) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:13.422862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 16:49:13.423195) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 16:49:13-- 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% 37.5M=0s 2016-04-22 16:49:14 (37.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=1.127868 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 16:49:14.565431) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:14.565780) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016845 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:14.615151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:14.615458) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c0be14550a2b77f8f8b4aab158fc3525ffc82828 --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 c0be14550a2b77f8f8b4aab158fc3525ffc82828 --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=b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 16:49:14,990 truncating revision to first 12 chars 2016-04-22 16:49:14,990 Setting DEBUG logging. 2016-04-22 16:49:14,990 attempt 1/10 2016-04-22 16:49:14,990 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c0be14550a2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 16:49:15,249 unpacking tar archive at: mozilla-aurora-c0be14550a2b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545447 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:15.173488) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:15.173775) ========= script_repo_revision: c0be14550a2b77f8f8b4aab158fc3525ffc82828 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:15.174142) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:15.174413) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 16:49:15.219692) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-22 16:49:15.219992) ========= /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=b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:49:15 INFO - MultiFileLogger online at 20160422 16:49:15 in /builds/slave/test 16:49:15 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 16:49:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:49:15 INFO - {'append_to_log': False, 16:49:15 INFO - 'base_work_dir': '/builds/slave/test', 16:49:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:49:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:49:15 INFO - 'branch': 'Mozilla-Aurora', 16:49:15 INFO - 'buildbot_json_path': 'buildprops.json', 16:49:15 INFO - 'config_files': ('talos/linux_config.py',), 16:49:15 INFO - 'default_actions': ('clobber', 16:49:15 INFO - 'read-buildbot-config', 16:49:15 INFO - 'download-and-extract', 16:49:15 INFO - 'populate-webroot', 16:49:15 INFO - 'create-virtualenv', 16:49:15 INFO - 'install', 16:49:15 INFO - 'run-tests'), 16:49:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:49:15 INFO - 'download_minidump_stackwalk': True, 16:49:15 INFO - 'download_symbols': 'ondemand', 16:49:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:49:15 INFO - 'tooltool.py': '/tools/tooltool.py', 16:49:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:49:15 INFO - '/tools/misc-python/virtualenv.py')}, 16:49:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:49:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:49:15 INFO - 'installer_path': 'installer.exe', 16:49:15 INFO - 'log_level': 'info', 16:49:15 INFO - 'log_name': 'talos', 16:49:15 INFO - 'log_to_console': True, 16:49:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:49:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:49:15 INFO - 'opt_config_files': (), 16:49:15 INFO - 'pip_index': False, 16:49:15 INFO - 'sps_profile': False, 16:49:15 INFO - 'sps_profile_interval': 0, 16:49:15 INFO - 'suite': 'dromaeojs', 16:49:15 INFO - 'system_bits': '32', 16:49:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:49:15 INFO - 'title': 'talos-linux64-ix-007', 16:49:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:49:15 INFO - 'use_talos_json': True, 16:49:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:49:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:49:15 INFO - 'work_dir': 'build'} 16:49:15 INFO - ##### 16:49:15 INFO - ##### Running clobber step. 16:49:15 INFO - ##### 16:49:15 INFO - Running pre-action listener: _resource_record_pre_action 16:49:15 INFO - Running main action method: clobber 16:49:15 INFO - rmtree: /builds/slave/test/build 16:49:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:49:16 INFO - Running post-action listener: _resource_record_post_action 16:49:16 INFO - ##### 16:49:16 INFO - ##### Running read-buildbot-config step. 16:49:16 INFO - ##### 16:49:16 INFO - Running pre-action listener: _resource_record_pre_action 16:49:16 INFO - Running main action method: read_buildbot_config 16:49:16 INFO - Using buildbot properties: 16:49:16 INFO - { 16:49:16 INFO - "project": "", 16:49:16 INFO - "product": "firefox", 16:49:16 INFO - "script_repo_revision": "production", 16:49:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:49:16 INFO - "repository": "", 16:49:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:49:16 INFO - "buildid": "20160422141954", 16:49:16 INFO - "pgo_build": "True", 16:49:16 INFO - "basedir": "/builds/slave/test", 16:49:16 INFO - "buildnumber": 456, 16:49:16 INFO - "slavename": "talos-linux64-ix-007", 16:49:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:49:16 INFO - "platform": "ubuntu64_hw", 16:49:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:49:16 INFO - "branch": "mozilla-aurora", 16:49:16 INFO - "repo_path": "releases/mozilla-aurora", 16:49:16 INFO - "revision": "c0be14550a2b77f8f8b4aab158fc3525ffc82828", 16:49:16 INFO - "stage_platform": "linux64-pgo", 16:49:16 INFO - "builduid": "a8fa92f486c841e2a62a6cc39bf9290a", 16:49:16 INFO - "slavebuilddir": "test" 16:49:16 INFO - } 16:49:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 16:49:16 INFO - Running post-action listener: _resource_record_post_action 16:49:16 INFO - ##### 16:49:16 INFO - ##### Running download-and-extract step. 16:49:16 INFO - ##### 16:49:16 INFO - Running pre-action listener: _resource_record_pre_action 16:49:16 INFO - Running main action method: download_and_extract 16:49:16 INFO - mkdir: /builds/slave/test/build/tests 16:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:16 INFO - https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:49:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:49:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:49:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:49:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:49:18 INFO - Downloaded 1448 bytes. 16:49:18 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:49:18 INFO - Using the following test package requirements: 16:49:18 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:49:18 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:49:18 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:49:18 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:18 INFO - u'jsshell-linux-x86_64.zip'], 16:49:18 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:49:18 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:49:18 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:49:18 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:49:18 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:49:18 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:49:18 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:49:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:49:18 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:49:18 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')]} 16:49:18 INFO - https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:49:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:49:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:49:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:49:19 INFO - Downloaded 23358968 bytes. 16:49:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:49:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:49:20 INFO - Return code: 0 16:49:20 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:49:20 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')]} 16:49:20 INFO - https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:49:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:49:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:49:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:49:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:49:23 INFO - Downloaded 23358968 bytes. 16:49:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:49:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:49:24 INFO - Return code: 0 16:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:24 INFO - https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:49:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:49:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:49:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:49:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:49:25 INFO - Downloaded 10845198 bytes. 16:49:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:49:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:49:26 INFO - Return code: 0 16:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:26 INFO - https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:49:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:49:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:49:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:49:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:49:27 INFO - Downloaded 60837874 bytes. 16:49:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:49:27 INFO - mkdir: /builds/slave/test/properties 16:49:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:49:27 INFO - Writing to file /builds/slave/test/properties/build_url 16:49:27 INFO - Contents: 16:49:27 INFO - build_url:https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:49:28 INFO - Running post-action listener: _resource_record_post_action 16:49:28 INFO - Running post-action listener: set_extra_try_arguments 16:49:28 INFO - ##### 16:49:28 INFO - ##### Running populate-webroot step. 16:49:28 INFO - ##### 16:49:28 INFO - Running pre-action listener: _resource_record_pre_action 16:49:28 INFO - Running main action method: populate_webroot 16:49:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:49:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:49:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:49:28 INFO - '--tppagecycles', 16:49:28 INFO - '7'], 16:49:28 INFO - 'tests': ['tsvgm']}}, 16:49:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:49:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:49:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:49:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:49:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:49:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:49:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:49:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:28 INFO - 'talos_options': ['--e10s'], 16:49:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:49:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:28 INFO - 'tests': ['damp', 'tps']}, 16:49:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:28 INFO - 'talos_options': ['--e10s'], 16:49:28 INFO - 'tests': ['damp', 'tps']}, 16:49:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:49:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:49:28 INFO - 'other': {'tests': ['a11yr', 16:49:28 INFO - 'ts_paint', 16:49:28 INFO - 'tpaint', 16:49:28 INFO - 'sessionrestore', 16:49:28 INFO - 'sessionrestore_no_auto_restore', 16:49:28 INFO - 'tabpaint']}, 16:49:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:49:28 INFO - 'tests': ['a11yr', 16:49:28 INFO - 'ts_paint', 16:49:28 INFO - 'tpaint', 16:49:28 INFO - 'sessionrestore', 16:49:28 INFO - 'sessionrestore_no_auto_restore', 16:49:28 INFO - 'tabpaint']}, 16:49:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:49:28 INFO - 'tests': ['a11yr', 16:49:28 INFO - 'ts_paint', 16:49:28 INFO - 'tpaint', 16:49:28 INFO - 'sessionrestore', 16:49:28 INFO - 'sessionrestore_no_auto_restore', 16:49:28 INFO - 'tabpaint']}, 16:49:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:49:28 INFO - 'tests': ['a11yr', 16:49:28 INFO - 'ts_paint', 16:49:28 INFO - 'tpaint', 16:49:28 INFO - 'sessionrestore', 16:49:28 INFO - 'sessionrestore_no_auto_restore', 16:49:28 INFO - 'tabpaint']}, 16:49:28 INFO - 'other_l64': {'tests': ['a11yr', 16:49:28 INFO - 'ts_paint', 16:49:28 INFO - 'tpaint', 16:49:28 INFO - 'sessionrestore', 16:49:28 INFO - 'sessionrestore_no_auto_restore', 16:49:28 INFO - 'tabpaint']}, 16:49:28 INFO - 'other_nol64': {'tests': ['a11yr', 16:49:28 INFO - 'ts_paint', 16:49:28 INFO - 'tpaint', 16:49:28 INFO - 'sessionrestore', 16:49:28 INFO - 'sessionrestore_no_auto_restore', 16:49:28 INFO - 'tabpaint']}, 16:49:28 INFO - 'svgr': {'tests': ['tsvgx', 16:49:28 INFO - 'tsvgr_opacity', 16:49:28 INFO - 'tart', 16:49:28 INFO - 'tscrollx', 16:49:28 INFO - 'cart']}, 16:49:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:49:28 INFO - 'tests': ['tsvgx', 16:49:28 INFO - 'tsvgr_opacity', 16:49:28 INFO - 'tart', 16:49:28 INFO - 'tscrollx', 16:49:28 INFO - 'cart']}, 16:49:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:28 INFO - 'tests': ['tp5o']}, 16:49:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:28 INFO - 'talos_options': ['--e10s'], 16:49:28 INFO - 'tests': ['tp5o']}, 16:49:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:28 INFO - 'talos_options': ['--xperf_path', 16:49:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:49:28 INFO - 'tests': ['tp5n']}, 16:49:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:28 INFO - 'talos_options': ['--e10s', 16:49:28 INFO - '--xperf_path', 16:49:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:49:28 INFO - 'tests': ['tp5n']}}, 16:49:28 INFO - 'talos.zip': {'path': '', 16:49:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:49:28 INFO - Running post-action listener: _resource_record_post_action 16:49:28 INFO - ##### 16:49:28 INFO - ##### Running create-virtualenv step. 16:49:28 INFO - ##### 16:49:28 INFO - Running pre-action listener: _resource_record_pre_action 16:49:28 INFO - Running main action method: create_virtualenv 16:49:28 INFO - Creating virtualenv /builds/slave/test/build/venv 16:49:28 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 16:49:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:49:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:49:28 INFO - Using real prefix '/usr' 16:49:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:49:28 INFO - Installing distribute.............................................................................................................................................................................................done. 16:49:30 INFO - Installing pip.................done. 16:49:30 INFO - Return code: 0 16:49:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:49: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')]} 16:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49: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')]} 16:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:30 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 0x7f748a47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd50410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddf160>, '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 0xde0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde04f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', '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 16:49:30 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 16:49:30 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 16:49:30 INFO - Using env: {'DISPLAY': ':0', 16:49:30 INFO - 'HOME': '/home/cltbld', 16:49:30 INFO - 'LANG': 'en_US.UTF-8', 16:49:30 INFO - 'LANGUAGE': 'en_US:en', 16:49:30 INFO - 'LOGNAME': 'cltbld', 16:49:30 INFO - 'MAIL': '/var/mail/cltbld', 16:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:30 INFO - 'MOZ_NO_REMOTE': '1', 16:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:30 INFO - 'NO_EM_RESTART': '1', 16:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:30 INFO - 'PWD': '/builds/slave/test', 16:49:30 INFO - 'SHELL': '/bin/bash', 16:49:30 INFO - 'SHLVL': '1', 16:49:30 INFO - 'TERM': 'linux', 16:49:30 INFO - 'TMOUT': '86400', 16:49:30 INFO - 'USER': 'cltbld', 16:49:30 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', 16:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:30 INFO - '_': '/tools/buildbot/bin/python'} 16:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:31 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 16:49:31 INFO - Cleaning up... 16:49:31 INFO - Return code: 0 16:49:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f748a47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd50410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddf160>, '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 0xde0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde04f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', '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 16:49:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:49:31 INFO - Using env: {'DISPLAY': ':0', 16:49:31 INFO - 'HOME': '/home/cltbld', 16:49:31 INFO - 'LANG': 'en_US.UTF-8', 16:49:31 INFO - 'LANGUAGE': 'en_US:en', 16:49:31 INFO - 'LOGNAME': 'cltbld', 16:49:31 INFO - 'MAIL': '/var/mail/cltbld', 16:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:31 INFO - 'MOZ_NO_REMOTE': '1', 16:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:31 INFO - 'NO_EM_RESTART': '1', 16:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:31 INFO - 'PWD': '/builds/slave/test', 16:49:31 INFO - 'SHELL': '/bin/bash', 16:49:31 INFO - 'SHLVL': '1', 16:49:31 INFO - 'TERM': 'linux', 16:49:31 INFO - 'TMOUT': '86400', 16:49:31 INFO - 'USER': 'cltbld', 16:49:31 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', 16:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:31 INFO - '_': '/tools/buildbot/bin/python'} 16:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:31 INFO - Downloading/unpacking psutil>=0.7.1 16:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:49:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:33 INFO - Installing collected packages: psutil 16:49:33 INFO - Running setup.py install for psutil 16:49:33 INFO - building 'psutil._psutil_linux' extension 16:49:33 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 16:49:33 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 16:49:33 INFO - building 'psutil._psutil_posix' extension 16:49:33 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 16:49:33 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 16:49:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:33 INFO - Successfully installed psutil 16:49:33 INFO - Cleaning up... 16:49:33 INFO - Return code: 0 16:49:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:33 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 0x7f748a47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd50410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddf160>, '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 0xde0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde04f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', '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 16:49:33 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 16:49:33 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 16:49:33 INFO - Using env: {'DISPLAY': ':0', 16:49:33 INFO - 'HOME': '/home/cltbld', 16:49:33 INFO - 'LANG': 'en_US.UTF-8', 16:49:33 INFO - 'LANGUAGE': 'en_US:en', 16:49:33 INFO - 'LOGNAME': 'cltbld', 16:49:33 INFO - 'MAIL': '/var/mail/cltbld', 16:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:33 INFO - 'MOZ_NO_REMOTE': '1', 16:49:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:33 INFO - 'NO_EM_RESTART': '1', 16:49:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:33 INFO - 'PWD': '/builds/slave/test', 16:49:33 INFO - 'SHELL': '/bin/bash', 16:49:33 INFO - 'SHLVL': '1', 16:49:33 INFO - 'TERM': 'linux', 16:49:33 INFO - 'TMOUT': '86400', 16:49:33 INFO - 'USER': 'cltbld', 16:49:33 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', 16:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:33 INFO - '_': '/tools/buildbot/bin/python'} 16:49:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:49:35 INFO - Installing collected packages: mozsystemmonitor 16:49:35 INFO - Running setup.py install for mozsystemmonitor 16:49:35 INFO - Successfully installed mozsystemmonitor 16:49:35 INFO - Cleaning up... 16:49:36 INFO - Return code: 0 16:49:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:49: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')]} 16:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49: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')]} 16:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49: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', '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 0x7f748a47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd50410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddf160>, '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 0xde0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde04f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', '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 16:49: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:49: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 blobuploader==1.2.4 16:49:36 INFO - Using env: {'DISPLAY': ':0', 16:49:36 INFO - 'HOME': '/home/cltbld', 16:49:36 INFO - 'LANG': 'en_US.UTF-8', 16:49:36 INFO - 'LANGUAGE': 'en_US:en', 16:49:36 INFO - 'LOGNAME': 'cltbld', 16:49:36 INFO - 'MAIL': '/var/mail/cltbld', 16:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:36 INFO - 'MOZ_NO_REMOTE': '1', 16:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:36 INFO - 'NO_EM_RESTART': '1', 16:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:36 INFO - 'PWD': '/builds/slave/test', 16:49:36 INFO - 'SHELL': '/bin/bash', 16:49:36 INFO - 'SHLVL': '1', 16:49:36 INFO - 'TERM': 'linux', 16:49:36 INFO - 'TMOUT': '86400', 16:49:36 INFO - 'USER': 'cltbld', 16:49:36 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', 16:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:36 INFO - '_': '/tools/buildbot/bin/python'} 16:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:36 INFO - Downloading/unpacking blobuploader==1.2.4 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49:38 INFO - Downloading blobuploader-1.2.4.tar.gz 16:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:49:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:49:38 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 16:49:38 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 16:49:38 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 16:49:38 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 16:49:38 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 16:49:38 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 16:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:49:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:49:38 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 16:49:38 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 16:49:38 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 16:49:38 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 16:49:38 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 16:49:38 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 16:49:38 INFO - Downloading docopt-0.6.1.tar.gz 16:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:49:39 INFO - Installing collected packages: blobuploader, requests, docopt 16:49:39 INFO - Running setup.py install for blobuploader 16:49:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:49:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:49:39 INFO - Running setup.py install for requests 16:49:39 INFO - Running setup.py install for docopt 16:49:39 INFO - Successfully installed blobuploader requests docopt 16:49:39 INFO - Cleaning up... 16:49:39 INFO - Return code: 0 16:49:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49: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')]} 16:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49: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')]} 16:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:39 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 0x7f748a47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd50410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddf160>, '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 0xde0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde04f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', '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 16:49:39 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 16:49:39 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 16:49:39 INFO - Using env: {'DISPLAY': ':0', 16:49:39 INFO - 'HOME': '/home/cltbld', 16:49:39 INFO - 'LANG': 'en_US.UTF-8', 16:49:39 INFO - 'LANGUAGE': 'en_US:en', 16:49:39 INFO - 'LOGNAME': 'cltbld', 16:49:39 INFO - 'MAIL': '/var/mail/cltbld', 16:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:39 INFO - 'MOZ_NO_REMOTE': '1', 16:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:39 INFO - 'NO_EM_RESTART': '1', 16:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:39 INFO - 'PWD': '/builds/slave/test', 16:49:39 INFO - 'SHELL': '/bin/bash', 16:49:39 INFO - 'SHLVL': '1', 16:49:39 INFO - 'TERM': 'linux', 16:49:39 INFO - 'TMOUT': '86400', 16:49:39 INFO - 'USER': 'cltbld', 16:49:39 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', 16:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:39 INFO - '_': '/tools/buildbot/bin/python'} 16:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:49:39 INFO - Running setup.py (path:/tmp/pip-BirDqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:49:39 INFO - Running setup.py (path:/tmp/pip-qGhlYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:49:40 INFO - Running setup.py (path:/tmp/pip-YVAPs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:49:40 INFO - Running setup.py (path:/tmp/pip-AXG757-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:49:40 INFO - Running setup.py (path:/tmp/pip-3Cs4Wh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:49:40 INFO - Running setup.py (path:/tmp/pip-mOKlbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:49:40 INFO - Running setup.py (path:/tmp/pip-9jFMS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:49:40 INFO - Running setup.py (path:/tmp/pip-hXCcq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:49:40 INFO - Running setup.py (path:/tmp/pip-uuhUF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:49:40 INFO - Running setup.py (path:/tmp/pip-Wzm3Rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:49:40 INFO - Running setup.py (path:/tmp/pip-jrMsPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:49:40 INFO - Running setup.py (path:/tmp/pip-YL8rWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:49:40 INFO - Running setup.py (path:/tmp/pip-YWH51m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:49:40 INFO - Running setup.py (path:/tmp/pip-PalJ7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:40 INFO - Running setup.py (path:/tmp/pip-Ke9VXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:49:40 INFO - Running setup.py (path:/tmp/pip-fM7cTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:49:41 INFO - Running setup.py (path:/tmp/pip-JgY3WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:49:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:49:41 INFO - Running setup.py install for manifestparser 16:49:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:49:41 INFO - Running setup.py install for mozcrash 16:49:41 INFO - Running setup.py install for mozdebug 16:49:41 INFO - Running setup.py install for mozdevice 16:49:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:49:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:49:41 INFO - Running setup.py install for mozfile 16:49:41 INFO - Running setup.py install for mozhttpd 16:49:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:49:41 INFO - Running setup.py install for mozinfo 16:49:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:49:41 INFO - Running setup.py install for mozInstall 16:49:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:49:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:49:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:49:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:49:41 INFO - Running setup.py install for mozleak 16:49:41 INFO - Running setup.py install for mozlog 16:49:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:49:42 INFO - Running setup.py install for moznetwork 16:49:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:49:42 INFO - Running setup.py install for mozprocess 16:49:42 INFO - Running setup.py install for mozprofile 16:49:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:49:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:49:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:49:42 INFO - Running setup.py install for mozrunner 16:49:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:49:42 INFO - Running setup.py install for mozscreenshot 16:49:42 INFO - Running setup.py install for moztest 16:49:42 INFO - Running setup.py install for mozversion 16:49:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:49:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:49:42 INFO - Cleaning up... 16:49:42 INFO - Return code: 0 16:49:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:42 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 0x7f748a47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd50410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddf160>, '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 0xde0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde04f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', '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 16:49:42 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 16:49:42 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 16:49:42 INFO - Using env: {'DISPLAY': ':0', 16:49:42 INFO - 'HOME': '/home/cltbld', 16:49:42 INFO - 'LANG': 'en_US.UTF-8', 16:49:42 INFO - 'LANGUAGE': 'en_US:en', 16:49:42 INFO - 'LOGNAME': 'cltbld', 16:49:42 INFO - 'MAIL': '/var/mail/cltbld', 16:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:42 INFO - 'MOZ_NO_REMOTE': '1', 16:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:42 INFO - 'NO_EM_RESTART': '1', 16:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:42 INFO - 'PWD': '/builds/slave/test', 16:49:42 INFO - 'SHELL': '/bin/bash', 16:49:42 INFO - 'SHLVL': '1', 16:49:42 INFO - 'TERM': 'linux', 16:49:42 INFO - 'TMOUT': '86400', 16:49:42 INFO - 'USER': 'cltbld', 16:49:42 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', 16:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:42 INFO - '_': '/tools/buildbot/bin/python'} 16:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:49:43 INFO - Running setup.py (path:/tmp/pip-DwM4JM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:49:43 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)) 16:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:49:43 INFO - Running setup.py (path:/tmp/pip-pJuCET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:49:43 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)) 16:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:49:43 INFO - Running setup.py (path:/tmp/pip-2gnRwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:49:43 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)) 16:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:49:43 INFO - Running setup.py (path:/tmp/pip-TTTpfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:49:43 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)) 16:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:49:43 INFO - Running setup.py (path:/tmp/pip-azRo3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:49:43 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)) 16:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:49:43 INFO - Running setup.py (path:/tmp/pip-Qy9gkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:49:43 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)) 16:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:49:43 INFO - Running setup.py (path:/tmp/pip-DjWUNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:49:43 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)) 16:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:49:43 INFO - Running setup.py (path:/tmp/pip-psLCNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:49:43 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)) 16:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:49:43 INFO - Running setup.py (path:/tmp/pip-A2LkPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:49:43 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)) 16:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:49:43 INFO - Running setup.py (path:/tmp/pip-iAEKVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:49:43 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)) 16:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:49:43 INFO - Running setup.py (path:/tmp/pip-cSZv3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:49:43 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)) 16:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:49:43 INFO - Running setup.py (path:/tmp/pip-D0CPAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:49:43 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)) 16:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:49:43 INFO - Running setup.py (path:/tmp/pip-Qsr0Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:49:44 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)) 16:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:49:44 INFO - Running setup.py (path:/tmp/pip-Y8uZDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:49:44 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)) 16:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:44 INFO - Running setup.py (path:/tmp/pip-64IJgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:44 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)) 16:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:49:44 INFO - Running setup.py (path:/tmp/pip-HdgcTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:49:44 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)) 16:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:49:44 INFO - Running setup.py (path:/tmp/pip-RutsQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:49:44 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)) 16:49:44 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)) 16:49:44 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)) 16:49:44 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)) 16:49:44 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)) 16:49:44 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)) 16:49:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:49:44 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 16:49:44 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 16:49:44 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 16:49:44 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 16:49:44 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 16:49:44 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 16:49:46 INFO - Downloading blessings-1.6.tar.gz 16:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:49:46 INFO - Installing collected packages: blessings 16:49:46 INFO - Running setup.py install for blessings 16:49:46 INFO - Successfully installed blessings 16:49:46 INFO - Cleaning up... 16:49:46 INFO - Return code: 0 16:49:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:49:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:49:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:49:46 INFO - Reading from file tmpfile_stdout 16:49:46 INFO - Current package versions: 16:49:46 INFO - argparse == 1.2.1 16:49:46 INFO - blessings == 1.6 16:49:46 INFO - blobuploader == 1.2.4 16:49:46 INFO - docopt == 0.6.1 16:49:46 INFO - manifestparser == 1.1 16:49:46 INFO - mozInstall == 1.12 16:49:46 INFO - mozcrash == 0.17 16:49:46 INFO - mozdebug == 0.1 16:49:46 INFO - mozdevice == 0.48 16:49:46 INFO - mozfile == 1.2 16:49:46 INFO - mozhttpd == 0.7 16:49:46 INFO - mozinfo == 0.9 16:49:46 INFO - mozleak == 0.1 16:49:46 INFO - mozlog == 3.1 16:49:46 INFO - moznetwork == 0.27 16:49:46 INFO - mozprocess == 0.22 16:49:46 INFO - mozprofile == 0.28 16:49:46 INFO - mozrunner == 6.11 16:49:46 INFO - mozscreenshot == 0.1 16:49:46 INFO - mozsystemmonitor == 0.0 16:49:46 INFO - moztest == 0.7 16:49:46 INFO - mozversion == 1.4 16:49:46 INFO - psutil == 3.1.1 16:49:46 INFO - requests == 1.2.3 16:49:46 INFO - wsgiref == 0.1.2 16:49:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:46 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 0x7f748a47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd50410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddf160>, '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 0xde0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde04f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', '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 16:49:46 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 16:49:46 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 16:49:46 INFO - Using env: {'DISPLAY': ':0', 16:49:46 INFO - 'HOME': '/home/cltbld', 16:49:46 INFO - 'LANG': 'en_US.UTF-8', 16:49:46 INFO - 'LANGUAGE': 'en_US:en', 16:49:46 INFO - 'LOGNAME': 'cltbld', 16:49:46 INFO - 'MAIL': '/var/mail/cltbld', 16:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:46 INFO - 'MOZ_NO_REMOTE': '1', 16:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:46 INFO - 'NO_EM_RESTART': '1', 16:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:46 INFO - 'PWD': '/builds/slave/test', 16:49:46 INFO - 'SHELL': '/bin/bash', 16:49:46 INFO - 'SHLVL': '1', 16:49:46 INFO - 'TERM': 'linux', 16:49:46 INFO - 'TMOUT': '86400', 16:49:46 INFO - 'USER': 'cltbld', 16:49:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', 16:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:46 INFO - '_': '/tools/buildbot/bin/python'} 16:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:46 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)) 16:49:46 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)) 16:49:46 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)) 16:49:46 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)) 16:49:46 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)) 16:49:46 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)) 16:49:46 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)) 16:49:46 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)) 16:49:46 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)) 16:49:46 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)) 16:49:46 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)) 16:49:46 INFO - Cleaning up... 16:49:46 INFO - Return code: 0 16:49:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:46 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 0x7f748a47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd50410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddf160>, '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 0xde0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde04f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', '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 16:49:46 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 16:49:46 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 16:49:46 INFO - Using env: {'DISPLAY': ':0', 16:49:46 INFO - 'HOME': '/home/cltbld', 16:49:46 INFO - 'LANG': 'en_US.UTF-8', 16:49:46 INFO - 'LANGUAGE': 'en_US:en', 16:49:46 INFO - 'LOGNAME': 'cltbld', 16:49:46 INFO - 'MAIL': '/var/mail/cltbld', 16:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:46 INFO - 'MOZ_NO_REMOTE': '1', 16:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:46 INFO - 'NO_EM_RESTART': '1', 16:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:46 INFO - 'PWD': '/builds/slave/test', 16:49:46 INFO - 'SHELL': '/bin/bash', 16:49:46 INFO - 'SHLVL': '1', 16:49:46 INFO - 'TERM': 'linux', 16:49:46 INFO - 'TMOUT': '86400', 16:49:46 INFO - 'USER': 'cltbld', 16:49:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', 16:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:46 INFO - '_': '/tools/buildbot/bin/python'} 16:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:47 INFO - Downloading/unpacking jsonschema 16:49:47 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 16:49:47 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 16:49:47 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 16:49:47 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 16:49:47 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 16:49:47 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 16:49:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:49:48 INFO - Downloading/unpacking functools32 (from jsonschema) 16:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:49 INFO - Downloading functools32-3.2.3-2.tar.gz 16:49:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:49:49 INFO - warning: no files found matching '*.txt' 16:49:49 INFO - no previously-included directories found matching 'build' 16:49:49 INFO - no previously-included directories found matching 'dist' 16:49:49 INFO - no previously-included directories found matching '.git*' 16:49:49 INFO - Installing collected packages: jsonschema, functools32 16:49:49 INFO - Running setup.py install for functools32 16:49:49 INFO - warning: no files found matching '*.txt' 16:49:49 INFO - no previously-included directories found matching 'build' 16:49:49 INFO - no previously-included directories found matching 'dist' 16:49:49 INFO - no previously-included directories found matching '.git*' 16:49:49 INFO - Successfully installed jsonschema functools32 16:49:49 INFO - Cleaning up... 16:49:49 INFO - Return code: 0 16:49:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:49 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 0x7f748a47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd50410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddf160>, '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 0xde0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde04f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', '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 16:49:49 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 16:49:49 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 16:49:49 INFO - Using env: {'DISPLAY': ':0', 16:49:49 INFO - 'HOME': '/home/cltbld', 16:49:49 INFO - 'LANG': 'en_US.UTF-8', 16:49:49 INFO - 'LANGUAGE': 'en_US:en', 16:49:49 INFO - 'LOGNAME': 'cltbld', 16:49:49 INFO - 'MAIL': '/var/mail/cltbld', 16:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:49 INFO - 'MOZ_NO_REMOTE': '1', 16:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:49 INFO - 'NO_EM_RESTART': '1', 16:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:49 INFO - 'PWD': '/builds/slave/test', 16:49:49 INFO - 'SHELL': '/bin/bash', 16:49:49 INFO - 'SHLVL': '1', 16:49:49 INFO - 'TERM': 'linux', 16:49:49 INFO - 'TMOUT': '86400', 16:49:49 INFO - 'USER': 'cltbld', 16:49:49 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', 16:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:49 INFO - '_': '/tools/buildbot/bin/python'} 16:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:49 INFO - Downloading/unpacking flake8 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:49:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:49:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:49:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:49:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:49:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:49:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:49:52 INFO - no previously-included directories found matching 'docs/_build' 16:49:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:49:52 INFO - Running setup.py install for pep8 16:49:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:49:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:49:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:49:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:49:52 INFO - no previously-included directories found matching 'docs/_build' 16:49:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:49:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:49:52 INFO - Cleaning up... 16:49:52 INFO - Return code: 0 16:49:52 INFO - Running post-action listener: _resource_record_post_action 16:49:52 INFO - Running post-action listener: _start_resource_monitoring 16:49:52 INFO - Starting resource monitoring. 16:49:52 INFO - ##### 16:49:52 INFO - ##### Running install step. 16:49:52 INFO - ##### 16:49:52 INFO - Running pre-action listener: _resource_record_pre_action 16:49:52 INFO - Running main action method: install 16:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:49:52 INFO - Reading from file tmpfile_stdout 16:49:52 INFO - Detecting whether we're running mozinstall >=1.0... 16:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:49:52 INFO - Reading from file tmpfile_stdout 16:49:52 INFO - Output received: 16:49:52 INFO - Usage: mozinstall [options] installer 16:49:52 INFO - Options: 16:49:52 INFO - -h, --help show this help message and exit 16:49:52 INFO - -d DEST, --destination=DEST 16:49:52 INFO - Directory to install application into. [default: 16:49:52 INFO - "/builds/slave/test"] 16:49:52 INFO - --app=APP Application being installed. [default: firefox] 16:49:52 INFO - mkdir: /builds/slave/test/build/application 16:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:50:08 INFO - Reading from file tmpfile_stdout 16:50:08 INFO - Output received: 16:50:08 INFO - /builds/slave/test/build/application/firefox/firefox 16:50:08 INFO - Running post-action listener: _resource_record_post_action 16:50:08 INFO - ##### 16:50:08 INFO - ##### Running run-tests step. 16:50:08 INFO - ##### 16:50:08 INFO - Running pre-action listener: _resource_record_pre_action 16:50:08 INFO - Running main action method: run_tests 16:50:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:50:08 INFO - Python 2.7.3 16:50:08 INFO - Return code: 0 16:50:08 INFO - grabbing minidump binary from tooltool 16:50:08 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')]} 16:50:08 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 0xddf160>, '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 0xde0060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde04f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:50:08 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 16:50:08 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 16:50:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:50:08 INFO - Return code: 0 16:50:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:50:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:50:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:50:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:50:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:50:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:50:09 INFO - Return code: 0 16:50:09 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/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 16:50:09 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/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 16:50:09 INFO - Using env: {'DISPLAY': ':0', 16:50:09 INFO - 'HOME': '/home/cltbld', 16:50:09 INFO - 'LANG': 'en_US.UTF-8', 16:50:09 INFO - 'LANGUAGE': 'en_US:en', 16:50:09 INFO - 'LOGNAME': 'cltbld', 16:50:09 INFO - 'MAIL': '/var/mail/cltbld', 16:50:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:50:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:09 INFO - 'MOZ_NO_REMOTE': '1', 16:50:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:09 INFO - 'NO_EM_RESTART': '1', 16:50:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:09 INFO - 'PWD': '/builds/slave/test', 16:50:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:50:09 INFO - 'SHELL': '/bin/bash', 16:50:09 INFO - 'SHLVL': '1', 16:50:09 INFO - 'TERM': 'linux', 16:50:09 INFO - 'TMOUT': '86400', 16:50:09 INFO - 'USER': 'cltbld', 16:50:09 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177', 16:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:09 INFO - '_': '/tools/buildbot/bin/python'} 16:50:09 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/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 16:50:09 INFO - mozversion application_buildid: 20160422141954 16:50:09 INFO - mozversion application_changeset: c0be14550a2b77f8f8b4aab158fc3525ffc82828 16:50:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:50:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:50:09 INFO - mozversion application_name: Firefox 16:50:09 INFO - mozversion application_remotingname: firefox-dev 16:50:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:50:09 INFO - mozversion application_vendor: Mozilla 16:50:09 INFO - mozversion application_version: 47.0a2 16:50:09 INFO - mozversion platform_buildid: 20160422141954 16:50:09 INFO - mozversion platform_changeset: c0be14550a2b77f8f8b4aab158fc3525ffc82828 16:50:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:50:09 INFO - mozversion platform_version: 47.0a2 16:50:09 INFO - using testdate: 1461369009 16:50:09 INFO - actual date: 1461369009 16:50:09 INFO - starting webserver on 'localhost:34338' 16:50:09 INFO - SUITE-START | Running 2 tests 16:50:09 INFO - TEST-START | dromaeo_css 16:50:09 INFO - operating with platform_type : linux_ 16:50:09 INFO - Initialising browser for dromaeo_css test... 16:50:09 INFO - TEST-INFO | started process 30927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLaaL3p/profile http://localhost:34338/getInfo.html) 16:50:13 INFO - PROCESS | 30927 | __metrics Screen width/height:1600/1200 16:50:13 INFO - PROCESS | 30927 | colorDepth:24 16:50:13 INFO - PROCESS | 30927 | Browser inner width/height: 1024/697 16:50:13 INFO - PROCESS | 30927 | __metrics 16:50:14 INFO - PROCESS | 30927 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:50:15 INFO - TEST-INFO | 30927: exit 0 16:50:15 INFO - Browser initialized. 16:50:15 INFO - Running cycle 1/1 for dromaeo_css test... 16:50:15 INFO - TEST-INFO | started process 31022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLaaL3p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:50:27 INFO - PROCESS | 31022 | RSS: Main: 142286848 16:50:27 INFO - PROCESS | 31022 | 16:51:18 INFO - PROCESS | 31022 | 1461369078280 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] 16:53:26 INFO - PROCESS | 31022 | Cycle 1(1): loaded http://localhost:34338/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34338/tests/dromaeo/cssquery-ext.html) 16:53:27 INFO - PROCESS | 31022 | RSS: Main: 217870336 16:53:27 INFO - PROCESS | 31022 | 16:56:29 INFO - PROCESS | 31022 | Cycle 1(1): loaded http://localhost:34338/tests/dromaeo/cssquery-ext.html (next: http://localhost:34338/tests/dromaeo/cssquery-jquery.html) 16:56:30 INFO - PROCESS | 31022 | RSS: Main: 217788416 16:56:30 INFO - PROCESS | 31022 | 16:59:32 INFO - PROCESS | 31022 | Cycle 1(1): loaded http://localhost:34338/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34338/tests/dromaeo/cssquery-mootools.html) 16:59:32 INFO - PROCESS | 31022 | RSS: Main: 214003712 16:59:32 INFO - PROCESS | 31022 | 17:02:34 INFO - PROCESS | 31022 | Cycle 1(1): loaded http://localhost:34338/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34338/tests/dromaeo/cssquery-prototype.html) 17:02:35 INFO - PROCESS | 31022 | RSS: Main: 207167488 17:02:35 INFO - PROCESS | 31022 | 17:05:37 INFO - PROCESS | 31022 | Cycle 1(1): loaded http://localhost:34338/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34338/tests/dromaeo/cssquery-yui.html) 17:05:38 INFO - PROCESS | 31022 | RSS: Main: 206155776 17:05:38 INFO - PROCESS | 31022 | 17:08:40 INFO - PROCESS | 31022 | Cycle 1(1): loaded http://localhost:34338/tests/dromaeo/cssquery-yui.html (next: http://localhost:34338/tests/dromaeo/cssquery-dojo.html) 17:08:40 INFO - PROCESS | 31022 | RSS: Main: 252366848 17:08:40 INFO - PROCESS | 31022 | 17:08:40 INFO - PROCESS | 31022 | __start_tp_report 17:08:40 INFO - PROCESS | 31022 | _x_x_mozilla_page_load 17:08:40 INFO - PROCESS | 31022 | _x_x_mozilla_page_load_details 17:08:40 INFO - PROCESS | 31022 | |i|pagename|runs| 17:08:40 INFO - PROCESS | 31022 | |0;dojo.html;3326.118578576677;3412.488126780984;3425.6231814500416;3429.108431807731;3465.6361082086373;5504.284443022407;5505.614606977513;5515.972420137904;5516.806911758089;5543.501084902358;5511.366192887809;5526.58550608705;5529.087700529418;5537.972310138453;5544.77820887164;4896.387951506062;5020.92468612972;5035.370578677665;5093.185090385539;5131.7690703918415;4951.876203094916;4975.427825800025;5027.245913113025;5033.697978121306;5039.622028347871;5059.747012649371;5154.433012368637;5157.948420515784;5160.509751573594;5173.87065323368;4975.676581022222;5023.547880690755;5036.546710796028;5047.394312682502;5092.13433716271;4785.688930219525;5048.873778155576;5066.290719299301;5070.645054846163;5105.872353191163;5365.570754339644;5429.0227759003365;5435.10320797068;5453.945460545384;5461.808836690697;5896;5900.586958912878;5907.1434641976675;5911;5912.733926973297;5824.184614154022;5903.350631430582;5919.496842768327;5932.0508718604815;5941.673207973603;5505.697186654733;5513.117901135799;5519.641223320471;5523.392426833045;5543.584231182637;6041;6042.184305118841;6057.061155520902;6060.818175454743;6065.4541091302;5777.364489906107;5795.710214489259;5828.184054232411;5891.941080589139;5962.731677074542;5949.970250148722;5955.672438015864;5962.880742385215;5965.373635768268;5970.462658360769;5910.261217347832;5916.615419997686;5919.733611987471;5924.703764811742;5925.614835035795;5727.599068065196;5759.798407055733;5894.086416605433;5907.556933230025;5914.4381283777975;4489.34904438861;4527.071950250191;4540.228161212602;4541.954580454153;4547.8635640930825;4096.078382364004;4104.507459104927;4118.217538667644;4126.731762435432;4143.917121657611;5429.755660995264;5672.489475947102;5760.798372056958;5768.826935191951;5773.509251713652;5935.0503919372695;5996.340402555716;6001.2498437695285;6005.099235114681;6008.429199226067;5630.521405680481;5672.035753921843;5674.744636491368;5678.716064196857;5682.318121825408;4982.202847544376;5069.873253168626;5144.794208231704;5146.897062058738;5169.121249387613;6088.634681919099;6105.267367915879;6117;6118.816435506942;6120.510359171256;5822.0684690449325;5910.940890591039;5917.37867523921;5922.466977972003;5927.407259274038;6141.9385806143155;6159.1377207190135;6203.7828675996125;6204.317525072148;6209.472194863487;5833.591648584558;5866.208061911588;5872.207252021093;5904.996150654485;5930.525557955267;5607.74765135578;5890.646561206341;5925.111233315038;5932.970335148297;5938.881222375615;5753.223314852608;5758.712064396847;5771.047777116729;5789.8263052108505;5821.476067153807;5767.884642307215;5777.364489906023;5779.133130030529;5779.248697669276;5785.4214578541805;5566.805161819317;5681.744321505625;5693.032184528723;5705.686187259741;5788.7395067222915;5742.052561327334;5766.711664416678;5842.1820945068575;5878.030125029493;5913.881722365614;5715.31416230055;5716.342620598684;5719.799807006735;5722.084466485342;5737.512311453574 17:08:40 INFO - PROCESS | 31022 | |1;ext.html;572.4075581772865;579.3916387792818;592.4758485830193;594.991489425424;596.8209537138857;31436.371272574535;32263.83868080662;40280.19439611206;41085.38371924424;41154.176916461656;43901;44127.77936110315;44508.55491445085;44532;44589.55410445895;7468.55188688679;7531.284527969834;7569.507981981181;8005.6797728090805;10420.374777513336;10583.047525722683;10739.946300268488;10740.03339699427;10742.892571074268;10746.677599671983;10746.785064298709;10857.45712714365;10858.891411085906;10867.619633312836;10872.945635271813;10672.733181670443;10732.409717465536;10735.516901739402;10760.300580462284;10762.677119686421;10558.1025612823;10696.304740191863;10705.946470267676;10707.892921070768;10948.616798412017;44196.779016104716;44489.55510444887;44577;44607.77696111531;44630.10739785186;3381.560397148355;3502.842372093262;3565.4295312749837;3587.3901436755814;3828.483154774098;33454.33091338184;33482.33035339304;33647.49528757071;33786.662133378595;33827;3779.8866034019024;3836.75061121029;3896;3944.9408258876138;3953.0710283083454;217175;218476;219069;219241;220045;45735.313970290474;47120.5287947123;47209;47265.76367118143;67828.6608566954;45251.54748452539;45411.77294113508;45444.545554544035;45449.772751136035;45457.31814022792;14519.637009074857;14584.708305833823;14675.77986330206;14676.192809395585;14690.779638305434;9581.904180958101;11841.703957400961;12284.631461056004;12286.262824230575;12293.631191064282;15195.544133676007;15327.693446131016;15494.922525387301;15735.370585176694;15864.60338491547;5983.760649574056;5991.5206783457215;6006.669633170218;6029.155918171459;6249.78125765596;1119.8040342940117;1136.5624234669713;1142.7600203957095;1162.831389448542;1219.2562536852513;29444.263893402836;29671.851640741657;29741;30250.24374390658;30336.393272134435;1129.3788416371128;1136.3977092141179;1208.8126340417073;1220.6460126563375;1232.9136960412864;15542.611434713996;15575.81688903091;15599;15853.920730396274;15977.840221597868;350922;354540;355057;355237;355942;56780.71609641925;56871.43128568744;57382;57385.426145738005;57469.13796293059;1213.247786372437;1295.8963282937343;1451.484722923368;1461.1452300404383;1466.5746933389412;27278.454430910875;27727.58408623832;28013.299667508476;28078.157655270374;28199;43499.34750978675;43530.78234608807;43593;43895.34156987584;43941.78029109834;193233;194954;195196;195531;298740;34259.14352141217;34633.307333853685;35008;35043.82478087593;35047.64952350444;41162.176756465306;42088.78955605203;50096.49903501064;51879;52524;38816.80591597024;39089.80455097706;39315.80342098271;39407;39529.407058893565;38662.420063698504;39518.802405987786;39704;39797.60202397939;40591.594084059965;39002.2199556013;39523.40714889336;39839.2032159361;40132.79933600313;40339;33708.49437258394;35713.46429803607;36176.819115904254;36830.63169368379;36913.26173476569;27164.728352716218;27532.587011194446;27686.72313276922;27694.584581231702;27764 17:08:40 INFO - PROCESS | 31022 | |2;jquery.html;376.668531692111;388.32625394939777;393.7342293951582;398.75078076202374;403.1010845813833;16654;19243.518912027208;19409.22363105476;19456.513587160327;19513.219471221153;16556.751648725247;16766.916165419185;17426.128693565333;17465;17468.388606398777;5628.634138780976;5772.076467765159;5798.594098413113;5809.448102430283;5816.505597024258;4265.466816647919;6252.5935814171935;6534.901976470357;6545.312742162076;6566.21205455346;5550.47270509301;6468.870622587546;6486.708098135572;6512.479001679854;6515.934840651604;5741.569382296324;5762.9135562966585;5771.769129234825;5776.451237132465;5783.045797443438;3869.6517313441645;5409;5574.498295153415;5576.498115169614;5580.107182850725;20797.792022079888;21164.894175529178;21235.044423001003;21431.464213394633;21443.46391340229;2409.373562873648;2459.360566252787;2541.9110331138504;2808.9578656320173;2885.336372634285;9989.150922171624;10000.94999525005;10240.89759102407;10537;10681.572737090508;1844.9446516604523;1875.3248830421037;1891.6784146694956;1918.5107797511685;1980.7127966444784;64986;68077;68341;70176;70327.94508082434;9495.43027418357;9754.95122524397;9892.15916647093;9906.851397229048;10304.484775761182;13278.601641950758;13309.800352994713;13311.933440332736;13314.267715275753;13326.133801302884;7244.601546914971;7366;7460.29127232912;7479.177290498041;7545.094588649397;7266.45501587383;7290.125184977836;7297.233790452032;7339.669714862844;7371.631418429057;4122.587741225853;4138.482689663792;4142.896427589334;4154.543000269968;4295.506016808107;1689.7972243330878;1712.2722842791763;1713.3917459302018;1719.664665390237;1768.6904791661407;962.1869520255373;1046.6980709284833;1047.3297089862494;1058.9682309530726;1072.1208608940594;16870.946629380644;17223.483295501155;17351.3059477622;17862;18324.26702931868;987.8518222266574;996.4170959988488;1004.6634377483625;1032.695354870315;1098.6374496416163;10256.179505639531;10331.328463649988;10391.220658450495;10399.428031458192;10432.113270371952;343642;347258;418838;421420;425570;68796.31203687999;69193;70098.64950675215;71395.64302178456;74858.25141748622;1087.1140020882956;1111.372074777748;1115.7154925493946;1119.7032786311634;1120.5125770289949;16199.352025919303;16327.183640817673;16365.754513682066;16397.91801040987;16820.243089060776;34965.300693986486;35256.64743352636;36671.63328366682;36819.26361472702;36832.26335473329;50670.74664626653;51241.7437912808;51379.2293115611;51592.74203628958;52061.21908171305;8378.916210838057;8564.400491965502;8629;8783.989841168348;8940.821183576421;8412.789680257798;12315.076369272161;12322.32227227511;13138.211707297593;13191.934040329737;10367.844482332923;10621.627023785975;10785;10818.026377625736;10978.011978921935;10861.294015888941;11346.319220846775;11426.657200284004;11501.53993840237;12027.338496382783;10808.243422960632;11130.610428634958;11241.156913231376;11285.097192224766;11309;8244.670213191404;8315.168483151878;8348.666053357798;8630.309575233841;8829;10314.638987635397;10622.946885265525;10814.188935829687;10913.454327283445;11270.94364528172 17:08:40 INFO - PROCESS | 31022 | |3;mootools.html;1318.9868101318984;1578.4633224703603;1599.2163839718537;1861.6928206845862;1966.4887129346366;7656.081270247571;8271.048829384623;8414.537200453973;8423.410361274713;8431.578421078952;8358.582070896446;8538.91461085389;8548.70079547216;8554.786130346745;8555.187257210571;2126.2876936226385;2403.771641694036;2454.0919859651863;2455.4475243070347;2478.925632231027;2475.084218839032;2491.289982355029;2500.4499010217723;2506.223070848043;2507.022261318078;2465.9753402466013;2483.627455881623;2491.6885389326335;2498.912538061159;2500.2124330835727;2415.2995631266913;2441.7680320369536;2443.5601591713485;2444.2300675287315;2444.5721998650256;2390.6294524348755;2412.746661600524;2416.8187385946126;2422.043292899295;2437.7927876130375;8703.086175951497;8761.868571971425;8762.912370876336;8764;8767.912320876838;5111.05445492585;5237.083510385705;5240.030594340059;5245.711485868275;5248.842534723926;3185.5062465317915;3248.5289633003317;3346.1634591352163;3376.983115084409;3381.830908454592;1063.1760385701066;1098.4672433869566;1108.467935391017;1116.0234794554765;1173.3312012153076;12287.262764234085;12306.876931230663;12337.074719396081;12359.32023738694;12372.8144077838;4679.572730317218;4778.5699287064335;4803.975980120077;4836.347093142451;4841.975790121027;10324.12244959172;10368.792624147474;10371.688849334532;10381.169506439466;10397.376157430579;4713.6464765142755;5241;5281.577473802164;5287.286216360819;5293.311869456946;4665.113628410591;4744.098621261949;4764.0471905619015;4773.832915847928;4785.904281914342;4000.538054931402;4047.514298284225;4073.429719839225;4081.428599996003;4088.223237584909;1306.8303868038054;1308.463529952715;1314.309987256698;1326.1313839435186;1336.3051213369188;1200.9819852702217;1211.927284362941;1280.7182419867613;1363.740889231043;1484.7772834074974;7867.685292588347;7923.841523169504;7977.7207797726805;8039.155888631726;8047.597620119088;528.9576833853282;531.3358302122347;533.34398689612;533.6157966264284;534.4628648208526;6065.787697430657;6099.451049405575;6106.145139680449;6146.692665366714;6151.108089327023;10028.197744180594;10293.125084367763;10416.687499375032;10430.947845260876;10437.217208709226;10025.097741203326;10111.090001899864;10150;10246.180305575685;10301.330413523097;8031.959840200879;8068.3948703847445;8090.9595452021185;8112.83774324522;8135.145809689898;8000.919990800017;8038.598070096588;8054.275115239657;8144.633491493016;8244.340452763885;9324.347295689236;9463.101005404476;9478.289128315266;9534.666286679932;9574.090461406155;9675.225981921289;9834.606615735576;9845.409275443497;9874.851877221703;10042.196624270187;6547.541672082908;7129.21578626361;7494.063242094739;7661.846763064596;7779.688812447439;8075.676972921017;8097.595120244082;8113.472624279403;8143.022837259567;8155.102938676622;6784.084148640068;6948.5483443576;7016.403605693573;7091.716331346895;7175.31834475724;7177.677004534913;7186.496945213785;7262.455315851226;7319.158296795937;7349.8162545936775;7440.665170067252;7803.258690424401;7811.804704882196;7815.804604884924;7818.765437036898;7176.354128128493;7235.674394652148;7266.1280646322775;7269.818254543678;7281.235470275757;7170;7232.63836808168;7303.123625165014;7371.778846634609;7386.113666359856 17:08:40 INFO - PROCESS | 31022 | |4;prototype.html;369.702389576391;370.84239198340714;375.1091158498566;376.63090171631785;384.35236626284694;6063.514918806491;6089.908651370233;6104.450599446049;6104.6947652617355;6109.14471973924;5971.253593300838;6016.909746353808;6024.216851809269;6028.156058151862;6033.456988871001;4547.795349209294;4604.907901841962;4663.626909847204;4709.175894218498;4759.381280433556;4699.953000469985;4703.858884233478;4729.385179926605;4736.029114031615;4738.620910327183;4679.15775160471;4682.321063445798;4694.577488026077;4695.741734204617;4701.271302948048;4492.236319825637;4603.8618841434645;4658.883527911796;4677.812887484497;4695.577398034194;4182.602652747984;4186.0581369192;4194.412782210493;4194.790260486994;4199.118185181115;5764.423557644244;5775.768969241225;5776.855578610568;5778.0466223073145;5779;5494.5054945054735;5495.203195536625;5503.559715222773;5503.697296648683;5516.172574113915;6378.489720822323;6390.904136437957;6399.776007839703;6406.167198264243;6411.3588641135975;4407.27279998803;4536.954630453686;4539.682222244444;4546.29532422475;4658.906821863544;6607.9669601651685;6654.800355989328;6661.26726060133;6663.333666633346;6686.5653732507235;4632.62938964882;4634.884127896829;4640.79116439761;4643.721376717408;4644.396228490342;4700.95299047012;4701.48283688794;4706.835260765857;4706.905861882811;4710.764461776897;5392.838214853561;5397.865053373697;5402.540784033401;5404.756785944642;5418.322709661293;6293.653849038255;6416.903746443807;6447.484201263887;6453.096566480603;6456.289808121103;1630.2500849609075;1650.1666658337463;1656.4202529114955;1656.4864891883315;1657.1796960504387;1039.9896001040045;1084.5065495199665;1096.3038470571084;1098.8956049175315;1115.576081089197;6175.320714721377;6187.102870083902;6214.782482613177;6215.875682486416;6230.283517395467;6565.80302590923;6567.376099270562;6572.441342485942;6584;6619.801405957829;6181.536384771161;6185.505159587222;6187.659678717624;6190.597611155261;6192.566520343623;3501.492283618912;3556.05764472415;3557.4663800429626;3563.394222982099;3566.411542095525;6598.1422415085735;6805.013273075377;6808.38724514796;6813.386795188457;6816.931830681729;6686.398224159751;6709.36261055199;6710.731570737116;6727.9327206728285;6731.49513786468;6763.830904227434;6765.086713293741;6766.560173588602;6769.559978601375;6775.1531058617675;6509.088727578048;6522.184726909137;6552.27924928248;6563.540552161303;6576.079348891255;6330.240371155491;6468.3855033771715;6477.352264773485;6477.643729594917;6483.481321494363;6645.60126392418;6668.233153187445;6695.598264104169;6699.0621313015245;6708.496862735412;4489.461264648263;4529.932051019171;4554.521775213688;4558.6581006423985;4566.543345665407;6463.7737679181;6470.191226096738;6471.935280647322;6500.414962653194;6527.5757075789925;6240.438360547572;6383.6169829808505;6399.232092148972;6400.103985441949;6401.071844582416;6360.618362898241;6377.17096777416;6382.234131904015;6383.1382763326355;6394.520410969289;6215.875682486235;6238.875222495434;6240.063990401294;6249.281332646804;6331.461825744679;6379.106925030406;6409.2949775525585;6418.871622567429;6421.5825971311715;6423.164988551458;6113.205283313141;6207.906881396692;6245.28179259391;6266.811995640138;6364.936350636434 17:08:40 INFO - PROCESS | 31022 | |5;yui.html;659.1694464974132;700.4536461559982;721.877280862254;789.8617741895167;797.7447216890594;12142.514299428023;12262.93868530656;12342.07434442416;12343.444544995475;12384.00927925766;12299.32353720545;12322.938385308062;12377.56678516252;12392.690182745413;12397.876021239808;754.8188434775642;888.8133491966695;890.2032680750724;912.5574096563162;918.3846822628822;914.7347269291897;924.8011677489338;925.1673493855517;925.255169588481;925.5696101312889;974.878140232471;981.4503877828404;984.4536282363285;984.5077461269366;985.581128020592;807.0638059850545;959.71688351936;986.082942863137;988.4909271725068;991.3952488981752;711.5552779512805;714.3213946750608;714.5605452646637;714.8641758065951;715.1918332284537;12518.436670349856;12523.812142817866;12552.560660376934;12555.183913045623;12569.120161588693;13142.145760525535;13594.456221751117;13657;13700.974660809032;13863.890888728878;10827.458627068616;11501.654950351503;11591.942040289745;11637.301761894314;11644;3744.606816284278;3775.848966041355;3788.6400791925;3828.2343531293855;3908.7068469864876;49642;50399.74800125976;50651.74674126643;50805.491945080816;51881.7405912968;9674.75813104664;9675.951620241995;9909.900900991042;9992.850107248398;10150.137238334677;18450.815491845176;18488.168032438574;18506.167222475022;18511.722324165148;18519.44441666752;7457.179710231871;7475.102987641518;7581.241875812375;7627.275408836152;7671.501352412075;4298.76356800379;4333.111712099012;4340.696151269381;4368.388425620416;4396.956030439718;3443.1564266754804;3450.2236996675547;3464.8614055438006;3472.3576138414473;3482.9477557836653;572.4104172702123;640.6508452893185;663.5952069237761;665.986680266392;690.5304393012699;521.8695326168458;547.8712502561895;551.5008916930185;567.6225310168774;595.5890435599423;7663.27198916102;8060.073091594541;8070.878936815952;8131.14622964592;8221.54781487012;487.3883276487985;527.3408239700375;531.4552583601762;536.2974503400558;567.330709014096;3673.9632603674154;3760.680342170946;3789.7915614640906;3794.506714127201;3878.70909681775;63041.36958630447;63863.68068159722;64519.677401612695;64674;65054;54842;55649.721751390985;55912;57567;57741.422585774446;50164;51115.233271500954;51175.48824511707;51885.740571296905;52022.739886300325;7581.545107293359;7590.544567325757;7593.734219302298;7811.570363630055;7849.803754906173;36005.63994360023;38271.234575308896;38351.616483834805;39362.60637393704;39366.40950385689;45232.54767452284;45290.09419811519;51405;51641;52256;10595.682129536126;11002.50488728025;11309.943450282695;11371.488283027118;11511.597094101666;11665.066794656577;11705.824412633647;11844.822327664919;11910.404479776149;12105.576304829288;11464.140189485655;11811.763764724485;11894;11897.702557435787;12030.27818330903;10691.09125724322;11228.382438965935;11393.316401015965;11576.363300018244;11716.472758725708;10987.121030317396;11231.4384280784;11321;11458.369789661649;11579.768404632028;9524.761880953032;9612.51937403141;9715.805683886425;9794.559244834141;9801.411915285105;9803.215742740706;9989.400635961865;10069.546870390997;10102.191824654157;10116.949415252877 17:08:40 INFO - PROCESS | 31022 | __end_tp_report 17:08:40 INFO - PROCESS | 31022 | __start_cc_report 17:08:40 INFO - PROCESS | 31022 | _x_x_mozilla_cycle_collect,703 17:08:40 INFO - PROCESS | 31022 | __end_cc_report 17:08:40 INFO - PROCESS | 31022 | __startTimestamp1461370120765__endTimestamp 17:08:40 INFO - PROCESS | 31022 | 17:08:40 INFO - PROCESS | 31022 | ------- Summary: start ------- 17:08:40 INFO - PROCESS | 31022 | Number of tests: 6 17:08:40 INFO - PROCESS | 31022 | 17:08:40 INFO - PROCESS | 31022 | [#0] dojo.html Cycles:165 Average:5511.94 Median:5737.51 stddev:597.01 (10.4%) stddev-sans-first:573.69 17:08:40 INFO - PROCESS | 31022 | Values: 3326.1 3412.5 3425.6 3429.1 3465.6 5504.3 5505.6 5516.0 5516.8 5543.5 5511.4 5526.6 5529.1 5538.0 5544.8 4896.4 5020.9 5035.4 5093.2 5131.8 4951.9 4975.4 5027.2 5033.7 5039.6 5059.7 5154.4 5157.9 5160.5 5173.9 4975.7 5023.5 5036.5 5047.4 5092.1 4785.7 5048.9 5066.3 5070.6 5105.9 5365.6 5429.0 5435.1 5453.9 5461.8 5896.0 5900.6 5907.1 5911.0 5912.7 5824.2 5903.4 5919.5 5932.1 5941.7 5505.7 5513.1 5519.6 5523.4 5543.6 6041.0 6042.2 6057.1 6060.8 6065.5 5777.4 5795.7 5828.2 5891.9 5962.7 5950.0 5955.7 5962.9 5965.4 5970.5 5910.3 5916.6 5919.7 5924.7 5925.6 5727.6 5759.8 5894.1 5907.6 5914.4 4489.3 4527.1 4540.2 4542.0 4547.9 4096.1 4104.5 4118.2 4126.7 4143.9 5429.8 5672.5 5760.8 5768.8 5773.5 5935.1 5996.3 6001.2 6005.1 6008.4 5630.5 5672.0 5674.7 5678.7 5682.3 4982.2 5069.9 5144.8 5146.9 5169.1 6088.6 6105.3 6117.0 6118.8 6120.5 5822.1 5910.9 5917.4 5922.5 5927.4 6141.9 6159.1 6203.8 6204.3 6209.5 5833.6 5866.2 5872.2 5905.0 5930.5 5607.7 5890.6 5925.1 5933.0 5938.9 5753.2 5758.7 5771.0 5789.8 5821.5 5767.9 5777.4 5779.1 5779.2 5785.4 5566.8 5681.7 5693.0 5705.7 5788.7 5742.1 5766.7 5842.2 5878.0 5913.9 5715.3 5716.3 5719.8 5722.1 5737.5 17:08:40 INFO - PROCESS | 31022 | 17:08:40 INFO - PROCESS | 31022 | [#1] ext.html Cycles:180 Average:44289.46 Median:34820.65 stddev:71055.39 (204.1%) stddev-sans-first:71178.90 17:08:40 INFO - PROCESS | 31022 | Values: 572.4 579.4 592.5 595.0 596.8 31436.4 32263.8 40280.2 41085.4 41154.2 43901.0 44127.8 44508.6 44532.0 44589.6 7468.6 7531.3 7569.5 8005.7 10420.4 10583.0 10739.9 10740.0 10742.9 10746.7 10746.8 10857.5 10858.9 10867.6 10872.9 10672.7 10732.4 10735.5 10760.3 10762.7 10558.1 10696.3 10705.9 10707.9 10948.6 44196.8 44489.6 44577.0 44607.8 44630.1 3381.6 3502.8 3565.4 3587.4 3828.5 33454.3 33482.3 33647.5 33786.7 33827.0 3779.9 3836.8 3896.0 3944.9 3953.1 217175.0 218476.0 219069.0 219241.0 220045.0 45735.3 47120.5 47209.0 47265.8 67828.7 45251.5 45411.8 45444.5 45449.8 45457.3 14519.6 14584.7 14675.8 14676.2 14690.8 9581.9 11841.7 12284.6 12286.3 12293.6 15195.5 15327.7 15494.9 15735.4 15864.6 5983.8 5991.5 6006.7 6029.2 6249.8 1119.8 1136.6 1142.8 1162.8 1219.3 29444.3 29671.9 29741.0 30250.2 30336.4 1129.4 1136.4 1208.8 1220.6 1232.9 15542.6 15575.8 15599.0 15853.9 15977.8 350922.0 354540.0 355057.0 355237.0 355942.0 56780.7 56871.4 57382.0 57385.4 57469.1 1213.2 1295.9 1451.5 1461.1 1466.6 27278.5 27727.6 28013.3 28078.2 28199.0 43499.3 43530.8 43593.0 43895.3 43941.8 193233.0 194954.0 195196.0 195531.0 298740.0 34259.1 34633.3 35008.0 35043.8 35047.6 41162.2 42088.8 50096.5 51879.0 52524.0 38816.8 39089.8 39315.8 39407.0 39529.4 38662.4 39518.8 39704.0 39797.6 40591.6 39002.2 39523.4 39839.2 40132.8 40339.0 33708.5 35713.5 36176.8 36830.6 36913.3 27164.7 27532.6 27686.7 27694.6 27764.0 17:08:40 INFO - PROCESS | 31022 | 17:08:40 INFO - PROCESS | 31022 | [#2] jquery.html Cycles:180 Average:24554.52 Median:173263.67 stddev:64679.32 (37.3%) stddev-sans-first:64835.29 17:08:40 INFO - PROCESS | 31022 | Values: 376.7 388.3 393.7 398.8 403.1 16654.0 19243.5 19409.2 19456.5 19513.2 16556.8 16766.9 17426.1 17465.0 17468.4 5628.6 5772.1 5798.6 5809.4 5816.5 4265.5 6252.6 6534.9 6545.3 6566.2 5550.5 6468.9 6486.7 6512.5 6515.9 5741.6 5762.9 5771.8 5776.5 5783.0 3869.7 5409.0 5574.5 5576.5 5580.1 20797.8 21164.9 21235.0 21431.5 21443.5 2409.4 2459.4 2541.9 2809.0 2885.3 9989.2 10000.9 10240.9 10537.0 10681.6 1844.9 1875.3 1891.7 1918.5 1980.7 64986.0 68077.0 68341.0 70176.0 70327.9 9495.4 9755.0 9892.2 9906.9 10304.5 13278.6 13309.8 13311.9 13314.3 13326.1 7244.6 7366.0 7460.3 7479.2 7545.1 7266.5 7290.1 7297.2 7339.7 7371.6 4122.6 4138.5 4142.9 4154.5 4295.5 1689.8 1712.3 1713.4 1719.7 1768.7 962.2 1046.7 1047.3 1059.0 1072.1 16870.9 17223.5 17351.3 17862.0 18324.3 987.9 996.4 1004.7 1032.7 1098.6 10256.2 10331.3 10391.2 10399.4 10432.1 343642.0 347258.0 418838.0 421420.0 425570.0 68796.3 69193.0 70098.6 71395.6 74858.3 1087.1 1111.4 1115.7 1119.7 1120.5 16199.4 16327.2 16365.8 16397.9 16820.2 34965.3 35256.6 36671.6 36819.3 36832.3 50670.7 51241.7 51379.2 51592.7 52061.2 8378.9 8564.4 8629.0 8784.0 8940.8 8412.8 12315.1 12322.3 13138.2 13191.9 10367.8 10621.6 10785.0 10818.0 10978.0 10861.3 11346.3 11426.7 11501.5 12027.3 10808.2 11130.6 11241.2 11285.1 11309.0 8244.7 8315.2 8348.7 8630.3 8829.0 10314.6 10622.9 10814.2 10913.5 11270.9 17:08:40 INFO - PROCESS | 31022 | 17:08:40 INFO - PROCESS | 31022 | [#3] mootools.html Cycles:180 Average:5991.87 Median:5243.36 stddev:3190.58 (60.8%) stddev-sans-first:3180.19 17:08:40 INFO - PROCESS | 31022 | Values: 1319.0 1578.5 1599.2 1861.7 1966.5 7656.1 8271.0 8414.5 8423.4 8431.6 8358.6 8538.9 8548.7 8554.8 8555.2 2126.3 2403.8 2454.1 2455.4 2478.9 2475.1 2491.3 2500.4 2506.2 2507.0 2466.0 2483.6 2491.7 2498.9 2500.2 2415.3 2441.8 2443.6 2444.2 2444.6 2390.6 2412.7 2416.8 2422.0 2437.8 8703.1 8761.9 8762.9 8764.0 8767.9 5111.1 5237.1 5240.0 5245.7 5248.8 3185.5 3248.5 3346.2 3377.0 3381.8 1063.2 1098.5 1108.5 1116.0 1173.3 12287.3 12306.9 12337.1 12359.3 12372.8 4679.6 4778.6 4804.0 4836.3 4842.0 10324.1 10368.8 10371.7 10381.2 10397.4 4713.6 5241.0 5281.6 5287.3 5293.3 4665.1 4744.1 4764.0 4773.8 4785.9 4000.5 4047.5 4073.4 4081.4 4088.2 1306.8 1308.5 1314.3 1326.1 1336.3 1201.0 1211.9 1280.7 1363.7 1484.8 7867.7 7923.8 7977.7 8039.2 8047.6 529.0 531.3 533.3 533.6 534.5 6065.8 6099.5 6106.1 6146.7 6151.1 10028.2 10293.1 10416.7 10430.9 10437.2 10025.1 10111.1 10150.0 10246.2 10301.3 8032.0 8068.4 8091.0 8112.8 8135.1 8000.9 8038.6 8054.3 8144.6 8244.3 9324.3 9463.1 9478.3 9534.7 9574.1 9675.2 9834.6 9845.4 9874.9 10042.2 6547.5 7129.2 7494.1 7661.8 7779.7 8075.7 8097.6 8113.5 8143.0 8155.1 6784.1 6948.5 7016.4 7091.7 7175.3 7177.7 7186.5 7262.5 7319.2 7349.8 7440.7 7803.3 7811.8 7815.8 7818.8 7176.4 7235.7 7266.1 7269.8 7281.2 7170.0 7232.6 7303.1 7371.8 7386.1 17:08:40 INFO - PROCESS | 31022 | 17:08:40 INFO - PROCESS | 31022 | [#4] prototype.html Cycles:180 Average:5368.36 Median:6144.26 stddev:1583.75 (25.8%) stddev-sans-first:1543.12 17:08:40 INFO - PROCESS | 31022 | Values: 369.7 370.8 375.1 376.6 384.4 6063.5 6089.9 6104.5 6104.7 6109.1 5971.3 6016.9 6024.2 6028.2 6033.5 4547.8 4604.9 4663.6 4709.2 4759.4 4700.0 4703.9 4729.4 4736.0 4738.6 4679.2 4682.3 4694.6 4695.7 4701.3 4492.2 4603.9 4658.9 4677.8 4695.6 4182.6 4186.1 4194.4 4194.8 4199.1 5764.4 5775.8 5776.9 5778.0 5779.0 5494.5 5495.2 5503.6 5503.7 5516.2 6378.5 6390.9 6399.8 6406.2 6411.4 4407.3 4537.0 4539.7 4546.3 4658.9 6608.0 6654.8 6661.3 6663.3 6686.6 4632.6 4634.9 4640.8 4643.7 4644.4 4701.0 4701.5 4706.8 4706.9 4710.8 5392.8 5397.9 5402.5 5404.8 5418.3 6293.7 6416.9 6447.5 6453.1 6456.3 1630.3 1650.2 1656.4 1656.5 1657.2 1040.0 1084.5 1096.3 1098.9 1115.6 6175.3 6187.1 6214.8 6215.9 6230.3 6565.8 6567.4 6572.4 6584.0 6619.8 6181.5 6185.5 6187.7 6190.6 6192.6 3501.5 3556.1 3557.5 3563.4 3566.4 6598.1 6805.0 6808.4 6813.4 6816.9 6686.4 6709.4 6710.7 6727.9 6731.5 6763.8 6765.1 6766.6 6769.6 6775.2 6509.1 6522.2 6552.3 6563.5 6576.1 6330.2 6468.4 6477.4 6477.6 6483.5 6645.6 6668.2 6695.6 6699.1 6708.5 4489.5 4529.9 4554.5 4558.7 4566.5 6463.8 6470.2 6471.9 6500.4 6527.6 6240.4 6383.6 6399.2 6400.1 6401.1 6360.6 6377.2 6382.2 6383.1 6394.5 6215.9 6238.9 6240.1 6249.3 6331.5 6379.1 6409.3 6418.9 6421.6 6423.2 6113.2 6207.9 6245.3 6266.8 6364.9 17:08:40 INFO - PROCESS | 31022 | 17:08:40 INFO - PROCESS | 31022 | [#5] yui.html Cycles:180 Average:14536.46 Median:50728.62 stddev:17611.87 (34.7%) stddev-sans-first:17630.44 17:08:40 INFO - PROCESS | 31022 | Values: 659.2 700.5 721.9 789.9 797.7 12142.5 12262.9 12342.1 12343.4 12384.0 12299.3 12322.9 12377.6 12392.7 12397.9 754.8 888.8 890.2 912.6 918.4 914.7 924.8 925.2 925.3 925.6 974.9 981.5 984.5 984.5 985.6 807.1 959.7 986.1 988.5 991.4 711.6 714.3 714.6 714.9 715.2 12518.4 12523.8 12552.6 12555.2 12569.1 13142.1 13594.5 13657.0 13701.0 13863.9 10827.5 11501.7 11591.9 11637.3 11644.0 3744.6 3775.8 3788.6 3828.2 3908.7 49642.0 50399.7 50651.7 50805.5 51881.7 9674.8 9676.0 9909.9 9992.9 10150.1 18450.8 18488.2 18506.2 18511.7 18519.4 7457.2 7475.1 7581.2 7627.3 7671.5 4298.8 4333.1 4340.7 4368.4 4397.0 3443.2 3450.2 3464.9 3472.4 3482.9 572.4 640.7 663.6 666.0 690.5 521.9 547.9 551.5 567.6 595.6 7663.3 8060.1 8070.9 8131.1 8221.5 487.4 527.3 531.5 536.3 567.3 3674.0 3760.7 3789.8 3794.5 3878.7 63041.4 63863.7 64519.7 64674.0 65054.0 54842.0 55649.7 55912.0 57567.0 57741.4 50164.0 51115.2 51175.5 51885.7 52022.7 7581.5 7590.5 7593.7 7811.6 7849.8 36005.6 38271.2 38351.6 39362.6 39366.4 45232.5 45290.1 51405.0 51641.0 52256.0 10595.7 11002.5 11309.9 11371.5 11511.6 11665.1 11705.8 11844.8 11910.4 12105.6 11464.1 11811.8 11894.0 11897.7 12030.3 10691.1 11228.4 11393.3 11576.4 11716.5 10987.1 11231.4 11321.0 11458.4 11579.8 9524.8 9612.5 9715.8 9794.6 9801.4 9803.2 9989.4 10069.5 10102.2 10116.9 17:08:40 INFO - PROCESS | 31022 | -------- Summary: end -------- 17:08:40 INFO - PROCESS | 31022 | 17:08:41 INFO - TEST-INFO | 31022: exit 0 17:08:41 INFO - TEST-OK | dromaeo_css | took 1112145ms 17:08:41 INFO - TEST-START | kraken 17:08:41 INFO - operating with platform_type : linux_ 17:08:41 INFO - Initialising browser for kraken test... 17:08:41 INFO - TEST-INFO | started process 31218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT9Uo1k/profile http://localhost:34338/getInfo.html) 17:08:45 INFO - PROCESS | 31218 | __metrics Screen width/height:1600/1200 17:08:45 INFO - PROCESS | 31218 | colorDepth:24 17:08:45 INFO - PROCESS | 31218 | Browser inner width/height: 1024/697 17:08:45 INFO - PROCESS | 31218 | __metrics 17:08:46 INFO - PROCESS | 31218 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:08:47 INFO - TEST-INFO | 31218: exit 0 17:08:47 INFO - Browser initialized. 17:08:47 INFO - Running cycle 1/1 for kraken test... 17:08:47 INFO - TEST-INFO | started process 31310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT9Uo1k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:08:59 INFO - PROCESS | 31310 | RSS: Main: 141987840 17:08:59 INFO - PROCESS | 31310 | 17:09:02 INFO - PROCESS | 31310 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34338/tests/kraken/driver.html?testName=audio-beat-detection) 17:09:02 INFO - PROCESS | 31310 | RSS: Main: 176979968 17:09:02 INFO - PROCESS | 31310 | 17:09:05 INFO - PROCESS | 31310 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34338/tests/kraken/driver.html?testName=audio-dft) 17:09:06 INFO - PROCESS | 31310 | RSS: Main: 175775744 17:09:06 INFO - PROCESS | 31310 | 17:09:08 INFO - PROCESS | 31310 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34338/tests/kraken/driver.html?testName=audio-fft) 17:09:09 INFO - PROCESS | 31310 | RSS: Main: 173297664 17:09:09 INFO - PROCESS | 31310 | 17:09:11 INFO - PROCESS | 31310 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34338/tests/kraken/driver.html?testName=audio-oscillator) 17:09:12 INFO - PROCESS | 31310 | RSS: Main: 173088768 17:09:12 INFO - PROCESS | 31310 | 17:09:14 INFO - PROCESS | 31310 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34338/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:09:14 INFO - PROCESS | 31310 | RSS: Main: 170598400 17:09:14 INFO - PROCESS | 31310 | 17:09:17 INFO - PROCESS | 31310 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34338/tests/kraken/driver.html?testName=imaging-darkroom) 17:09:18 INFO - PROCESS | 31310 | RSS: Main: 170856448 17:09:18 INFO - PROCESS | 31310 | 17:09:21 INFO - PROCESS | 31310 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34338/tests/kraken/driver.html?testName=imaging-desaturate) 17:09:22 INFO - PROCESS | 31310 | RSS: Main: 171884544 17:09:22 INFO - PROCESS | 31310 | 17:09:25 INFO - PROCESS | 31310 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34338/tests/kraken/driver.html?testName=json-parse-financial) 17:09:25 INFO - PROCESS | 31310 | RSS: Main: 171704320 17:09:25 INFO - PROCESS | 31310 | 17:09:27 INFO - PROCESS | 31310 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34338/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:09:27 INFO - PROCESS | 31310 | RSS: Main: 176709632 17:09:27 INFO - PROCESS | 31310 | 17:09:29 INFO - PROCESS | 31310 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:09:30 INFO - PROCESS | 31310 | RSS: Main: 175788032 17:09:30 INFO - PROCESS | 31310 | 17:09:32 INFO - PROCESS | 31310 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:09:32 INFO - PROCESS | 31310 | RSS: Main: 180862976 17:09:32 INFO - PROCESS | 31310 | 17:09:35 INFO - PROCESS | 31310 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:09:35 INFO - PROCESS | 31310 | RSS: Main: 187195392 17:09:35 INFO - PROCESS | 31310 | 17:09:38 INFO - PROCESS | 31310 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:09:38 INFO - PROCESS | 31310 | RSS: Main: 185626624 17:09:38 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34338/tests/kraken/driver.html?testName=ai-astar) 17:09:40 INFO - PROCESS | 31310 | RSS: Main: 247955456 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | __start_tp_report 17:09:40 INFO - PROCESS | 31310 | _x_x_mozilla_page_load 17:09:40 INFO - PROCESS | 31310 | _x_x_mozilla_page_load_details 17:09:40 INFO - PROCESS | 31310 | |i|pagename|runs| 17:09:40 INFO - PROCESS | 31310 | |0;ai-astar;112;110;104;109;111;110;99;110;112;108 17:09:40 INFO - PROCESS | 31310 | |1;audio-beat-detection;154;135;153;175;127;157;165;128;195;129 17:09:40 INFO - PROCESS | 31310 | |2;audio-dft;161;163;161;162;162;161;161;165;161;161 17:09:40 INFO - PROCESS | 31310 | |3;audio-fft;77;74;76;166;78;76;76;75;163;75 17:09:40 INFO - PROCESS | 31310 | |4;audio-oscillator;93;93;149;93;93;94;154;92;93;149 17:09:40 INFO - PROCESS | 31310 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 17:09:40 INFO - PROCESS | 31310 | |6;imaging-darkroom;146;146;145;145;146;146;146;147;147;148 17:09:40 INFO - PROCESS | 31310 | |7;imaging-desaturate;95;95;96;95;96;95;95;96;95;96 17:09:40 INFO - PROCESS | 31310 | |8;json-parse-financial;54;53;53;55;54;54;54;64;52;52 17:09:40 INFO - PROCESS | 31310 | |9;json-stringify-tinderbox;65;66;65;65;66;66;66;66;67;66 17:09:40 INFO - PROCESS | 31310 | |10;stanford-crypto-aes;78;79;78;77;79;79;77;78;78;78 17:09:40 INFO - PROCESS | 31310 | |11;stanford-crypto-ccm;113;119;116;111;119;114;119;113;123;113 17:09:40 INFO - PROCESS | 31310 | |12;stanford-crypto-pbkdf2;140;145;137;144;154;141;144;139;143;149 17:09:40 INFO - PROCESS | 31310 | |13;stanford-crypto-sha256-iterative;70;72;69;70;67;67;67;69;69;67 17:09:40 INFO - PROCESS | 31310 | __end_tp_report 17:09:40 INFO - PROCESS | 31310 | __start_cc_report 17:09:40 INFO - PROCESS | 31310 | _x_x_mozilla_cycle_collect,1061 17:09:40 INFO - PROCESS | 31310 | __end_cc_report 17:09:40 INFO - PROCESS | 31310 | __startTimestamp1461370180865__endTimestamp 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | ------- Summary: start ------- 17:09:40 INFO - PROCESS | 31310 | Number of tests: 14 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.50 stddev:4.06 (3.7%) stddev-sans-first:4.11 17:09:40 INFO - PROCESS | 31310 | Values: 112.0 110.0 104.0 109.0 111.0 110.0 99.0 110.0 112.0 108.0 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:155.50 stddev:22.60 (14.5%) stddev-sans-first:23.95 17:09:40 INFO - PROCESS | 31310 | Values: 154.0 135.0 153.0 175.0 127.0 157.0 165.0 128.0 195.0 129.0 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | [#2] audio-dft Cycles:10 Average:161.80 Median:161.50 stddev:1.32 (0.8%) stddev-sans-first:1.36 17:09:40 INFO - PROCESS | 31310 | Values: 161.0 163.0 161.0 162.0 162.0 161.0 161.0 165.0 161.0 161.0 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:37.39 (49.2%) stddev-sans-first:39.17 17:09:40 INFO - PROCESS | 31310 | Values: 77.0 74.0 76.0 166.0 78.0 76.0 76.0 75.0 163.0 75.0 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:93.00 stddev:27.89 (30.0%) stddev-sans-first:28.87 17:09:40 INFO - PROCESS | 31310 | Values: 93.0 93.0 149.0 93.0 93.0 94.0 154.0 92.0 93.0 149.0 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:09:40 INFO - PROCESS | 31310 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 17:09:40 INFO - PROCESS | 31310 | Values: 146.0 146.0 145.0 145.0 146.0 146.0 146.0 147.0 147.0 148.0 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:09:40 INFO - PROCESS | 31310 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:3.47 (6.4%) stddev-sans-first:3.68 17:09:40 INFO - PROCESS | 31310 | Values: 54.0 53.0 53.0 55.0 54.0 54.0 54.0 64.0 52.0 52.0 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 17:09:40 INFO - PROCESS | 31310 | Values: 65.0 66.0 65.0 65.0 66.0 66.0 66.0 66.0 67.0 66.0 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 17:09:40 INFO - PROCESS | 31310 | Values: 78.0 79.0 78.0 77.0 79.0 79.0 77.0 78.0 78.0 78.0 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:117.50 stddev:3.83 (3.3%) stddev-sans-first:3.91 17:09:40 INFO - PROCESS | 31310 | Values: 113.0 119.0 116.0 111.0 119.0 114.0 119.0 113.0 123.0 113.0 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.60 Median:144.00 stddev:4.99 (3.5%) stddev-sans-first:5.12 17:09:40 INFO - PROCESS | 31310 | Values: 140.0 145.0 137.0 144.0 154.0 141.0 144.0 139.0 143.0 149.0 17:09:40 INFO - PROCESS | 31310 | 17:09:40 INFO - PROCESS | 31310 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.70 (2.5%) stddev-sans-first:1.74 17:09:40 INFO - PROCESS | 31310 | Values: 70.0 72.0 69.0 70.0 67.0 67.0 67.0 69.0 69.0 67.0 17:09:40 INFO - PROCESS | 31310 | -------- Summary: end -------- 17:09:40 INFO - PROCESS | 31310 | 17:09:41 INFO - TEST-INFO | 31310: exit 0 17:09:41 INFO - TEST-OK | kraken | took 60309ms 17:09:41 INFO - SUITE-END | took 1172s 17:09:42 INFO - Completed test suite (00:19:32) 17:09:42 INFO - javascript benchmark 17:09:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3326.118578576677, 3412.488126780984, 3425.6231814500416, 3429.108431807731, 3465.6361082086373, 5504.284443022407, 5505.614606977513, 5515.972420137904, 5516.806911758089, 5543.501084902358, 5511.366192887809, 5526.58550608705, 5529.087700529418, 5537.972310138453, 5544.77820887164, 4896.387951506062, 5020.92468612972, 5035.370578677665, 5093.185090385539, 5131.7690703918415, 4951.876203094916, 4975.427825800025, 5027.245913113025, 5033.697978121306, 5039.622028347871, 5059.747012649371, 5154.433012368637, 5157.948420515784, 5160.509751573594, 5173.87065323368, 4975.676581022222, 5023.547880690755, 5036.546710796028, 5047.394312682502, 5092.13433716271, 4785.688930219525, 5048.873778155576, 5066.290719299301, 5070.645054846163, 5105.872353191163, 5365.570754339644, 5429.0227759003365, 5435.10320797068, 5453.945460545384, 5461.808836690697, 5896.0, 5900.586958912878, 5907.1434641976675, 5911.0, 5912.733926973297, 5824.184614154022, 5903.350631430582, 5919.496842768327, 5932.0508718604815, 5941.673207973603, 5505.697186654733, 5513.117901135799, 5519.641223320471, 5523.392426833045, 5543.584231182637, 6041.0, 6042.184305118841, 6057.061155520902, 6060.818175454743, 6065.4541091302, 5777.364489906107, 5795.710214489259, 5828.184054232411, 5891.941080589139, 5962.731677074542, 5949.970250148722, 5955.672438015864, 5962.880742385215, 5965.373635768268, 5970.462658360769, 5910.261217347832, 5916.615419997686, 5919.733611987471, 5924.703764811742, 5925.614835035795, 5727.599068065196, 5759.798407055733, 5894.086416605433, 5907.556933230025, 5914.4381283777975, 4489.34904438861, 4527.071950250191, 4540.228161212602, 4541.954580454153, 4547.8635640930825, 4096.078382364004, 4104.507459104927, 4118.217538667644, 4126.731762435432, 4143.917121657611, 5429.755660995264, 5672.489475947102, 5760.798372056958, 5768.826935191951, 5773.509251713652, 5935.0503919372695, 5996.340402555716, 6001.2498437695285, 6005.099235114681, 6008.429199226067, 5630.521405680481, 5672.035753921843, 5674.744636491368, 5678.716064196857, 5682.318121825408, 4982.202847544376, 5069.873253168626, 5144.794208231704, 5146.897062058738, 5169.121249387613, 6088.634681919099, 6105.267367915879, 6117.0, 6118.816435506942, 6120.510359171256, 5822.0684690449325, 5910.940890591039, 5917.37867523921, 5922.466977972003, 5927.407259274038, 6141.9385806143155, 6159.1377207190135, 6203.7828675996125, 6204.317525072148, 6209.472194863487, 5833.591648584558, 5866.208061911588, 5872.207252021093, 5904.996150654485, 5930.525557955267, 5607.74765135578, 5890.646561206341, 5925.111233315038, 5932.970335148297, 5938.881222375615, 5753.223314852608, 5758.712064396847, 5771.047777116729, 5789.8263052108505, 5821.476067153807, 5767.884642307215, 5777.364489906023, 5779.133130030529, 5779.248697669276, 5785.4214578541805, 5566.805161819317, 5681.744321505625, 5693.032184528723, 5705.686187259741, 5788.7395067222915, 5742.052561327334, 5766.711664416678, 5842.1820945068575, 5878.030125029493, 5913.881722365614, 5715.31416230055, 5716.342620598684, 5719.799807006735, 5722.084466485342, 5737.512311453574], "unit": "score", "name": "dojo.html", "value": 5474.584324435339}, {"lowerIsBetter": false, "replicates": [572.4075581772865, 579.3916387792818, 592.4758485830193, 594.991489425424, 596.8209537138857, 31436.371272574535, 32263.83868080662, 40280.19439611206, 41085.38371924424, 41154.176916461656, 43901.0, 44127.77936110315, 44508.55491445085, 44532.0, 44589.55410445895, 7468.55188688679, 7531.284527969834, 7569.507981981181, 8005.6797728090805, 10420.374777513336, 10583.047525722683, 10739.946300268488, 10740.03339699427, 10742.892571074268, 10746.677599671983, 10746.785064298709, 10857.45712714365, 10858.891411085906, 10867.619633312836, 10872.945635271813, 10672.733181670443, 10732.409717465536, 10735.516901739402, 10760.300580462284, 10762.677119686421, 10558.1025612823, 10696.304740191863, 10705.946470267676, 10707.892921070768, 10948.616798412017, 44196.779016104716, 44489.55510444887, 44577.0, 44607.77696111531, 44630.10739785186, 3381.560397148355, 3502.842372093262, 3565.4295312749837, 3587.3901436755814, 3828.483154774098, 33454.33091338184, 33482.33035339304, 33647.49528757071, 33786.662133378595, 33827.0, 3779.8866034019024, 3836.75061121029, 3896.0, 3944.9408258876138, 3953.0710283083454, 217175.0, 218476.0, 219069.0, 219241.0, 220045.0, 45735.313970290474, 47120.5287947123, 47209.0, 47265.76367118143, 67828.6608566954, 45251.54748452539, 45411.77294113508, 45444.545554544035, 45449.772751136035, 45457.31814022792, 14519.637009074857, 14584.708305833823, 14675.77986330206, 14676.192809395585, 14690.779638305434, 9581.904180958101, 11841.703957400961, 12284.631461056004, 12286.262824230575, 12293.631191064282, 15195.544133676007, 15327.693446131016, 15494.922525387301, 15735.370585176694, 15864.60338491547, 5983.760649574056, 5991.5206783457215, 6006.669633170218, 6029.155918171459, 6249.78125765596, 1119.8040342940117, 1136.5624234669713, 1142.7600203957095, 1162.831389448542, 1219.2562536852513, 29444.263893402836, 29671.851640741657, 29741.0, 30250.24374390658, 30336.393272134435, 1129.3788416371128, 1136.3977092141179, 1208.8126340417073, 1220.6460126563375, 1232.9136960412864, 15542.611434713996, 15575.81688903091, 15599.0, 15853.920730396274, 15977.840221597868, 350922.0, 354540.0, 355057.0, 355237.0, 355942.0, 56780.71609641925, 56871.43128568744, 57382.0, 57385.426145738005, 57469.13796293059, 1213.247786372437, 1295.8963282937343, 1451.484722923368, 1461.1452300404383, 1466.5746933389412, 27278.454430910875, 27727.58408623832, 28013.299667508476, 28078.157655270374, 28199.0, 43499.34750978675, 43530.78234608807, 43593.0, 43895.34156987584, 43941.78029109834, 193233.0, 194954.0, 195196.0, 195531.0, 298740.0, 34259.14352141217, 34633.307333853685, 35008.0, 35043.82478087593, 35047.64952350444, 41162.176756465306, 42088.78955605203, 50096.49903501064, 51879.0, 52524.0, 38816.80591597024, 39089.80455097706, 39315.80342098271, 39407.0, 39529.407058893565, 38662.420063698504, 39518.802405987786, 39704.0, 39797.60202397939, 40591.594084059965, 39002.2199556013, 39523.40714889336, 39839.2032159361, 40132.79933600313, 40339.0, 33708.49437258394, 35713.46429803607, 36176.819115904254, 36830.63169368379, 36913.26173476569, 27164.728352716218, 27532.587011194446, 27686.72313276922, 27694.584581231702, 27764.0], "unit": "score", "name": "ext.html", "value": 18877.20160327882}, {"lowerIsBetter": false, "replicates": [376.668531692111, 388.32625394939777, 393.7342293951582, 398.75078076202374, 403.1010845813833, 16654.0, 19243.518912027208, 19409.22363105476, 19456.513587160327, 19513.219471221153, 16556.751648725247, 16766.916165419185, 17426.128693565333, 17465.0, 17468.388606398777, 5628.634138780976, 5772.076467765159, 5798.594098413113, 5809.448102430283, 5816.505597024258, 4265.466816647919, 6252.5935814171935, 6534.901976470357, 6545.312742162076, 6566.21205455346, 5550.47270509301, 6468.870622587546, 6486.708098135572, 6512.479001679854, 6515.934840651604, 5741.569382296324, 5762.9135562966585, 5771.769129234825, 5776.451237132465, 5783.045797443438, 3869.6517313441645, 5409.0, 5574.498295153415, 5576.498115169614, 5580.107182850725, 20797.792022079888, 21164.894175529178, 21235.044423001003, 21431.464213394633, 21443.46391340229, 2409.373562873648, 2459.360566252787, 2541.9110331138504, 2808.9578656320173, 2885.336372634285, 9989.150922171624, 10000.94999525005, 10240.89759102407, 10537.0, 10681.572737090508, 1844.9446516604523, 1875.3248830421037, 1891.6784146694956, 1918.5107797511685, 1980.7127966444784, 64986.0, 68077.0, 68341.0, 70176.0, 70327.94508082434, 9495.43027418357, 9754.95122524397, 9892.15916647093, 9906.851397229048, 10304.484775761182, 13278.601641950758, 13309.800352994713, 13311.933440332736, 13314.267715275753, 13326.133801302884, 7244.601546914971, 7366.0, 7460.29127232912, 7479.177290498041, 7545.094588649397, 7266.45501587383, 7290.125184977836, 7297.233790452032, 7339.669714862844, 7371.631418429057, 4122.587741225853, 4138.482689663792, 4142.896427589334, 4154.543000269968, 4295.506016808107, 1689.7972243330878, 1712.2722842791763, 1713.3917459302018, 1719.664665390237, 1768.6904791661407, 962.1869520255373, 1046.6980709284833, 1047.3297089862494, 1058.9682309530726, 1072.1208608940594, 16870.946629380644, 17223.483295501155, 17351.3059477622, 17862.0, 18324.26702931868, 987.8518222266574, 996.4170959988488, 1004.6634377483625, 1032.695354870315, 1098.6374496416163, 10256.179505639531, 10331.328463649988, 10391.220658450495, 10399.428031458192, 10432.113270371952, 343642.0, 347258.0, 418838.0, 421420.0, 425570.0, 68796.31203687999, 69193.0, 70098.64950675215, 71395.64302178456, 74858.25141748622, 1087.1140020882956, 1111.372074777748, 1115.7154925493946, 1119.7032786311634, 1120.5125770289949, 16199.352025919303, 16327.183640817673, 16365.754513682066, 16397.91801040987, 16820.243089060776, 34965.300693986486, 35256.64743352636, 36671.63328366682, 36819.26361472702, 36832.26335473329, 50670.74664626653, 51241.7437912808, 51379.2293115611, 51592.74203628958, 52061.21908171305, 8378.916210838057, 8564.400491965502, 8629.0, 8783.989841168348, 8940.821183576421, 8412.789680257798, 12315.076369272161, 12322.32227227511, 13138.211707297593, 13191.934040329737, 10367.844482332923, 10621.627023785975, 10785.0, 10818.026377625736, 10978.011978921935, 10861.294015888941, 11346.319220846775, 11426.657200284004, 11501.53993840237, 12027.338496382783, 10808.243422960632, 11130.610428634958, 11241.156913231376, 11285.097192224766, 11309.0, 8244.670213191404, 8315.168483151878, 8348.666053357798, 8630.309575233841, 8829.0, 10314.638987635397, 10622.946885265525, 10814.188935829687, 10913.454327283445, 11270.94364528172], "unit": "score", "name": "jquery.html", "value": 8726.780954730286}, {"lowerIsBetter": false, "replicates": [1318.9868101318984, 1578.4633224703603, 1599.2163839718537, 1861.6928206845862, 1966.4887129346366, 7656.081270247571, 8271.048829384623, 8414.537200453973, 8423.410361274713, 8431.578421078952, 8358.582070896446, 8538.91461085389, 8548.70079547216, 8554.786130346745, 8555.187257210571, 2126.2876936226385, 2403.771641694036, 2454.0919859651863, 2455.4475243070347, 2478.925632231027, 2475.084218839032, 2491.289982355029, 2500.4499010217723, 2506.223070848043, 2507.022261318078, 2465.9753402466013, 2483.627455881623, 2491.6885389326335, 2498.912538061159, 2500.2124330835727, 2415.2995631266913, 2441.7680320369536, 2443.5601591713485, 2444.2300675287315, 2444.5721998650256, 2390.6294524348755, 2412.746661600524, 2416.8187385946126, 2422.043292899295, 2437.7927876130375, 8703.086175951497, 8761.868571971425, 8762.912370876336, 8764.0, 8767.912320876838, 5111.05445492585, 5237.083510385705, 5240.030594340059, 5245.711485868275, 5248.842534723926, 3185.5062465317915, 3248.5289633003317, 3346.1634591352163, 3376.983115084409, 3381.830908454592, 1063.1760385701066, 1098.4672433869566, 1108.467935391017, 1116.0234794554765, 1173.3312012153076, 12287.262764234085, 12306.876931230663, 12337.074719396081, 12359.32023738694, 12372.8144077838, 4679.572730317218, 4778.5699287064335, 4803.975980120077, 4836.347093142451, 4841.975790121027, 10324.12244959172, 10368.792624147474, 10371.688849334532, 10381.169506439466, 10397.376157430579, 4713.6464765142755, 5241.0, 5281.577473802164, 5287.286216360819, 5293.311869456946, 4665.113628410591, 4744.098621261949, 4764.0471905619015, 4773.832915847928, 4785.904281914342, 4000.538054931402, 4047.514298284225, 4073.429719839225, 4081.428599996003, 4088.223237584909, 1306.8303868038054, 1308.463529952715, 1314.309987256698, 1326.1313839435186, 1336.3051213369188, 1200.9819852702217, 1211.927284362941, 1280.7182419867613, 1363.740889231043, 1484.7772834074974, 7867.685292588347, 7923.841523169504, 7977.7207797726805, 8039.155888631726, 8047.597620119088, 528.9576833853282, 531.3358302122347, 533.34398689612, 533.6157966264284, 534.4628648208526, 6065.787697430657, 6099.451049405575, 6106.145139680449, 6146.692665366714, 6151.108089327023, 10028.197744180594, 10293.125084367763, 10416.687499375032, 10430.947845260876, 10437.217208709226, 10025.097741203326, 10111.090001899864, 10150.0, 10246.180305575685, 10301.330413523097, 8031.959840200879, 8068.3948703847445, 8090.9595452021185, 8112.83774324522, 8135.145809689898, 8000.919990800017, 8038.598070096588, 8054.275115239657, 8144.633491493016, 8244.340452763885, 9324.347295689236, 9463.101005404476, 9478.289128315266, 9534.666286679932, 9574.090461406155, 9675.225981921289, 9834.606615735576, 9845.409275443497, 9874.851877221703, 10042.196624270187, 6547.541672082908, 7129.21578626361, 7494.063242094739, 7661.846763064596, 7779.688812447439, 8075.676972921017, 8097.595120244082, 8113.472624279403, 8143.022837259567, 8155.102938676622, 6784.084148640068, 6948.5483443576, 7016.403605693573, 7091.716331346895, 7175.31834475724, 7177.677004534913, 7186.496945213785, 7262.455315851226, 7319.158296795937, 7349.8162545936775, 7440.665170067252, 7803.258690424401, 7811.804704882196, 7815.804604884924, 7818.765437036898, 7176.354128128493, 7235.674394652148, 7266.1280646322775, 7269.818254543678, 7281.235470275757, 7170.0, 7232.63836808168, 7303.123625165014, 7371.778846634609, 7386.113666359856], "unit": "score", "name": "mootools.html", "value": 4813.557516394437}, {"lowerIsBetter": false, "replicates": [369.702389576391, 370.84239198340714, 375.1091158498566, 376.63090171631785, 384.35236626284694, 6063.514918806491, 6089.908651370233, 6104.450599446049, 6104.6947652617355, 6109.14471973924, 5971.253593300838, 6016.909746353808, 6024.216851809269, 6028.156058151862, 6033.456988871001, 4547.795349209294, 4604.907901841962, 4663.626909847204, 4709.175894218498, 4759.381280433556, 4699.953000469985, 4703.858884233478, 4729.385179926605, 4736.029114031615, 4738.620910327183, 4679.15775160471, 4682.321063445798, 4694.577488026077, 4695.741734204617, 4701.271302948048, 4492.236319825637, 4603.8618841434645, 4658.883527911796, 4677.812887484497, 4695.577398034194, 4182.602652747984, 4186.0581369192, 4194.412782210493, 4194.790260486994, 4199.118185181115, 5764.423557644244, 5775.768969241225, 5776.855578610568, 5778.0466223073145, 5779.0, 5494.5054945054735, 5495.203195536625, 5503.559715222773, 5503.697296648683, 5516.172574113915, 6378.489720822323, 6390.904136437957, 6399.776007839703, 6406.167198264243, 6411.3588641135975, 4407.27279998803, 4536.954630453686, 4539.682222244444, 4546.29532422475, 4658.906821863544, 6607.9669601651685, 6654.800355989328, 6661.26726060133, 6663.333666633346, 6686.5653732507235, 4632.62938964882, 4634.884127896829, 4640.79116439761, 4643.721376717408, 4644.396228490342, 4700.95299047012, 4701.48283688794, 4706.835260765857, 4706.905861882811, 4710.764461776897, 5392.838214853561, 5397.865053373697, 5402.540784033401, 5404.756785944642, 5418.322709661293, 6293.653849038255, 6416.903746443807, 6447.484201263887, 6453.096566480603, 6456.289808121103, 1630.2500849609075, 1650.1666658337463, 1656.4202529114955, 1656.4864891883315, 1657.1796960504387, 1039.9896001040045, 1084.5065495199665, 1096.3038470571084, 1098.8956049175315, 1115.576081089197, 6175.320714721377, 6187.102870083902, 6214.782482613177, 6215.875682486416, 6230.283517395467, 6565.80302590923, 6567.376099270562, 6572.441342485942, 6584.0, 6619.801405957829, 6181.536384771161, 6185.505159587222, 6187.659678717624, 6190.597611155261, 6192.566520343623, 3501.492283618912, 3556.05764472415, 3557.4663800429626, 3563.394222982099, 3566.411542095525, 6598.1422415085735, 6805.013273075377, 6808.38724514796, 6813.386795188457, 6816.931830681729, 6686.398224159751, 6709.36261055199, 6710.731570737116, 6727.9327206728285, 6731.49513786468, 6763.830904227434, 6765.086713293741, 6766.560173588602, 6769.559978601375, 6775.1531058617675, 6509.088727578048, 6522.184726909137, 6552.27924928248, 6563.540552161303, 6576.079348891255, 6330.240371155491, 6468.3855033771715, 6477.352264773485, 6477.643729594917, 6483.481321494363, 6645.60126392418, 6668.233153187445, 6695.598264104169, 6699.0621313015245, 6708.496862735412, 4489.461264648263, 4529.932051019171, 4554.521775213688, 4558.6581006423985, 4566.543345665407, 6463.7737679181, 6470.191226096738, 6471.935280647322, 6500.414962653194, 6527.5757075789925, 6240.438360547572, 6383.6169829808505, 6399.232092148972, 6400.103985441949, 6401.071844582416, 6360.618362898241, 6377.17096777416, 6382.234131904015, 6383.1382763326355, 6394.520410969289, 6215.875682486235, 6238.875222495434, 6240.063990401294, 6249.281332646804, 6331.461825744679, 6379.106925030406, 6409.2949775525585, 6418.871622567429, 6421.5825971311715, 6423.164988551458, 6113.205283313141, 6207.906881396692, 6245.28179259391, 6266.811995640138, 6364.936350636434], "unit": "score", "name": "prototype.html", "value": 4862.855131621176}, {"lowerIsBetter": false, "replicates": [659.1694464974132, 700.4536461559982, 721.877280862254, 789.8617741895167, 797.7447216890594, 12142.514299428023, 12262.93868530656, 12342.07434442416, 12343.444544995475, 12384.00927925766, 12299.32353720545, 12322.938385308062, 12377.56678516252, 12392.690182745413, 12397.876021239808, 754.8188434775642, 888.8133491966695, 890.2032680750724, 912.5574096563162, 918.3846822628822, 914.7347269291897, 924.8011677489338, 925.1673493855517, 925.255169588481, 925.5696101312889, 974.878140232471, 981.4503877828404, 984.4536282363285, 984.5077461269366, 985.581128020592, 807.0638059850545, 959.71688351936, 986.082942863137, 988.4909271725068, 991.3952488981752, 711.5552779512805, 714.3213946750608, 714.5605452646637, 714.8641758065951, 715.1918332284537, 12518.436670349856, 12523.812142817866, 12552.560660376934, 12555.183913045623, 12569.120161588693, 13142.145760525535, 13594.456221751117, 13657.0, 13700.974660809032, 13863.890888728878, 10827.458627068616, 11501.654950351503, 11591.942040289745, 11637.301761894314, 11644.0, 3744.606816284278, 3775.848966041355, 3788.6400791925, 3828.2343531293855, 3908.7068469864876, 49642.0, 50399.74800125976, 50651.74674126643, 50805.491945080816, 51881.7405912968, 9674.75813104664, 9675.951620241995, 9909.900900991042, 9992.850107248398, 10150.137238334677, 18450.815491845176, 18488.168032438574, 18506.167222475022, 18511.722324165148, 18519.44441666752, 7457.179710231871, 7475.102987641518, 7581.241875812375, 7627.275408836152, 7671.501352412075, 4298.76356800379, 4333.111712099012, 4340.696151269381, 4368.388425620416, 4396.956030439718, 3443.1564266754804, 3450.2236996675547, 3464.8614055438006, 3472.3576138414473, 3482.9477557836653, 572.4104172702123, 640.6508452893185, 663.5952069237761, 665.986680266392, 690.5304393012699, 521.8695326168458, 547.8712502561895, 551.5008916930185, 567.6225310168774, 595.5890435599423, 7663.27198916102, 8060.073091594541, 8070.878936815952, 8131.14622964592, 8221.54781487012, 487.3883276487985, 527.3408239700375, 531.4552583601762, 536.2974503400558, 567.330709014096, 3673.9632603674154, 3760.680342170946, 3789.7915614640906, 3794.506714127201, 3878.70909681775, 63041.36958630447, 63863.68068159722, 64519.677401612695, 64674.0, 65054.0, 54842.0, 55649.721751390985, 55912.0, 57567.0, 57741.422585774446, 50164.0, 51115.233271500954, 51175.48824511707, 51885.740571296905, 52022.739886300325, 7581.545107293359, 7590.544567325757, 7593.734219302298, 7811.570363630055, 7849.803754906173, 36005.63994360023, 38271.234575308896, 38351.616483834805, 39362.60637393704, 39366.40950385689, 45232.54767452284, 45290.09419811519, 51405.0, 51641.0, 52256.0, 10595.682129536126, 11002.50488728025, 11309.943450282695, 11371.488283027118, 11511.597094101666, 11665.066794656577, 11705.824412633647, 11844.822327664919, 11910.404479776149, 12105.576304829288, 11464.140189485655, 11811.763764724485, 11894.0, 11897.702557435787, 12030.27818330903, 10691.09125724322, 11228.382438965935, 11393.316401015965, 11576.363300018244, 11716.472758725708, 10987.121030317396, 11231.4384280784, 11321.0, 11458.369789661649, 11579.768404632028, 9524.761880953032, 9612.51937403141, 9715.805683886425, 9794.559244834141, 9801.411915285105, 9803.215742740706, 9989.400635961865, 10069.546870390997, 10102.191824654157, 10116.949415252877], "unit": "score", "name": "yui.html", "value": 6453.85728728753}], "name": "dromaeo_css", "value": 7173.413945160166}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 104.0, 109.0, 111.0, 110.0, 99.0, 110.0, 112.0, 108.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [154.0, 135.0, 153.0, 175.0, 127.0, 157.0, 165.0, 128.0, 195.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 151.8}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 161.0, 162.0, 162.0, 161.0, 161.0, 165.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [77.0, 74.0, 76.0, 166.0, 78.0, 76.0, 76.0, 75.0, 163.0, 75.0], "unit": "score", "name": "audio-fft", "value": 93.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 149.0, 93.0, 93.0, 94.0, 154.0, 92.0, 93.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 110.3}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [54.0, 53.0, 53.0, 55.0, 54.0, 54.0, 54.0, 64.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.5}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.8}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 78.0, 77.0, 79.0, 79.0, 77.0, 78.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.1}, {"lowerIsBetter": true, "replicates": [113.0, 119.0, 116.0, 111.0, 119.0, 114.0, 119.0, 113.0, 123.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.0}, {"lowerIsBetter": true, "replicates": [140.0, 145.0, 137.0, 144.0, 154.0, 141.0, 144.0, 139.0, 143.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.6}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 69.0, 70.0, 67.0, 67.0, 67.0, 69.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1511.2999999999997}]} 17:09:42 INFO - Return code: 0 17:09:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:09:42 INFO - # TBPL SUCCESS # 17:09:42 INFO - Running post-action listener: _resource_record_post_action 17:09:42 INFO - Running post-run listener: _resource_record_post_run 17:09:43 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 278528; Write bytes: 508940288; Read time: 48; Write time: 560868 17:09:43 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 257126400; Read time: 0; Write time: 347060 17:09:43 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 278528; Write bytes: 251813888; Read time: 48; Write time: 213808 17:09:43 INFO - Running post-run listener: _upload_blobber_files 17:09:43 INFO - Blob upload gear active. 17:09:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:09:43 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 17:09:43 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'] 17:09:43 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 17:09:43 INFO - (blobuploader) - INFO - Open directory for files ... 17:09:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:09:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:09:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:44 INFO - (blobuploader) - INFO - Done attempting. 17:09:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:09:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:09:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:45 INFO - (blobuploader) - INFO - Done attempting. 17:09:45 INFO - (blobuploader) - INFO - Iteration through files over. 17:09:45 INFO - Return code: 0 17:09:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:09:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:09:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f5121158dc9858155b6cb56e687c3cc7fe42212611d65742869f3a6a69ce3a428bae96ee3edee0bbf32c4fc2510edd1667b6939927a83633d24949d79fd2a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18028d7fa8ca2f32adad5946574ad047547ad3ac579bbe8c574632e848af2430978c2db7513f0b199680ebaa2684c7fc565821d415b04f463a339ed260e14b57"} 17:09:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:09:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:09:45 INFO - Contents: 17:09:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f5121158dc9858155b6cb56e687c3cc7fe42212611d65742869f3a6a69ce3a428bae96ee3edee0bbf32c4fc2510edd1667b6939927a83633d24949d79fd2a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18028d7fa8ca2f32adad5946574ad047547ad3ac579bbe8c574632e848af2430978c2db7513f0b199680ebaa2684c7fc565821d415b04f463a339ed260e14b57"} 17:09:45 INFO - Running post-run listener: copy_logs_to_upload_dir 17:09:45 INFO - Copying logs to upload dir... 17:09:45 INFO - mkdir: /builds/slave/test/build/upload/logs 17:09:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.839242 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-22 17:09:45.072660) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 17:09:45.076602) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177 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/9f5121158dc9858155b6cb56e687c3cc7fe42212611d65742869f3a6a69ce3a428bae96ee3edee0bbf32c4fc2510edd1667b6939927a83633d24949d79fd2a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18028d7fa8ca2f32adad5946574ad047547ad3ac579bbe8c574632e848af2430978c2db7513f0b199680ebaa2684c7fc565821d415b04f463a339ed260e14b57"} build_url:https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/eHKzFv2nSyORjclhwjK4_g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f5121158dc9858155b6cb56e687c3cc7fe42212611d65742869f3a6a69ce3a428bae96ee3edee0bbf32c4fc2510edd1667b6939927a83633d24949d79fd2a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18028d7fa8ca2f32adad5946574ad047547ad3ac579bbe8c574632e848af2430978c2db7513f0b199680ebaa2684c7fc565821d415b04f463a339ed260e14b57"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 17:09:45.108358) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:09:45.108969) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1461367768.4694-819944177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:09:45.189072) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 17:09:45.189472) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 17:09:45.189964) ========= ========= Total master_lag: 0.17 =========