builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1464777614.3 results: success (0) buildid: 20160601004014 builduid: 02b1f90cad29446e8d71fc80e09721a5 revision: 3cc4a98864ad31001292b38c97df30962b9e94d0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 03:40:14.300063) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 03:40:14.300510) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 03:40:14.300801) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 03:40:14.315439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 03:40:14.316541) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 03:40:15-- 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% 69.7M=0s 2016-06-01 03:40:15 (69.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078642 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 03:40:14.408962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 03:40:14.409306) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016589 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 03:40:14.459642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 03:40:14.460027) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3cc4a98864ad31001292b38c97df30962b9e94d0 --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 3cc4a98864ad31001292b38c97df30962b9e94d0 --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=6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 03:40:15,230 truncating revision to first 12 chars 2016-06-01 03:40:15,230 Setting DEBUG logging. 2016-06-01 03:40:15,230 attempt 1/10 2016-06-01 03:40:15,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3cc4a98864ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 03:40:15,986 unpacking tar archive at: mozilla-aurora-3cc4a98864ad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.179765 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 03:40:15.653807) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 03:40:15.654233) ========= script_repo_revision: 3cc4a98864ad31001292b38c97df30962b9e94d0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 03:40:15.654670) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 03:40:15.654970) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 03:40:15.661841) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-01 03:40:15.662140) ========= /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=6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:40:16 INFO - MultiFileLogger online at 20160601 03:40:16 in /builds/slave/test 03:40:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:40:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:40:16 INFO - {'append_to_log': False, 03:40:16 INFO - 'base_work_dir': '/builds/slave/test', 03:40:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:40:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:40:16 INFO - 'branch': 'Mozilla-Aurora', 03:40:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:40:16 INFO - 'config_files': ('talos/linux_config.py',), 03:40:16 INFO - 'default_actions': ('clobber', 03:40:16 INFO - 'read-buildbot-config', 03:40:16 INFO - 'download-and-extract', 03:40:16 INFO - 'populate-webroot', 03:40:16 INFO - 'create-virtualenv', 03:40:16 INFO - 'install', 03:40:16 INFO - 'run-tests'), 03:40:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:40:16 INFO - 'download_minidump_stackwalk': True, 03:40:16 INFO - 'download_symbols': 'ondemand', 03:40:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:40:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:40:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:40:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:40:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:40:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:40:16 INFO - 'installer_path': 'installer.exe', 03:40:16 INFO - 'log_level': 'info', 03:40:16 INFO - 'log_name': 'talos', 03:40:16 INFO - 'log_to_console': True, 03:40:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:40:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:40:16 INFO - 'opt_config_files': (), 03:40:16 INFO - 'pip_index': False, 03:40:16 INFO - 'sps_profile': False, 03:40:16 INFO - 'sps_profile_interval': 0, 03:40:16 INFO - 'suite': 'dromaeojs', 03:40:16 INFO - 'system_bits': '32', 03:40:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:40:16 INFO - 'title': 'talos-linux64-ix-023', 03:40:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:40:16 INFO - 'use_talos_json': True, 03:40:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:40:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:40:16 INFO - 'work_dir': 'build'} 03:40:16 INFO - ##### 03:40:16 INFO - ##### Running clobber step. 03:40:16 INFO - ##### 03:40:16 INFO - Running pre-action listener: _resource_record_pre_action 03:40:16 INFO - Running main action method: clobber 03:40:16 INFO - rmtree: /builds/slave/test/build 03:40:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:40:16 INFO - Running post-action listener: _resource_record_post_action 03:40:16 INFO - ##### 03:40:16 INFO - ##### Running read-buildbot-config step. 03:40:16 INFO - ##### 03:40:16 INFO - Running pre-action listener: _resource_record_pre_action 03:40:16 INFO - Running main action method: read_buildbot_config 03:40:16 INFO - Using buildbot properties: 03:40:16 INFO - { 03:40:16 INFO - "project": "", 03:40:16 INFO - "product": "firefox", 03:40:16 INFO - "script_repo_revision": "production", 03:40:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:40:16 INFO - "repository": "", 03:40:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:40:16 INFO - "buildid": "20160601004014", 03:40:16 INFO - "stage_platform": "linux64-pgo", 03:40:16 INFO - "basedir": "/builds/slave/test", 03:40:16 INFO - "nightly_build": "True", 03:40:16 INFO - "buildnumber": 541, 03:40:16 INFO - "slavename": "talos-linux64-ix-023", 03:40:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:40:16 INFO - "platform": "ubuntu64_hw", 03:40:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:40:16 INFO - "branch": "mozilla-aurora", 03:40:16 INFO - "repo_path": "releases/mozilla-aurora", 03:40:16 INFO - "revision": "3cc4a98864ad31001292b38c97df30962b9e94d0", 03:40:16 INFO - "pgo_build": "True", 03:40:16 INFO - "builduid": "02b1f90cad29446e8d71fc80e09721a5", 03:40:16 INFO - "slavebuilddir": "test" 03:40:16 INFO - } 03:40:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:40:16 INFO - Running post-action listener: _resource_record_post_action 03:40:16 INFO - ##### 03:40:16 INFO - ##### Running download-and-extract step. 03:40:16 INFO - ##### 03:40:16 INFO - Running pre-action listener: _resource_record_pre_action 03:40:16 INFO - Running main action method: download_and_extract 03:40:16 INFO - mkdir: /builds/slave/test/build/tests 03:40: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')]} 03:40:16 INFO - https://queue.taskcluster.net/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:40:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:40:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:40:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:40:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:40:17 INFO - Downloaded 1361 bytes. 03:40:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:40:17 INFO - Using the following test package requirements: 03:40:17 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:40:17 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:17 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:40:17 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:17 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:40:17 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:17 INFO - u'jsshell-linux-x86_64.zip'], 03:40:17 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:17 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:40:17 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:40:17 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:17 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:40:17 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:17 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:40:17 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:17 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:40:17 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:17 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:40:17 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:17 INFO - https://queue.taskcluster.net/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:40:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:40:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:40:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:40:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:40:18 INFO - Downloaded 24174964 bytes. 03:40:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:40:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:40:20 INFO - Return code: 0 03:40:20 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:40: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')]} 03:40:20 INFO - https://queue.taskcluster.net/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:40:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:40:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:40:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:40:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:40:21 INFO - Downloaded 24174964 bytes. 03:40:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:40:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:40:22 INFO - Return code: 0 03:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:22 INFO - https://queue.taskcluster.net/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:40:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:40:23 INFO - Downloaded 10840145 bytes. 03:40:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:40:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:40:23 INFO - Return code: 0 03:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:23 INFO - https://queue.taskcluster.net/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:40:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:40:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:40:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:40:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:40:25 INFO - Downloaded 62803165 bytes. 03:40:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:40:25 INFO - mkdir: /builds/slave/test/properties 03:40:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:40:25 INFO - Writing to file /builds/slave/test/properties/build_url 03:40:25 INFO - Contents: 03:40:25 INFO - build_url:https://queue.taskcluster.net/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:40:26 INFO - Running post-action listener: _resource_record_post_action 03:40:26 INFO - Running post-action listener: set_extra_try_arguments 03:40:26 INFO - ##### 03:40:26 INFO - ##### Running populate-webroot step. 03:40:26 INFO - ##### 03:40:26 INFO - Running pre-action listener: _resource_record_pre_action 03:40:26 INFO - Running main action method: populate_webroot 03:40:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:40:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:40:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:40:26 INFO - '--tppagecycles', 03:40:26 INFO - '7'], 03:40:26 INFO - 'tests': ['tsvgm']}}, 03:40:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:40:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:40:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:40:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:40:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:40:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:40:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:26 INFO - 'talos_options': ['--disable-e10s'], 03:40:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:26 INFO - 'talos_options': ['--disable-e10s'], 03:40:26 INFO - 'tests': ['damp', 'tps']}, 03:40:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:26 INFO - 'tests': ['damp', 'tps']}, 03:40:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:40:26 INFO - 'tests': ['dromaeo_dom']}, 03:40:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:40:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:40:26 INFO - 'tests': ['a11yr', 03:40:26 INFO - 'ts_paint', 03:40:26 INFO - 'tpaint', 03:40:26 INFO - 'sessionrestore', 03:40:26 INFO - 'sessionrestore_no_auto_restore', 03:40:26 INFO - 'tabpaint']}, 03:40:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:40:26 INFO - 'ts_paint', 03:40:26 INFO - 'tpaint', 03:40:26 INFO - 'sessionrestore', 03:40:26 INFO - 'sessionrestore_no_auto_restore', 03:40:26 INFO - 'tabpaint']}, 03:40:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:40:26 INFO - 'ts_paint', 03:40:26 INFO - 'tpaint', 03:40:26 INFO - 'sessionrestore', 03:40:26 INFO - 'sessionrestore_no_auto_restore', 03:40:26 INFO - 'tabpaint']}, 03:40:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:40:26 INFO - 'ts_paint', 03:40:26 INFO - 'tpaint', 03:40:26 INFO - 'sessionrestore', 03:40:26 INFO - 'sessionrestore_no_auto_restore', 03:40:26 INFO - 'tabpaint']}, 03:40:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:40:26 INFO - 'tests': ['a11yr', 03:40:26 INFO - 'ts_paint', 03:40:26 INFO - 'tpaint', 03:40:26 INFO - 'sessionrestore', 03:40:26 INFO - 'sessionrestore_no_auto_restore', 03:40:26 INFO - 'tabpaint']}, 03:40:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:40:26 INFO - 'tests': ['a11yr', 03:40:26 INFO - 'ts_paint', 03:40:26 INFO - 'tpaint', 03:40:26 INFO - 'sessionrestore', 03:40:26 INFO - 'sessionrestore_no_auto_restore', 03:40:26 INFO - 'tabpaint']}, 03:40:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:40:26 INFO - 'tests': ['tsvgx', 03:40:26 INFO - 'tsvgr_opacity', 03:40:26 INFO - 'tart', 03:40:26 INFO - 'tscrollx', 03:40:26 INFO - 'cart']}, 03:40:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:40:26 INFO - 'tsvgr_opacity', 03:40:26 INFO - 'tart', 03:40:26 INFO - 'tscrollx', 03:40:26 INFO - 'cart']}, 03:40:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:26 INFO - 'talos_options': ['--disable-e10s'], 03:40:26 INFO - 'tests': ['tp5o']}, 03:40:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:26 INFO - 'tests': ['tp5o']}, 03:40:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:26 INFO - 'talos_options': ['--disable-e10s', 03:40:26 INFO - '--xperf_path', 03:40:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:26 INFO - 'tests': ['tp5n']}, 03:40:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:26 INFO - 'talos_options': ['--xperf_path', 03:40:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:26 INFO - 'tests': ['tp5n']}}, 03:40:26 INFO - 'talos.zip': {'path': '', 03:40:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:40:26 INFO - Running post-action listener: _resource_record_post_action 03:40:26 INFO - ##### 03:40:26 INFO - ##### Running create-virtualenv step. 03:40:26 INFO - ##### 03:40:26 INFO - Running pre-action listener: _resource_record_pre_action 03:40:26 INFO - Running main action method: create_virtualenv 03:40:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:40:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:40:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:40:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:40:26 INFO - Using real prefix '/usr' 03:40:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:40:26 INFO - Installing distribute.............................................................................................................................................................................................done. 03:40:28 INFO - Installing pip.................done. 03:40:28 INFO - Return code: 0 03:40:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f908e584f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80410>, '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 0x1e81310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e817a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:40:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:40:28 INFO - Using env: {'DISPLAY': ':0', 03:40:28 INFO - 'HOME': '/home/cltbld', 03:40:28 INFO - 'LANG': 'en_US.UTF-8', 03:40:28 INFO - 'LANGUAGE': 'en_US:en', 03:40:28 INFO - 'LOGNAME': 'cltbld', 03:40:28 INFO - 'MAIL': '/var/mail/cltbld', 03:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:28 INFO - 'MOZ_NO_REMOTE': '1', 03:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:28 INFO - 'NO_EM_RESTART': '1', 03:40:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:28 INFO - 'PWD': '/builds/slave/test', 03:40:28 INFO - 'SHELL': '/bin/bash', 03:40:28 INFO - 'SHLVL': '1', 03:40:28 INFO - 'TERM': 'linux', 03:40:28 INFO - 'TMOUT': '86400', 03:40:28 INFO - 'USER': 'cltbld', 03:40:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 03:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:28 INFO - '_': '/tools/buildbot/bin/python'} 03:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:40:29 INFO - Cleaning up... 03:40:29 INFO - Return code: 0 03:40:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:29 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 0x7f908e584f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80410>, '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 0x1e81310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e817a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:40:29 INFO - Using env: {'DISPLAY': ':0', 03:40:29 INFO - 'HOME': '/home/cltbld', 03:40:29 INFO - 'LANG': 'en_US.UTF-8', 03:40:29 INFO - 'LANGUAGE': 'en_US:en', 03:40:29 INFO - 'LOGNAME': 'cltbld', 03:40:29 INFO - 'MAIL': '/var/mail/cltbld', 03:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:29 INFO - 'MOZ_NO_REMOTE': '1', 03:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:29 INFO - 'NO_EM_RESTART': '1', 03:40:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:29 INFO - 'PWD': '/builds/slave/test', 03:40:29 INFO - 'SHELL': '/bin/bash', 03:40:29 INFO - 'SHLVL': '1', 03:40:29 INFO - 'TERM': 'linux', 03:40:29 INFO - 'TMOUT': '86400', 03:40:29 INFO - 'USER': 'cltbld', 03:40:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 03:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:29 INFO - '_': '/tools/buildbot/bin/python'} 03:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:29 INFO - Downloading/unpacking psutil>=0.7.1 03:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:40:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:31 INFO - Installing collected packages: psutil 03:40:31 INFO - Running setup.py install for psutil 03:40:31 INFO - building 'psutil._psutil_linux' extension 03:40:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:40:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:40:31 INFO - building 'psutil._psutil_posix' extension 03:40:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:40:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:40:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:31 INFO - Successfully installed psutil 03:40:31 INFO - Cleaning up... 03:40:31 INFO - Return code: 0 03:40:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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', '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 0x7f908e584f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80410>, '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 0x1e81310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e817a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:40: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 mozsystemmonitor==0.0.0 03:40:31 INFO - Using env: {'DISPLAY': ':0', 03:40:31 INFO - 'HOME': '/home/cltbld', 03:40:31 INFO - 'LANG': 'en_US.UTF-8', 03:40:31 INFO - 'LANGUAGE': 'en_US:en', 03:40:31 INFO - 'LOGNAME': 'cltbld', 03:40:31 INFO - 'MAIL': '/var/mail/cltbld', 03:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:31 INFO - 'MOZ_NO_REMOTE': '1', 03:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:31 INFO - 'NO_EM_RESTART': '1', 03:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:31 INFO - 'PWD': '/builds/slave/test', 03:40:31 INFO - 'SHELL': '/bin/bash', 03:40:31 INFO - 'SHLVL': '1', 03:40:31 INFO - 'TERM': 'linux', 03:40:31 INFO - 'TMOUT': '86400', 03:40:31 INFO - 'USER': 'cltbld', 03:40:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 03:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:31 INFO - '_': '/tools/buildbot/bin/python'} 03:40:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:40:34 INFO - Installing collected packages: mozsystemmonitor 03:40:34 INFO - Running setup.py install for mozsystemmonitor 03:40:34 INFO - Successfully installed mozsystemmonitor 03:40:34 INFO - Cleaning up... 03:40:34 INFO - Return code: 0 03:40:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:34 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 0x7f908e584f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80410>, '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 0x1e81310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e817a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:40:34 INFO - Using env: {'DISPLAY': ':0', 03:40:34 INFO - 'HOME': '/home/cltbld', 03:40:34 INFO - 'LANG': 'en_US.UTF-8', 03:40:34 INFO - 'LANGUAGE': 'en_US:en', 03:40:34 INFO - 'LOGNAME': 'cltbld', 03:40:34 INFO - 'MAIL': '/var/mail/cltbld', 03:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:34 INFO - 'MOZ_NO_REMOTE': '1', 03:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:34 INFO - 'NO_EM_RESTART': '1', 03:40:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:34 INFO - 'PWD': '/builds/slave/test', 03:40:34 INFO - 'SHELL': '/bin/bash', 03:40:34 INFO - 'SHLVL': '1', 03:40:34 INFO - 'TERM': 'linux', 03:40:34 INFO - 'TMOUT': '86400', 03:40:34 INFO - 'USER': 'cltbld', 03:40:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 03:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:34 INFO - '_': '/tools/buildbot/bin/python'} 03:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:34 INFO - Downloading/unpacking blobuploader==1.2.4 03:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:36 INFO - Downloading blobuploader-1.2.4.tar.gz 03:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:40:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:40:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:36 INFO - Downloading docopt-0.6.1.tar.gz 03:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:40:37 INFO - Installing collected packages: blobuploader, requests, docopt 03:40:37 INFO - Running setup.py install for blobuploader 03:40:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:40:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:40:37 INFO - Running setup.py install for requests 03:40:37 INFO - Running setup.py install for docopt 03:40:37 INFO - Successfully installed blobuploader requests docopt 03:40:37 INFO - Cleaning up... 03:40:37 INFO - Return code: 0 03:40:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:37 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 0x7f908e584f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80410>, '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 0x1e81310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e817a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:40:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:40:37 INFO - Using env: {'DISPLAY': ':0', 03:40:37 INFO - 'HOME': '/home/cltbld', 03:40:37 INFO - 'LANG': 'en_US.UTF-8', 03:40:37 INFO - 'LANGUAGE': 'en_US:en', 03:40:37 INFO - 'LOGNAME': 'cltbld', 03:40:37 INFO - 'MAIL': '/var/mail/cltbld', 03:40:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:37 INFO - 'MOZ_NO_REMOTE': '1', 03:40:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:37 INFO - 'NO_EM_RESTART': '1', 03:40:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:37 INFO - 'PWD': '/builds/slave/test', 03:40:37 INFO - 'SHELL': '/bin/bash', 03:40:37 INFO - 'SHLVL': '1', 03:40:37 INFO - 'TERM': 'linux', 03:40:37 INFO - 'TMOUT': '86400', 03:40:37 INFO - 'USER': 'cltbld', 03:40:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 03:40:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:37 INFO - '_': '/tools/buildbot/bin/python'} 03:40:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:37 INFO - Running setup.py (path:/tmp/pip-tmDXjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:37 INFO - Running setup.py (path:/tmp/pip-dYtmed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:37 INFO - Running setup.py (path:/tmp/pip-DliZBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:38 INFO - Running setup.py (path:/tmp/pip-UJkoDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:38 INFO - Running setup.py (path:/tmp/pip-w7xIns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:38 INFO - Running setup.py (path:/tmp/pip-zNBi1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:38 INFO - Running setup.py (path:/tmp/pip-nfaNBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:38 INFO - Running setup.py (path:/tmp/pip-7UAgQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:38 INFO - Running setup.py (path:/tmp/pip-rhX6MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:38 INFO - Running setup.py (path:/tmp/pip-ZzkL98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:38 INFO - Running setup.py (path:/tmp/pip-S4CSx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:38 INFO - Running setup.py (path:/tmp/pip-MH04kM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:38 INFO - Running setup.py (path:/tmp/pip-kmc0mT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:38 INFO - Running setup.py (path:/tmp/pip-KmmZmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:38 INFO - Running setup.py (path:/tmp/pip-rvUIYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:38 INFO - Running setup.py (path:/tmp/pip-F9zS4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:39 INFO - Running setup.py (path:/tmp/pip-KcIsAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:40:39 INFO - Running setup.py install for manifestparser 03:40:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:40:39 INFO - Running setup.py install for mozcrash 03:40:39 INFO - Running setup.py install for mozdebug 03:40:39 INFO - Running setup.py install for mozdevice 03:40:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:40:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:40:39 INFO - Running setup.py install for mozfile 03:40:39 INFO - Running setup.py install for mozhttpd 03:40:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:40:39 INFO - Running setup.py install for mozinfo 03:40:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:40:39 INFO - Running setup.py install for mozInstall 03:40:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:40:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:40:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:40:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:40:39 INFO - Running setup.py install for mozleak 03:40:39 INFO - Running setup.py install for mozlog 03:40:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:40:40 INFO - Running setup.py install for moznetwork 03:40:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:40:40 INFO - Running setup.py install for mozprocess 03:40:40 INFO - Running setup.py install for mozprofile 03:40:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:40:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:40:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:40:40 INFO - Running setup.py install for mozrunner 03:40:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:40:40 INFO - Running setup.py install for mozscreenshot 03:40:40 INFO - Running setup.py install for moztest 03:40:40 INFO - Running setup.py install for mozversion 03:40:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:40:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:40:40 INFO - Cleaning up... 03:40:40 INFO - Return code: 0 03:40:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:40 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 0x7f908e584f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80410>, '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 0x1e81310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e817a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:40:40 INFO - Using env: {'DISPLAY': ':0', 03:40:40 INFO - 'HOME': '/home/cltbld', 03:40:40 INFO - 'LANG': 'en_US.UTF-8', 03:40:40 INFO - 'LANGUAGE': 'en_US:en', 03:40:40 INFO - 'LOGNAME': 'cltbld', 03:40:40 INFO - 'MAIL': '/var/mail/cltbld', 03:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:40 INFO - 'MOZ_NO_REMOTE': '1', 03:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:40 INFO - 'NO_EM_RESTART': '1', 03:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:40 INFO - 'PWD': '/builds/slave/test', 03:40:40 INFO - 'SHELL': '/bin/bash', 03:40:40 INFO - 'SHLVL': '1', 03:40:40 INFO - 'TERM': 'linux', 03:40:40 INFO - 'TMOUT': '86400', 03:40:40 INFO - 'USER': 'cltbld', 03:40:40 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 03:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:40 INFO - '_': '/tools/buildbot/bin/python'} 03:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:41 INFO - Running setup.py (path:/tmp/pip-WkFg06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:41 INFO - Running setup.py (path:/tmp/pip-irWevn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:41 INFO - Running setup.py (path:/tmp/pip-VfuJn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:41 INFO - Running setup.py (path:/tmp/pip-PDxCzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:41 INFO - Running setup.py (path:/tmp/pip-5cEGKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:41 INFO - Running setup.py (path:/tmp/pip-dAsCjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:41 INFO - Running setup.py (path:/tmp/pip-aJJRja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:41 INFO - Running setup.py (path:/tmp/pip-rrGzu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:41 INFO - Running setup.py (path:/tmp/pip-sBG2u5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:41 INFO - Running setup.py (path:/tmp/pip-KBwJwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:41 INFO - Running setup.py (path:/tmp/pip-_ziCU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:41 INFO - Running setup.py (path:/tmp/pip-zbQ7BK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:42 INFO - Running setup.py (path:/tmp/pip-Aub9AG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:42 INFO - Running setup.py (path:/tmp/pip-wsT_5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:42 INFO - Running setup.py (path:/tmp/pip-DySpAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:42 INFO - Running setup.py (path:/tmp/pip-E3PD8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:42 INFO - Running setup.py (path:/tmp/pip-RFLu6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:40:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:40:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:40:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:40:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:40:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:40:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:44 INFO - Downloading blessings-1.6.tar.gz 03:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:40:44 INFO - Installing collected packages: blessings 03:40:44 INFO - Running setup.py install for blessings 03:40:44 INFO - Successfully installed blessings 03:40:44 INFO - Cleaning up... 03:40:44 INFO - Return code: 0 03:40:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:40:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:44 INFO - Reading from file tmpfile_stdout 03:40:44 INFO - Current package versions: 03:40:44 INFO - argparse == 1.2.1 03:40:44 INFO - blessings == 1.6 03:40:44 INFO - blobuploader == 1.2.4 03:40:44 INFO - docopt == 0.6.1 03:40:44 INFO - manifestparser == 1.1 03:40:44 INFO - mozInstall == 1.12 03:40:44 INFO - mozcrash == 0.17 03:40:44 INFO - mozdebug == 0.1 03:40:44 INFO - mozdevice == 0.48 03:40:44 INFO - mozfile == 1.2 03:40:44 INFO - mozhttpd == 0.7 03:40:44 INFO - mozinfo == 0.9 03:40:44 INFO - mozleak == 0.1 03:40:44 INFO - mozlog == 3.1 03:40:44 INFO - moznetwork == 0.27 03:40:44 INFO - mozprocess == 0.22 03:40:44 INFO - mozprofile == 0.28 03:40:44 INFO - mozrunner == 6.11 03:40:44 INFO - mozscreenshot == 0.1 03:40:44 INFO - mozsystemmonitor == 0.0 03:40:44 INFO - moztest == 0.7 03:40:44 INFO - mozversion == 1.4 03:40:44 INFO - psutil == 3.1.1 03:40:44 INFO - requests == 1.2.3 03:40:44 INFO - wsgiref == 0.1.2 03:40:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:44 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 0x7f908e584f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80410>, '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 0x1e81310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e817a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:40:44 INFO - Using env: {'DISPLAY': ':0', 03:40:44 INFO - 'HOME': '/home/cltbld', 03:40:44 INFO - 'LANG': 'en_US.UTF-8', 03:40:44 INFO - 'LANGUAGE': 'en_US:en', 03:40:44 INFO - 'LOGNAME': 'cltbld', 03:40:44 INFO - 'MAIL': '/var/mail/cltbld', 03:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:44 INFO - 'MOZ_NO_REMOTE': '1', 03:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:44 INFO - 'NO_EM_RESTART': '1', 03:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:44 INFO - 'PWD': '/builds/slave/test', 03:40:44 INFO - 'SHELL': '/bin/bash', 03:40:44 INFO - 'SHLVL': '1', 03:40:44 INFO - 'TERM': 'linux', 03:40:44 INFO - 'TMOUT': '86400', 03:40:44 INFO - 'USER': 'cltbld', 03:40:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 03:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:44 INFO - '_': '/tools/buildbot/bin/python'} 03:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:40:44 INFO - Cleaning up... 03:40:44 INFO - Return code: 0 03:40:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f908e584f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80410>, '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 0x1e81310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e817a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:40:44 INFO - Using env: {'DISPLAY': ':0', 03:40:44 INFO - 'HOME': '/home/cltbld', 03:40:44 INFO - 'LANG': 'en_US.UTF-8', 03:40:44 INFO - 'LANGUAGE': 'en_US:en', 03:40:44 INFO - 'LOGNAME': 'cltbld', 03:40:44 INFO - 'MAIL': '/var/mail/cltbld', 03:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:44 INFO - 'MOZ_NO_REMOTE': '1', 03:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:44 INFO - 'NO_EM_RESTART': '1', 03:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:44 INFO - 'PWD': '/builds/slave/test', 03:40:44 INFO - 'SHELL': '/bin/bash', 03:40:44 INFO - 'SHLVL': '1', 03:40:44 INFO - 'TERM': 'linux', 03:40:44 INFO - 'TMOUT': '86400', 03:40:44 INFO - 'USER': 'cltbld', 03:40:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 03:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:44 INFO - '_': '/tools/buildbot/bin/python'} 03:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:45 INFO - Downloading/unpacking jsonschema 03:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:40:47 INFO - Downloading/unpacking functools32 (from jsonschema) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:47 INFO - Downloading functools32-3.2.3-2.tar.gz 03:40:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:40:47 INFO - warning: no files found matching '*.txt' 03:40:47 INFO - no previously-included directories found matching 'build' 03:40:47 INFO - no previously-included directories found matching 'dist' 03:40:47 INFO - no previously-included directories found matching '.git*' 03:40:47 INFO - Installing collected packages: jsonschema, functools32 03:40:47 INFO - Running setup.py install for functools32 03:40:47 INFO - warning: no files found matching '*.txt' 03:40:47 INFO - no previously-included directories found matching 'build' 03:40:47 INFO - no previously-included directories found matching 'dist' 03:40:47 INFO - no previously-included directories found matching '.git*' 03:40:47 INFO - Successfully installed jsonschema functools32 03:40:47 INFO - Cleaning up... 03:40:47 INFO - Return code: 0 03:40:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f908e584f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80410>, '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 0x1e81310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e817a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:40:47 INFO - Using env: {'DISPLAY': ':0', 03:40:47 INFO - 'HOME': '/home/cltbld', 03:40:47 INFO - 'LANG': 'en_US.UTF-8', 03:40:47 INFO - 'LANGUAGE': 'en_US:en', 03:40:47 INFO - 'LOGNAME': 'cltbld', 03:40:47 INFO - 'MAIL': '/var/mail/cltbld', 03:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:47 INFO - 'MOZ_NO_REMOTE': '1', 03:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:47 INFO - 'NO_EM_RESTART': '1', 03:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:47 INFO - 'PWD': '/builds/slave/test', 03:40:47 INFO - 'SHELL': '/bin/bash', 03:40:47 INFO - 'SHLVL': '1', 03:40:47 INFO - 'TERM': 'linux', 03:40:47 INFO - 'TMOUT': '86400', 03:40:47 INFO - 'USER': 'cltbld', 03:40:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 03:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:47 INFO - '_': '/tools/buildbot/bin/python'} 03:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:47 INFO - Downloading/unpacking flake8 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:40:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:40:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:40:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:40:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:40:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:40:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:40:50 INFO - no previously-included directories found matching 'docs/_build' 03:40:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:40:50 INFO - Running setup.py install for pep8 03:40:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:40:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:40:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:40:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:40:50 INFO - no previously-included directories found matching 'docs/_build' 03:40:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:40:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:40:50 INFO - Cleaning up... 03:40:50 INFO - Return code: 0 03:40:50 INFO - Running post-action listener: _resource_record_post_action 03:40:50 INFO - Running post-action listener: _start_resource_monitoring 03:40:50 INFO - Starting resource monitoring. 03:40:50 INFO - ##### 03:40:50 INFO - ##### Running install step. 03:40:50 INFO - ##### 03:40:50 INFO - Running pre-action listener: _resource_record_pre_action 03:40:50 INFO - Running main action method: install 03:40:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:50 INFO - Reading from file tmpfile_stdout 03:40:50 INFO - Detecting whether we're running mozinstall >=1.0... 03:40:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:40:50 INFO - Reading from file tmpfile_stdout 03:40:50 INFO - Output received: 03:40:50 INFO - Usage: mozinstall [options] installer 03:40:50 INFO - Options: 03:40:50 INFO - -h, --help show this help message and exit 03:40:50 INFO - -d DEST, --destination=DEST 03:40:50 INFO - Directory to install application into. [default: 03:40:50 INFO - "/builds/slave/test"] 03:40:50 INFO - --app=APP Application being installed. [default: firefox] 03:40:50 INFO - mkdir: /builds/slave/test/build/application 03:40:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:41:06 INFO - Reading from file tmpfile_stdout 03:41:06 INFO - Output received: 03:41:06 INFO - /builds/slave/test/build/application/firefox/firefox 03:41:06 INFO - Running post-action listener: _resource_record_post_action 03:41:06 INFO - ##### 03:41:06 INFO - ##### Running run-tests step. 03:41:06 INFO - ##### 03:41:06 INFO - Running pre-action listener: _resource_record_pre_action 03:41:06 INFO - Running main action method: run_tests 03:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:41:06 INFO - Python 2.7.3 03:41:06 INFO - Return code: 0 03:41:06 INFO - grabbing minidump binary from tooltool 03:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:06 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 0x1e80410>, '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 0x1e81310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e817a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:41:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:41:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:41:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:41:06 INFO - Return code: 0 03:41:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:41:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:41:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:41:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:41:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:41:07 INFO - Return code: 0 03:41:07 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/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:41:07 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/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:41:07 INFO - Using env: {'DISPLAY': ':0', 03:41:07 INFO - 'HOME': '/home/cltbld', 03:41:07 INFO - 'LANG': 'en_US.UTF-8', 03:41:07 INFO - 'LANGUAGE': 'en_US:en', 03:41:07 INFO - 'LOGNAME': 'cltbld', 03:41:07 INFO - 'MAIL': '/var/mail/cltbld', 03:41:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:41:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:07 INFO - 'MOZ_NO_REMOTE': '1', 03:41:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:07 INFO - 'NO_EM_RESTART': '1', 03:41:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:07 INFO - 'PWD': '/builds/slave/test', 03:41:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:41:07 INFO - 'SHELL': '/bin/bash', 03:41:07 INFO - 'SHLVL': '1', 03:41:07 INFO - 'TERM': 'linux', 03:41:07 INFO - 'TMOUT': '86400', 03:41:07 INFO - 'USER': 'cltbld', 03:41:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364', 03:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:07 INFO - '_': '/tools/buildbot/bin/python'} 03:41:07 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/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:41:07 INFO - mozversion application_buildid: 20160601004014 03:41:07 INFO - mozversion application_changeset: 3cc4a98864ad31001292b38c97df30962b9e94d0 03:41:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:41:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:41:07 INFO - mozversion application_name: Firefox 03:41:07 INFO - mozversion application_remotingname: firefox-dev 03:41:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:07 INFO - mozversion application_vendor: Mozilla 03:41:07 INFO - mozversion application_version: 48.0a2 03:41:07 INFO - mozversion platform_buildid: 20160601004014 03:41:07 INFO - mozversion platform_changeset: 3cc4a98864ad31001292b38c97df30962b9e94d0 03:41:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:07 INFO - mozversion platform_version: 48.0a2 03:41:07 INFO - using testdate: 1464777667 03:41:07 INFO - actual date: 1464777667 03:41:07 INFO - starting webserver on 'localhost:36409' 03:41:07 INFO - SUITE-START | Running 2 tests 03:41:07 INFO - TEST-START | dromaeo_css 03:41:07 INFO - operating with platform_type : linux_ 03:41:07 INFO - Initialising browser for dromaeo_css test... 03:41:07 INFO - TEST-INFO | started process 7512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2chKUr/profile http://localhost:36409/getInfo.html) 03:41:11 INFO - PROCESS | 7512 | __metrics Screen width/height:1600/1200 03:41:11 INFO - PROCESS | 7512 | colorDepth:24 03:41:11 INFO - PROCESS | 7512 | Browser inner width/height: 1024/697 03:41:11 INFO - PROCESS | 7512 | __metrics 03:41:12 ERROR - PROCESS | 7512 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:41:13 INFO - TEST-INFO | 7512: exit 0 03:41:13 INFO - Browser initialized. 03:41:13 INFO - Running cycle 1/1 for dromaeo_css test... 03:41:13 INFO - TEST-INFO | started process 7603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2chKUr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:25 INFO - PROCESS | 7603 | RSS: Main: 142467072 03:41:25 INFO - PROCESS | 7603 | 03:42:16 INFO - PROCESS | 7603 | 1464777736320 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:44:23 INFO - PROCESS | 7603 | Cycle 1(1): loaded http://localhost:36409/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36409/tests/dromaeo/cssquery-ext.html) 03:44:24 INFO - PROCESS | 7603 | RSS: Main: 249044992 03:44:24 INFO - PROCESS | 7603 | 03:47:26 INFO - PROCESS | 7603 | Cycle 1(1): loaded http://localhost:36409/tests/dromaeo/cssquery-ext.html (next: http://localhost:36409/tests/dromaeo/cssquery-jquery.html) 03:47:27 INFO - PROCESS | 7603 | RSS: Main: 210558976 03:47:27 INFO - PROCESS | 7603 | 03:50:29 INFO - PROCESS | 7603 | Cycle 1(1): loaded http://localhost:36409/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36409/tests/dromaeo/cssquery-mootools.html) 03:50:29 INFO - PROCESS | 7603 | RSS: Main: 224129024 03:50:29 INFO - PROCESS | 7603 | 03:53:31 INFO - PROCESS | 7603 | Cycle 1(1): loaded http://localhost:36409/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36409/tests/dromaeo/cssquery-prototype.html) 03:53:32 INFO - PROCESS | 7603 | RSS: Main: 218640384 03:53:32 INFO - PROCESS | 7603 | 03:56:34 INFO - PROCESS | 7603 | Cycle 1(1): loaded http://localhost:36409/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36409/tests/dromaeo/cssquery-yui.html) 03:56:35 INFO - PROCESS | 7603 | RSS: Main: 186331136 03:56:35 INFO - PROCESS | 7603 | 03:59:37 INFO - PROCESS | 7603 | Cycle 1(1): loaded http://localhost:36409/tests/dromaeo/cssquery-yui.html (next: http://localhost:36409/tests/dromaeo/cssquery-dojo.html) 03:59:37 INFO - PROCESS | 7603 | RSS: Main: 256253952 03:59:37 INFO - PROCESS | 7603 | 03:59:37 INFO - PROCESS | 7603 | __start_tp_report 03:59:37 INFO - PROCESS | 7603 | _x_x_mozilla_page_load 03:59:37 INFO - PROCESS | 7603 | _x_x_mozilla_page_load_details 03:59:37 INFO - PROCESS | 7603 | |i|pagename|runs| 03:59:37 INFO - PROCESS | 7603 | |0;dojo.html;3234.336960923011;3276.7870088444242;3283.261266215102;3310.8841190558337;3330.2173989112553;5289.523942845148;5302.045631786277;5309.654872433294;5325.733713314338;5340.652857564261;5318.30861987942;5324.307839980797;5327.121025030865;5332.33345831771;5335.546478549319;4766.928496072562;4811.59101476375;4892.68197567157;4966.6771659842;4971.080350135218;4860.027994401116;4951.777170027357;4968.826091086813;4969.726665033421;4972.154733695281;4872.244802055687;4917.926231106536;4935.5804756595735;4939.678920870132;4953.108440480712;4912.950870491285;4934.309196712463;4947.035328110984;4948.208286674115;4973.975130124344;4821.132196204681;4847.248676455155;4882.658213925027;4897.020595880838;4944.554990050912;5285.312909321802;5312.2828418163435;5333.546648534879;5344.759485823147;5347.6256662033675;5663.377028526858;5720.856978575569;5722.856928576777;5724.885502289931;5731;5715.199872017921;5765.538756899438;5789.768409263666;5833.183354330397;5837.416258374171;5397.163439666858;5404.945950540523;5447.591430642718;5447.727613619343;5451.073317535949;5793.478586927196;5916.437938395846;5916.49709774674;5923.466887980103;5924.911126333109;5640.633358831663;5679.432056794288;5687.03320435527;5693.117566777156;5730.627509211888;5709.8287051388525;5729.684867332254;5731.111677689964;5731.570132240098;5735.713214339266;5637.295338082739;5686;5695.401982791747;5697.914531282034;5703.771849126071;5758.107493338455;5779.479846813807;5781.219535362757;5789.160571717078;5819.359870414251;4425.690201685916;4431.224535706303;4435.35687325336;4437;4462.486814016364;3891.1439483313625;3938.8030598469963;3988.142549351903;3992.2614316350987;4035.354343305116;5465;5482.068048431776;5488.80789172385;5491.36849262332;5493.478119578634;5806.361300256968;5812.709364531841;5813.069908814569;5817.069268916953;5822.039363505059;5351;5399.541039011728;5468.589855760833;5493.615446918758;5506.669599824023;4979.950200497949;5010.749462526859;5013.423456302572;5015.448300686921;5047.899042019139;5868.530517558585;5970.373110823388;5976.491998180203;5984.670843103671;5984.970075149684;5679.204911312419;5692.6299790513485;5748.195252664714;5777.508911742549;5778.768849246151;5991.520678345635;5994.430529099728;5997.13041608973;6006.009008513546;6010.939890601038;5513.696746678971;5731.885362292647;5733.369329373849;5734.426557344399;5739.971300143473;5781.768729250783;5843.211166492639;5847.473727364558;5850.912236316373;5888.646681199141;5626.071698169756;5637.8590535236945;5647.237622920853;5647.576431767552;5687.914681279702;5400;5531.557475401878;5636.689982050862;5645.717714114196;5645.802396916089;5471.316085489314;5491.725413729378;5516.9448305516435;5526.309211348582;5562.276904002454;5547.611667183259;5563.054280772198;5567.192757050124;5602.775888964559;5606.887862242814;5486.643368181215;5506.752196151103;5564.4713752193475;5565.5825813063375;5650.23721797552 03:59:37 INFO - PROCESS | 7603 | |1;ext.html;585.242111465652;642.3801032004116;651.150248925153;652.481277384479;659.6767583883897;32847.1788205295;33683.66316336836;33781;33833.492497612555;33842.66157338429;33483.83258083712;39423.80288098555;40050.19899602013;40067.398989015186;40073;8887.822243555142;9006.729798106067;9019.95490022549;9040.231580315682;9041.095890410972;8486.405951583361;8734.825303493926;8857.512836793974;8859.29125669945;8865.645374185026;10712.303700259497;10987;10996;11002.944985275102;11032.944835275852;10512.579496820117;10596.5231564579;10628.096611788007;10630.999999999962;10638;8225.177482251787;10272.79454410915;10429.478526073666;10512.842307365396;10532.999365060306;38952.80523597392;39417.40873886894;39426.802865985774;39528;39528.80235598804;3887.8250478728523;4006.559278479365;4079.816408261606;4202.600752928467;4551.34005569194;29920.401591968257;31604.683953160406;33053.66946330554;34247.4862877057;34377;4426.336049592554;4485.461744590637;4485.663575231838;4504.054148628792;4567.634589232886;311907;313657;313709;314818;315915;65594.34405655978;65847;66081.6695916527;66108.66945665241;66185;69754.65122674355;69949.95075073878;69991.65004174947;70175;70227.29772702309;19060.71408928867;19700.21199152018;19703.42372610188;19710.507237319183;19713.112909919088;14954.476593319181;15000.474983375529;15003;15007.174605396589;15007.174605396807;18501.259949602136;19904.104315305845;20567;20899.268525601532;20901.686474702892;7357.889631655529;7388.44586656003;7520.774376768706;7586.734464293723;7784.532928024337;1058.116472745251;1102.1843835561626;1166.0671462829703;1192.7316353820322;1198.1732604502865;32770.67229327724;33564.160895977795;33943.98168054962;34265.65734342675;35300.646993529735;1154.2901115813881;1172.9648110556698;1203.4043148641304;1203.5005472728894;1303.2897071096274;15389.923050384676;16910.096072138942;17492.47522574325;17515.824841751673;17595;453364;461775;462337;463036;463116;59090.40909590935;59798.70100649469;59818.40181598216;60111;60162.699186504666;1504.9699006019819;1508.6228442889278;1511.093343993595;1536.423841059625;1609.235613083776;29258.7074129256;30663.84668076645;32514;33014;33173;52107.91568337224;60332.69833650979;61462.692686536284;61628.691856540434;61636;422876;426382;428033;429830;430298;37313.81343093267;41661.79169104135;46978;46998;47362;43616;48938.51061489482;48949.2657610129;50102.24846627231;50505;40107;40247.79876100601;41259.38110928278;41470.792646037786;41832.163356733305;41443.7927810359;41511.58488415077;41538.792306038275;41811.79094104632;41925;40683;41366;41979.37030944477;42211.1557768849;42660.78669606632;35998.28003439864;37034.259314814095;37190.62809371872;37802.62197377991;37828.43257351197;28169.464748172762;28599.285017873888;28735.425291493633;28933.276668083465;29041.7095829039 03:59:37 INFO - PROCESS | 7603 | |2;jquery.html;417.9477565304336;426.6906492792726;427.4955552448111;433.6985794872565;442.46240817406846;18348.35780747674;19134.904325478372;19174.424767256987;19784.505387365323;20556;18706;18891.62216755664;19107.235710571596;19132.904335478303;19144;4717.315989181567;5159.948400516003;5371.409144994048;5373.6775793452325;5377.623566350357;5222.817201397952;5238.633295669305;5278.736063196825;5281.075811732951;5299.735013249341;5350.464953504638;5355.250264962909;5360.973195134019;5588.91616625751;5864.061750119981;5712.457316554921;5889.499392551638;5907.232059832194;5932.940670593303;5937.079752638348;5944.673042982634;5945.048792193272;5981;5985.072313791369;5993.130996005599;23621.76378236213;23946.16188433414;23972;24407.26778196657;24431.755682443127;2460.1143588308196;2500.2999160235163;2502.5245203411296;2991.880324787006;3026.561148633436;10375.42935138567;10634.62778802746;11710.414479276002;15228.543143705596;15423.922880385639;1921.3851567498407;1956;1958.0992743338081;2000.3798822364968;2037.7860324665844;75678.62160689216;76063;76119;77160;78718;11378.886211137948;11536.538538458535;11575.189736718517;11581;11789;16307.918460407622;16321.183940802912;16365.754513682305;16395.262213200196;16424.1787910604;8865.290776737846;8873.201411872833;8990.28077753778;9143.77140571491;9242.953785231166;9012.27901767857;9022.278217742565;9036.548172591476;9045.140711632384;9125.726228213165;4989.476105008922;4991.3511243538105;5028.346314979102;5144.6398752087;5159.071367153873;1989.1347263940231;2007.2874129684044;2091.518950641331;2115.862468939514;2133.136079887648;1018.3686114608989;1027.9023492768174;1037.5797801890246;1045.1847558904067;1096.6545538155456;17503.190555954516;18756.24975001012;19535.706964395544;20847.37457876266;21023.68464473034;1044.8798388185303;1097.5664612478026;1113.5991043224433;1147.3632134165618;1151.1021403305435;10921.890781092246;11418.31490110596;11480.311181329147;11625.24435911663;11780.764384712258;462115;468289;468733;473006;495597;69248;81950.59024704839;83450;90273;93000.53499732458;1061.490484567412;1129.9209055366046;1142.5429828068673;1146.1003112556602;1147.2829481574017;16992.320307187572;17046.31814727397;17112.743308850128;17428.564285892953;17769.289228430716;40477.190456190125;41118.58881411148;41329.380059299736;41399;42019.7899010503;55284;60965.39034609597;60997.69501152466;61866;62461.68769156125;12503.374831258583;12730.23618582888;12917.22496650204;13003.674908127372;13279.269640169883;13793.655158621115;13961.162330260217;14100.435982560994;14435.855641443452;15203.315850786963;9166.854143232096;10005.399676019462;11405.600803971822;11544.19190656646;13440.260785656492;11931.522739090338;12443;12840.61478155657;13152.408141633841;13267.933660331637;12253.571125010581;12409.689757755767;12609.93695031519;12675.556355527513;13134.868651313365;12485.500579976699;12594.937025314815;12812.871871281168;12926.159799612995;12936.935315323362;12444.502219911103;12562.560310389457;12772.42524086437;12803;13295.335233238106 03:59:37 INFO - PROCESS | 7603 | |3;mootools.html;1452.1142103316968;1568.396167475522;1585.8017747781528;1770.8848924819886;1903.6002439487706;7727.072751269849;8335.041470230924;8481.897353344057;8501.404901656879;8511.361647876403;8092.433529652927;8198.1801819818;8200.548969806674;8217.6302066407;8231.259186673198;2093.822025127866;2362.078789272185;2383.4160630645515;2386.8806559672034;2444.4133407982135;2403.627437747152;2412.3969007748065;2415.384077060356;2419.6733440985504;2420.3586049696846;2322.6980492535945;2376.192094687806;2376.346504711201;2378.6550950112223;2387.0451819272344;2108;2322.5587138443725;2371.9644205336936;2379.4051487128218;2384.0582969726947;2317.9072837086665;2357.3752955466816;2379.8334116611845;2389.6773935518654;2391.1511413448147;8449.788755281106;8524.914750852475;8526.87209691855;8530.232279094911;8544.829103417958;5138.10083235436;5257.290265814143;5262.447443018466;5263.26314315996;5270.604704647167;3522.788632682047;3558.928821423557;3580.3018411409785;3583.33708263972;3594.155373487228;1174.671092094215;1201.0931746531312;1208.788462019143;1225.0689475998217;1249.9125061245716;12272.938635306766;12289.56986505468;12300.876991230063;12327.630171094881;12342.012638988948;4512.593866552026;4558.817647294071;4578.198815207325;4650.348951146842;4708.128996135726;10430.061294483381;10445.216608754374;10455.477226138662;10459.84310235347;10462;4839.2983017462275;5239.1355426354985;5248.396434410015;5249.42256351801;5250.081235783722;4782;4826.710397376169;4853.369062021915;4859.052484765437;4876.049170411736;4095.262852686545;4150.522689890641;4258.978705106455;4333.306670932636;4333.891652708708;1337.518493342396;1361.101672895884;1370.2189751841554;1371.3897315694421;1372.766629672958;971.4899677669139;1005.1506477026901;1039.9012093851072;1093.8796732359433;1097.8133717268083;6089.330173680892;6102.923194402146;6127.356627554132;6141.57009009374;6318.147050148263;429.3195285472561;431.44559241374685;444.5621063252693;454.4073024050681;460.8548307283195;4051.9392209116886;4092.2224777292217;4120.958790412057;4145.440365550612;4177.603127702863;10037.247206459544;10453.686389408178;10471.16230701542;10471.738206544896;10488.056074953138;10044.146247568893;10218.080372766486;10296.433696146783;10316.071553560216;10328.328658637314;8104.432689711663;8168;8168.101508834024;8183.304419124322;8203.30271926881;5943.64338139713;6150.538709596709;6162.691865406801;6209.96895015522;6252.374762523711;9389.295802814953;9710.223182145553;9930.900690992998;9959.502024898582;9968.651097211563;9786;9855.063768941938;10064.094231519199;10072;10077;6748.325167483213;7355.7057717690695;7478;7698.692052317844;7799.376049916106;8087.797805054921;8136.633851476816;8140.389470789596;8184.345252379914;8202.17978202175;7215.927840721735;7329.120505539369;7414.555126692416;7440.2931721486375;7462.403007759258;7280.959067717467;7417.777466676009;7540.54756714577;7558.622068896643;7651.158372579123;7031.648417578998;7049.682764275517;7053.717851286096;7080.433565314659;7089.680964356719;5028.321176641107;5139.869228769665;5173.249878767633;5231.398389185292;5239.947600524099;5090;5106.821261255838;5109.1059064662795;5110.821121260738;5246.580273578181 03:59:37 INFO - PROCESS | 7603 | |4;prototype.html;351.729168540224;355.46325049175755;360.5835260274383;368.6368926607293;369.30570527408486;6030;6156.261248650168;6216.689165541722;6218.129461875341;6238.469730072944;6136.938630613692;6251.624902505853;6257;6269.090981807635;6269.686515674221;4775.713457192571;4806.927896081562;4814.66297359185;4818.397700287464;4825.276208568707;4593.609543188833;4680.485146633868;4759.167145749498;4813.831515896944;4829.7585120744;4739;4765.046990601893;4765.118453086173;4794.35276237707;4795.472498025214;4776.856694299159;4779.235322348442;4784.138855006097;4792.25720013395;4797.8320758773625;4224.66202703783;4224.683148763855;4231.534531201565;4235.894102647428;4237.216115018731;5906.852328691774;5999.340072592011;6010.939890601082;6014.0678194879865;6015.608985415934;5283.498067683564;5551.583631227674;5558.305211848519;5564.276644036249;5564.721763911788;6512;6546.9017964730565;6547.5089368297095;6562.507811914078;6567.047778072153;4571.085782843445;4571.291449825282;4573.314002899591;4573.63410927125;4573.908521829545;6788.694508747119;6867.416269617089;6868.278830722802;6881.277465866062;6882.5870447773295;4662.696924699883;4668.3697700810635;4671.743054131987;4675.929861052087;4681.765911704401;4643.7684003925415;4732.5977291929885;4736.881577960509;4737.076270127361;4742.241241401359;5369.24830523727;5462.781488740406;5473.75368108436;5476.863078422992;5480.451954804567;6545.574537655132;6568.310327415553;6606.141201643852;6618.106555615027;6632.668366581652;1559.9298031588605;1599.1364663082038;1642.0558179046857;1649.5546202525252;1650.3233674193523;1028.717102796737;1067.524951396621;1071.212658695858;1076.69852441315;1082.242430298794;6154.107654390088;6157.4458298753325;6158.076288556663;6163.106349579376;6167.876642467126;6702.865942681216;6710.261871194165;6716.71631645243;6727.428168605626;6728.428083612947;6207.472364848948;6219.471344935731;6219.875602487925;6223.097650840603;6237.313895471494;3587.336342776595;3626.546681664792;3632.455131730209;3633.436817293271;3635.163912300186;6774.695138718769;6924.376806087476;6929.757458488929;6942.791716248521;6943.444524438134;6793.116894803644;6798.286179951034;6830.965845170842;6840.281770414035;6849.075374824335;6888.448924086061;6914;6918.342757438036;6938.757143499954;6938.930610693828;6669.166354205724;6696.531242812956;6710.295418981132;6721.831954201184;6725.630090344882;6487.9026814598765;6488.286288508166;6607.504437167136;6651.368120028589;6659.866802664016;6842.384185423336;6913;6913.170419549686;6915.757948471779;6917.27368626287;4647.233206520887;4649.628029757679;4658.138244424792;4658.37111989877;4663.114008338405;6571.737130514726;6600.405963463311;6701.061851340719;6708.899366509604;6720.1599800025;6693.531452798257;6710.228323742636;6739.898901516579;6750.25747167821;6752.628605426552;6627.105340778933;6635.336466353326;6636.535442519171;6640.800775976729;6643.534952553468;6508.934910651023;6516.250631177475;6520.217573891164;6521.9673901630185;6534.313897040933;6522.934770652233;6647.0029495576055;6647.401733843783;6656.068150459037;6691.5650482718465;6492.31830657793;6522.15212022434;6528.771492997722;6528.934710653023;6541.247756508063 03:59:37 INFO - PROCESS | 7603 | |5;yui.html;748.9513181643193;822.0464261456711;873.4366333714753;898.2140626951417;901.3465237702662;15389.538313850588;15439.536813895587;15496.535103946871;15508.5347439577;15528.611784705374;13867.791983120262;13968.16191028539;14015.089019213743;14234.359453824576;14298.213598252092;778.307306497218;893.3255392178896;894.9373543851933;913.2009491694768;914.4741773480242;905.9365844390895;909.2407839454064;910.1444642036498;910.7449914024083;912.115248209236;940.6425558287841;945.5461378538306;946.394307643109;946.6166202687888;947.6304241345881;799.0411506192563;942.1614762861025;943.6084025129563;969.8108868770593;970.3110791338158;695.0720787748362;698.7833771530791;698.7938558125365;699.1749735312329;699.5138378826717;14813.851861481355;14831.77752333716;14884.62788430287;14888.032277901902;14894.627634309121;14481.637959051002;15217.239138043053;15392.461263855823;15401.3839446422;15423;11873.228240164448;11908.821367679406;11968.82046769299;12025.819612705816;12084.335361555111;4167.604077612622;4820.6143508519235;4823.372961515016;4868.342773725537;4890.584300334476;59977;60152;60481.39518604846;60819.39180608182;61297.080543791875;12284.754304913851;12348.259104453762;12383.814242786366;12395.690107747198;12488.75022499563;21435.8928205358;21531;21536.13855445796;21549.89225053896;21556.89221553882;8937.46375217489;8965.775855603662;9009.774755631031;9223.492707900996;9301.813963720822;4965.677230979974;5100.1074811907765;5139.691618502902;5206.167013277857;5276.736163191902;3542.326957877995;3629.219717760694;3633.5821380541047;3633.818309084535;3638.308721342936;625.0093601641358;632.6678493790797;634.3973225435855;636.2682914648099;663.2439019517753;730.6711979609197;767.0871662721344;780.0795061827099;782.941279404047;792.1009654042588;9960.452175130438;10196.133328666998;10276.897231027595;10430.739231519272;10447.320924139907;650.8958566629317;660.8843452395812;664.2892105447222;686.306830101601;784.5175217241356;4621.792019359137;4906.55840974314;4954.133026720309;4956.677815941952;4998.350214472168;65477.34522654808;66151.66924165348;66226.66886665633;66370;66452.67415640429;55416.72291638597;55551.44448555543;56162.719186404625;56840.71579642075;57136.14295785566;50405;51996.97066326585;52489;52901.2064819028;53510.19734703982;9777.560009799718;9806.80386392254;9807.656732014346;9994.650187243411;10001.799964000533;37558.2488350226;38205.235895282494;38514.80742596381;39762.204755905295;39993;45941.77029114833;46907;49438;49901;50239.24641130313;11913.880861191625;12130.454129564367;12140.817887731515;12199.69500762488;12413.875861241633;13144.34278286101;13614.727705446034;13628.523001694894;13827;14068.507602233873;12802.807957880454;12963.41664625113;13013.739725205633;13182.077254592086;13503.257320847448;12598.685032874251;12708.3010434427;12906.612801615967;12935.353232338157;13351.732965340832;12706.618801435972;12762;12817;12929.353532323534;13211.14127581704;10698.090662293793;10879.129669626253;10913.508892100033;11097.833532497181;11123.944380278046;10468.581256749949;11210;11478.95591357562;11617.767644647229;11871.584494542649 03:59:37 INFO - PROCESS | 7603 | __end_tp_report 03:59:37 INFO - PROCESS | 7603 | __start_cc_report 03:59:37 INFO - PROCESS | 7603 | _x_x_mozilla_cycle_collect,801 03:59:37 INFO - PROCESS | 7603 | __end_cc_report 03:59:37 INFO - PROCESS | 7603 | __startTimestamp1464778777810__endTimestamp 03:59:37 INFO - PROCESS | 7603 | 03:59:37 INFO - PROCESS | 7603 | ------- Summary: start ------- 03:59:37 INFO - PROCESS | 7603 | Number of tests: 6 03:59:37 INFO - PROCESS | 7603 | 03:59:37 INFO - PROCESS | 7603 | [#0] dojo.html Cycles:165 Average:5357.25 Median:5526.31 stddev:581.71 (10.5%) stddev-sans-first:559.14 03:59:37 INFO - PROCESS | 7603 | Values: 3234.3 3276.8 3283.3 3310.9 3330.2 5289.5 5302.0 5309.7 5325.7 5340.7 5318.3 5324.3 5327.1 5332.3 5335.5 4766.9 4811.6 4892.7 4966.7 4971.1 4860.0 4951.8 4968.8 4969.7 4972.2 4872.2 4917.9 4935.6 4939.7 4953.1 4913.0 4934.3 4947.0 4948.2 4974.0 4821.1 4847.2 4882.7 4897.0 4944.6 5285.3 5312.3 5333.5 5344.8 5347.6 5663.4 5720.9 5722.9 5724.9 5731.0 5715.2 5765.5 5789.8 5833.2 5837.4 5397.2 5404.9 5447.6 5447.7 5451.1 5793.5 5916.4 5916.5 5923.5 5924.9 5640.6 5679.4 5687.0 5693.1 5730.6 5709.8 5729.7 5731.1 5731.6 5735.7 5637.3 5686.0 5695.4 5697.9 5703.8 5758.1 5779.5 5781.2 5789.2 5819.4 4425.7 4431.2 4435.4 4437.0 4462.5 3891.1 3938.8 3988.1 3992.3 4035.4 5465.0 5482.1 5488.8 5491.4 5493.5 5806.4 5812.7 5813.1 5817.1 5822.0 5351.0 5399.5 5468.6 5493.6 5506.7 4980.0 5010.7 5013.4 5015.4 5047.9 5868.5 5970.4 5976.5 5984.7 5985.0 5679.2 5692.6 5748.2 5777.5 5778.8 5991.5 5994.4 5997.1 6006.0 6010.9 5513.7 5731.9 5733.4 5734.4 5740.0 5781.8 5843.2 5847.5 5850.9 5888.6 5626.1 5637.9 5647.2 5647.6 5687.9 5400.0 5531.6 5636.7 5645.7 5645.8 5471.3 5491.7 5516.9 5526.3 5562.3 5547.6 5563.1 5567.2 5602.8 5606.9 5486.6 5506.8 5564.5 5565.6 5650.2 03:59:37 INFO - PROCESS | 7603 | 03:59:37 INFO - PROCESS | 7603 | [#1] ext.html Cycles:180 Average:58105.75 Median:39477.40 stddev:106943.00 (270.9%) stddev-sans-first:107155.80 03:59:37 INFO - PROCESS | 7603 | Values: 585.2 642.4 651.2 652.5 659.7 32847.2 33683.7 33781.0 33833.5 33842.7 33483.8 39423.8 40050.2 40067.4 40073.0 8887.8 9006.7 9020.0 9040.2 9041.1 8486.4 8734.8 8857.5 8859.3 8865.6 10712.3 10987.0 10996.0 11002.9 11032.9 10512.6 10596.5 10628.1 10631.0 10638.0 8225.2 10272.8 10429.5 10512.8 10533.0 38952.8 39417.4 39426.8 39528.0 39528.8 3887.8 4006.6 4079.8 4202.6 4551.3 29920.4 31604.7 33053.7 34247.5 34377.0 4426.3 4485.5 4485.7 4504.1 4567.6 311907.0 313657.0 313709.0 314818.0 315915.0 65594.3 65847.0 66081.7 66108.7 66185.0 69754.7 69950.0 69991.7 70175.0 70227.3 19060.7 19700.2 19703.4 19710.5 19713.1 14954.5 15000.5 15003.0 15007.2 15007.2 18501.3 19904.1 20567.0 20899.3 20901.7 7357.9 7388.4 7520.8 7586.7 7784.5 1058.1 1102.2 1166.1 1192.7 1198.2 32770.7 33564.2 33944.0 34265.7 35300.6 1154.3 1173.0 1203.4 1203.5 1303.3 15389.9 16910.1 17492.5 17515.8 17595.0 453364.0 461775.0 462337.0 463036.0 463116.0 59090.4 59798.7 59818.4 60111.0 60162.7 1505.0 1508.6 1511.1 1536.4 1609.2 29258.7 30663.8 32514.0 33014.0 33173.0 52107.9 60332.7 61462.7 61628.7 61636.0 422876.0 426382.0 428033.0 429830.0 430298.0 37313.8 41661.8 46978.0 46998.0 47362.0 43616.0 48938.5 48949.3 50102.2 50505.0 40107.0 40247.8 41259.4 41470.8 41832.2 41443.8 41511.6 41538.8 41811.8 41925.0 40683.0 41366.0 41979.4 42211.2 42660.8 35998.3 37034.3 37190.6 37802.6 37828.4 28169.5 28599.3 28735.4 28933.3 29041.7 03:59:37 INFO - PROCESS | 7603 | 03:59:37 INFO - PROCESS | 7603 | [#2] jquery.html Cycles:180 Average:28815.55 Median:2003.83 stddev:77853.20 (3885.2%) stddev-sans-first:78042.40 03:59:37 INFO - PROCESS | 7603 | Values: 417.9 426.7 427.5 433.7 442.5 18348.4 19134.9 19174.4 19784.5 20556.0 18706.0 18891.6 19107.2 19132.9 19144.0 4717.3 5159.9 5371.4 5373.7 5377.6 5222.8 5238.6 5278.7 5281.1 5299.7 5350.5 5355.3 5361.0 5588.9 5864.1 5712.5 5889.5 5907.2 5932.9 5937.1 5944.7 5945.0 5981.0 5985.1 5993.1 23621.8 23946.2 23972.0 24407.3 24431.8 2460.1 2500.3 2502.5 2991.9 3026.6 10375.4 10634.6 11710.4 15228.5 15423.9 1921.4 1956.0 1958.1 2000.4 2037.8 75678.6 76063.0 76119.0 77160.0 78718.0 11378.9 11536.5 11575.2 11581.0 11789.0 16307.9 16321.2 16365.8 16395.3 16424.2 8865.3 8873.2 8990.3 9143.8 9243.0 9012.3 9022.3 9036.5 9045.1 9125.7 4989.5 4991.4 5028.3 5144.6 5159.1 1989.1 2007.3 2091.5 2115.9 2133.1 1018.4 1027.9 1037.6 1045.2 1096.7 17503.2 18756.2 19535.7 20847.4 21023.7 1044.9 1097.6 1113.6 1147.4 1151.1 10921.9 11418.3 11480.3 11625.2 11780.8 462115.0 468289.0 468733.0 473006.0 495597.0 69248.0 81950.6 83450.0 90273.0 93000.5 1061.5 1129.9 1142.5 1146.1 1147.3 16992.3 17046.3 17112.7 17428.6 17769.3 40477.2 41118.6 41329.4 41399.0 42019.8 55284.0 60965.4 60997.7 61866.0 62461.7 12503.4 12730.2 12917.2 13003.7 13279.3 13793.7 13961.2 14100.4 14435.9 15203.3 9166.9 10005.4 11405.6 11544.2 13440.3 11931.5 12443.0 12840.6 13152.4 13267.9 12253.6 12409.7 12609.9 12675.6 13134.9 12485.5 12594.9 12812.9 12926.2 12936.9 12444.5 12562.6 12772.4 12803.0 13295.3 03:59:37 INFO - PROCESS | 7603 | 03:59:37 INFO - PROCESS | 7603 | [#3] mootools.html Cycles:180 Average:5713.54 Median:4679.24 stddev:3176.19 (67.9%) stddev-sans-first:3168.96 03:59:37 INFO - PROCESS | 7603 | Values: 1452.1 1568.4 1585.8 1770.9 1903.6 7727.1 8335.0 8481.9 8501.4 8511.4 8092.4 8198.2 8200.5 8217.6 8231.3 2093.8 2362.1 2383.4 2386.9 2444.4 2403.6 2412.4 2415.4 2419.7 2420.4 2322.7 2376.2 2376.3 2378.7 2387.0 2108.0 2322.6 2372.0 2379.4 2384.1 2317.9 2357.4 2379.8 2389.7 2391.2 8449.8 8524.9 8526.9 8530.2 8544.8 5138.1 5257.3 5262.4 5263.3 5270.6 3522.8 3558.9 3580.3 3583.3 3594.2 1174.7 1201.1 1208.8 1225.1 1249.9 12272.9 12289.6 12300.9 12327.6 12342.0 4512.6 4558.8 4578.2 4650.3 4708.1 10430.1 10445.2 10455.5 10459.8 10462.0 4839.3 5239.1 5248.4 5249.4 5250.1 4782.0 4826.7 4853.4 4859.1 4876.0 4095.3 4150.5 4259.0 4333.3 4333.9 1337.5 1361.1 1370.2 1371.4 1372.8 971.5 1005.2 1039.9 1093.9 1097.8 6089.3 6102.9 6127.4 6141.6 6318.1 429.3 431.4 444.6 454.4 460.9 4051.9 4092.2 4121.0 4145.4 4177.6 10037.2 10453.7 10471.2 10471.7 10488.1 10044.1 10218.1 10296.4 10316.1 10328.3 8104.4 8168.0 8168.1 8183.3 8203.3 5943.6 6150.5 6162.7 6210.0 6252.4 9389.3 9710.2 9930.9 9959.5 9968.7 9786.0 9855.1 10064.1 10072.0 10077.0 6748.3 7355.7 7478.0 7698.7 7799.4 8087.8 8136.6 8140.4 8184.3 8202.2 7215.9 7329.1 7414.6 7440.3 7462.4 7281.0 7417.8 7540.5 7558.6 7651.2 7031.6 7049.7 7053.7 7080.4 7089.7 5028.3 5139.9 5173.2 5231.4 5239.9 5090.0 5106.8 5109.1 5110.8 5246.6 03:59:37 INFO - PROCESS | 7603 | 03:59:37 INFO - PROCESS | 7603 | [#4] prototype.html Cycles:180 Average:5489.02 Median:6218.80 stddev:1645.46 (26.5%) stddev-sans-first:1604.26 03:59:37 INFO - PROCESS | 7603 | Values: 351.7 355.5 360.6 368.6 369.3 6030.0 6156.3 6216.7 6218.1 6238.5 6136.9 6251.6 6257.0 6269.1 6269.7 4775.7 4806.9 4814.7 4818.4 4825.3 4593.6 4680.5 4759.2 4813.8 4829.8 4739.0 4765.0 4765.1 4794.4 4795.5 4776.9 4779.2 4784.1 4792.3 4797.8 4224.7 4224.7 4231.5 4235.9 4237.2 5906.9 5999.3 6010.9 6014.1 6015.6 5283.5 5551.6 5558.3 5564.3 5564.7 6512.0 6546.9 6547.5 6562.5 6567.0 4571.1 4571.3 4573.3 4573.6 4573.9 6788.7 6867.4 6868.3 6881.3 6882.6 4662.7 4668.4 4671.7 4675.9 4681.8 4643.8 4732.6 4736.9 4737.1 4742.2 5369.2 5462.8 5473.8 5476.9 5480.5 6545.6 6568.3 6606.1 6618.1 6632.7 1559.9 1599.1 1642.1 1649.6 1650.3 1028.7 1067.5 1071.2 1076.7 1082.2 6154.1 6157.4 6158.1 6163.1 6167.9 6702.9 6710.3 6716.7 6727.4 6728.4 6207.5 6219.5 6219.9 6223.1 6237.3 3587.3 3626.5 3632.5 3633.4 3635.2 6774.7 6924.4 6929.8 6942.8 6943.4 6793.1 6798.3 6831.0 6840.3 6849.1 6888.4 6914.0 6918.3 6938.8 6938.9 6669.2 6696.5 6710.3 6721.8 6725.6 6487.9 6488.3 6607.5 6651.4 6659.9 6842.4 6913.0 6913.2 6915.8 6917.3 4647.2 4649.6 4658.1 4658.4 4663.1 6571.7 6600.4 6701.1 6708.9 6720.2 6693.5 6710.2 6739.9 6750.3 6752.6 6627.1 6635.3 6636.5 6640.8 6643.5 6508.9 6516.3 6520.2 6522.0 6534.3 6522.9 6647.0 6647.4 6656.1 6691.6 6492.3 6522.2 6528.8 6528.9 6541.2 03:59:37 INFO - PROCESS | 7603 | 03:59:37 INFO - PROCESS | 7603 | [#5] yui.html Cycles:180 Average:15827.16 Median:4845.86 stddev:18223.74 (376.1%) stddev-sans-first:18239.69 03:59:37 INFO - PROCESS | 7603 | Values: 749.0 822.0 873.4 898.2 901.3 15389.5 15439.5 15496.5 15508.5 15528.6 13867.8 13968.2 14015.1 14234.4 14298.2 778.3 893.3 894.9 913.2 914.5 905.9 909.2 910.1 910.7 912.1 940.6 945.5 946.4 946.6 947.6 799.0 942.2 943.6 969.8 970.3 695.1 698.8 698.8 699.2 699.5 14813.9 14831.8 14884.6 14888.0 14894.6 14481.6 15217.2 15392.5 15401.4 15423.0 11873.2 11908.8 11968.8 12025.8 12084.3 4167.6 4820.6 4823.4 4868.3 4890.6 59977.0 60152.0 60481.4 60819.4 61297.1 12284.8 12348.3 12383.8 12395.7 12488.8 21435.9 21531.0 21536.1 21549.9 21556.9 8937.5 8965.8 9009.8 9223.5 9301.8 4965.7 5100.1 5139.7 5206.2 5276.7 3542.3 3629.2 3633.6 3633.8 3638.3 625.0 632.7 634.4 636.3 663.2 730.7 767.1 780.1 782.9 792.1 9960.5 10196.1 10276.9 10430.7 10447.3 650.9 660.9 664.3 686.3 784.5 4621.8 4906.6 4954.1 4956.7 4998.4 65477.3 66151.7 66226.7 66370.0 66452.7 55416.7 55551.4 56162.7 56840.7 57136.1 50405.0 51997.0 52489.0 52901.2 53510.2 9777.6 9806.8 9807.7 9994.7 10001.8 37558.2 38205.2 38514.8 39762.2 39993.0 45941.8 46907.0 49438.0 49901.0 50239.2 11913.9 12130.5 12140.8 12199.7 12413.9 13144.3 13614.7 13628.5 13827.0 14068.5 12802.8 12963.4 13013.7 13182.1 13503.3 12598.7 12708.3 12906.6 12935.4 13351.7 12706.6 12762.0 12817.0 12929.4 13211.1 10698.1 10879.1 10913.5 11097.8 11123.9 10468.6 11210.0 11479.0 11617.8 11871.6 03:59:37 INFO - PROCESS | 7603 | -------- Summary: end -------- 03:59:37 INFO - PROCESS | 7603 | 03:59:38 INFO - TEST-INFO | 7603: exit 0 03:59:38 INFO - TEST-OK | dromaeo_css | took 1110577ms 03:59:38 INFO - TEST-START | kraken 03:59:38 INFO - operating with platform_type : linux_ 03:59:38 INFO - Initialising browser for kraken test... 03:59:38 INFO - TEST-INFO | started process 7792 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1dOXzp/profile http://localhost:36409/getInfo.html) 03:59:42 INFO - PROCESS | 7792 | __metrics Screen width/height:1600/1200 03:59:42 INFO - PROCESS | 7792 | colorDepth:24 03:59:42 INFO - PROCESS | 7792 | Browser inner width/height: 1024/697 03:59:42 INFO - PROCESS | 7792 | __metrics 03:59:43 ERROR - PROCESS | 7792 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:59:43 INFO - TEST-INFO | 7792: exit 0 03:59:43 INFO - Browser initialized. 03:59:43 INFO - Running cycle 1/1 for kraken test... 03:59:43 INFO - TEST-INFO | started process 7883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1dOXzp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:55 INFO - PROCESS | 7883 | RSS: Main: 142266368 03:59:55 INFO - PROCESS | 7883 | 03:59:58 INFO - PROCESS | 7883 | Cycle 1(1): loaded http://localhost:36409/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36409/tests/kraken/driver.html?testName=audio-beat-detection) 03:59:58 INFO - PROCESS | 7883 | RSS: Main: 197038080 03:59:58 INFO - PROCESS | 7883 | 04:00:01 INFO - PROCESS | 7883 | Cycle 1(1): loaded http://localhost:36409/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36409/tests/kraken/driver.html?testName=audio-dft) 04:00:02 INFO - PROCESS | 7883 | RSS: Main: 182304768 04:00:02 INFO - PROCESS | 7883 | 04:00:05 INFO - PROCESS | 7883 | Cycle 1(1): loaded http://localhost:36409/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36409/tests/kraken/driver.html?testName=audio-fft) 04:00:05 INFO - PROCESS | 7883 | RSS: Main: 272334848 04:00:05 INFO - PROCESS | 7883 | 04:00:07 INFO - PROCESS | 7883 | Cycle 1(1): loaded http://localhost:36409/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36409/tests/kraken/driver.html?testName=audio-oscillator) 04:00:08 INFO - PROCESS | 7883 | RSS: Main: 178757632 04:00:08 INFO - PROCESS | 7883 | 04:00:10 INFO - PROCESS | 7883 | Cycle 1(1): loaded http://localhost:36409/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36409/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:00:11 INFO - PROCESS | 7883 | RSS: Main: 177577984 04:00:11 INFO - PROCESS | 7883 | 04:00:14 INFO - PROCESS | 7883 | Cycle 1(1): loaded http://localhost:36409/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36409/tests/kraken/driver.html?testName=imaging-darkroom) 04:00:14 INFO - PROCESS | 7883 | RSS: Main: 211427328 04:00:14 INFO - PROCESS | 7883 | 04:00:18 INFO - PROCESS | 7883 | Cycle 1(1): loaded http://localhost:36409/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36409/tests/kraken/driver.html?testName=imaging-desaturate) 04:00:18 INFO - PROCESS | 7883 | RSS: Main: 212021248 04:00:18 INFO - PROCESS | 7883 | 04:00:21 INFO - PROCESS | 7883 | Cycle 1(1): loaded http://localhost:36409/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36409/tests/kraken/driver.html?testName=json-parse-financial) 04:00:22 INFO - PROCESS | 7883 | RSS: Main: 211660800 04:00:22 INFO - PROCESS | 7883 | 04:00:23 INFO - PROCESS | 7883 | Cycle 1(1): loaded http://localhost:36409/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36409/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:00:24 INFO - PROCESS | 7883 | RSS: Main: 190689280 04:00:24 INFO - PROCESS | 7883 | 04:00:26 INFO - PROCESS | 7883 | Cycle 1(1): loaded http://localhost:36409/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36409/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:00:26 INFO - PROCESS | 7883 | RSS: Main: 194048000 04:00:26 INFO - PROCESS | 7883 | 04:00:28 INFO - PROCESS | 7883 | Cycle 1(1): loaded http://localhost:36409/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36409/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:00:29 INFO - PROCESS | 7883 | RSS: Main: 205897728 04:00:29 INFO - PROCESS | 7883 | 04:00:31 INFO - PROCESS | 7883 | Cycle 1(1): loaded http://localhost:36409/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:00:32 INFO - PROCESS | 7883 | RSS: Main: 210296832 04:00:32 INFO - PROCESS | 7883 | 04:00:34 INFO - PROCESS | 7883 | Cycle 1(1): loaded http://localhost:36409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:00:35 INFO - PROCESS | 7883 | RSS: Main: 208510976 04:00:35 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | Cycle 1(1): loaded http://localhost:36409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36409/tests/kraken/driver.html?testName=ai-astar) 04:00:37 INFO - PROCESS | 7883 | RSS: Main: 272101376 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | __start_tp_report 04:00:37 INFO - PROCESS | 7883 | _x_x_mozilla_page_load 04:00:37 INFO - PROCESS | 7883 | _x_x_mozilla_page_load_details 04:00:37 INFO - PROCESS | 7883 | |i|pagename|runs| 04:00:37 INFO - PROCESS | 7883 | |0;ai-astar;112;111;110;111;111;111;106;110;110;110 04:00:37 INFO - PROCESS | 7883 | |1;audio-beat-detection;160;135;163;189;130;161;154;130;180;130 04:00:37 INFO - PROCESS | 7883 | |2;audio-dft;161;161;162;161;161;161;160;161;160;160 04:00:37 INFO - PROCESS | 7883 | |3;audio-fft;76;75;76;175;75;76;75;77;169;76 04:00:37 INFO - PROCESS | 7883 | |4;audio-oscillator;92;92;161;92;92;92;152;93;93;141 04:00:37 INFO - PROCESS | 7883 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;117 04:00:37 INFO - PROCESS | 7883 | |6;imaging-darkroom;157;165;163;163;166;157;168;155;160;161 04:00:37 INFO - PROCESS | 7883 | |7;imaging-desaturate;95;94;95;94;95;94;96;96;94;95 04:00:37 INFO - PROCESS | 7883 | |8;json-parse-financial;56;56;56;55;55;56;55;75;65;54 04:00:37 INFO - PROCESS | 7883 | |9;json-stringify-tinderbox;58;58;58;58;58;59;59;58;58;59 04:00:37 INFO - PROCESS | 7883 | |10;stanford-crypto-aes;74;74;73;81;74;74;75;74;74;74 04:00:37 INFO - PROCESS | 7883 | |11;stanford-crypto-ccm;122;114;114;113;116;115;113;118;137;116 04:00:37 INFO - PROCESS | 7883 | |12;stanford-crypto-pbkdf2;157;155;163;156;158;158;158;157;160;158 04:00:37 INFO - PROCESS | 7883 | |13;stanford-crypto-sha256-iterative;68;68;68;67;67;66;66;66;66;65 04:00:37 INFO - PROCESS | 7883 | __end_tp_report 04:00:37 INFO - PROCESS | 7883 | __start_cc_report 04:00:37 INFO - PROCESS | 7883 | _x_x_mozilla_cycle_collect,1598 04:00:37 INFO - PROCESS | 7883 | __end_cc_report 04:00:37 INFO - PROCESS | 7883 | __startTimestamp1464778837521__endTimestamp 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | ------- Summary: start ------- 04:00:37 INFO - PROCESS | 7883 | Number of tests: 14 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.62 (1.5%) stddev-sans-first:1.58 04:00:37 INFO - PROCESS | 7883 | Values: 112.0 111.0 110.0 111.0 111.0 111.0 106.0 110.0 110.0 110.0 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:160.50 stddev:21.47 (13.4%) stddev-sans-first:22.63 04:00:37 INFO - PROCESS | 7883 | Values: 160.0 135.0 163.0 189.0 130.0 161.0 154.0 130.0 180.0 130.0 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 04:00:37 INFO - PROCESS | 7883 | Values: 161.0 161.0 162.0 161.0 161.0 161.0 160.0 161.0 160.0 160.0 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:40.61 (53.4%) stddev-sans-first:42.49 04:00:37 INFO - PROCESS | 7883 | Values: 76.0 75.0 76.0 175.0 75.0 76.0 75.0 77.0 169.0 76.0 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.00 stddev:28.91 (31.4%) stddev-sans-first:29.92 04:00:37 INFO - PROCESS | 7883 | Values: 92.0 92.0 161.0 92.0 92.0 92.0 152.0 93.0 93.0 141.0 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:00:37 INFO - PROCESS | 7883 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | [#6] imaging-darkroom Cycles:10 Average:161.50 Median:163.00 stddev:4.28 (2.6%) stddev-sans-first:4.21 04:00:37 INFO - PROCESS | 7883 | Values: 157.0 165.0 163.0 163.0 166.0 157.0 168.0 155.0 160.0 161.0 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 04:00:37 INFO - PROCESS | 7883 | Values: 95.0 94.0 95.0 94.0 95.0 94.0 96.0 96.0 94.0 95.0 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:56.00 stddev:6.63 (11.8%) stddev-sans-first:6.98 04:00:37 INFO - PROCESS | 7883 | Values: 56.0 56.0 56.0 55.0 55.0 56.0 55.0 75.0 65.0 54.0 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:00:37 INFO - PROCESS | 7883 | Values: 58.0 58.0 58.0 58.0 58.0 59.0 59.0 58.0 58.0 59.0 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.00 stddev:2.26 (3.1%) stddev-sans-first:2.39 04:00:37 INFO - PROCESS | 7883 | Values: 74.0 74.0 73.0 81.0 74.0 74.0 75.0 74.0 74.0 74.0 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:116.00 stddev:7.27 (6.3%) stddev-sans-first:7.55 04:00:37 INFO - PROCESS | 7883 | Values: 122.0 114.0 114.0 113.0 116.0 115.0 113.0 118.0 137.0 116.0 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:158.00 stddev:2.21 (1.4%) stddev-sans-first:2.32 04:00:37 INFO - PROCESS | 7883 | Values: 157.0 155.0 163.0 156.0 158.0 158.0 158.0 157.0 160.0 158.0 04:00:37 INFO - PROCESS | 7883 | 04:00:37 INFO - PROCESS | 7883 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.06 (1.6%) stddev-sans-first:1.01 04:00:37 INFO - PROCESS | 7883 | Values: 68.0 68.0 68.0 67.0 67.0 66.0 66.0 66.0 66.0 65.0 04:00:37 INFO - PROCESS | 7883 | -------- Summary: end -------- 04:00:37 INFO - PROCESS | 7883 | 04:00:38 INFO - TEST-INFO | 7883: exit 0 04:00:38 INFO - TEST-OK | kraken | took 59912ms 04:00:38 INFO - SUITE-END | took 1170s 04:00:38 INFO - Completed test suite (00:19:30) 04:00:38 INFO - javascript benchmark 04:00:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3234.336960923011, 3276.7870088444242, 3283.261266215102, 3310.8841190558337, 3330.2173989112553, 5289.523942845148, 5302.045631786277, 5309.654872433294, 5325.733713314338, 5340.652857564261, 5318.30861987942, 5324.307839980797, 5327.121025030865, 5332.33345831771, 5335.546478549319, 4766.928496072562, 4811.59101476375, 4892.68197567157, 4966.6771659842, 4971.080350135218, 4860.027994401116, 4951.777170027357, 4968.826091086813, 4969.726665033421, 4972.154733695281, 4872.244802055687, 4917.926231106536, 4935.5804756595735, 4939.678920870132, 4953.108440480712, 4912.950870491285, 4934.309196712463, 4947.035328110984, 4948.208286674115, 4973.975130124344, 4821.132196204681, 4847.248676455155, 4882.658213925027, 4897.020595880838, 4944.554990050912, 5285.312909321802, 5312.2828418163435, 5333.546648534879, 5344.759485823147, 5347.6256662033675, 5663.377028526858, 5720.856978575569, 5722.856928576777, 5724.885502289931, 5731.0, 5715.199872017921, 5765.538756899438, 5789.768409263666, 5833.183354330397, 5837.416258374171, 5397.163439666858, 5404.945950540523, 5447.591430642718, 5447.727613619343, 5451.073317535949, 5793.478586927196, 5916.437938395846, 5916.49709774674, 5923.466887980103, 5924.911126333109, 5640.633358831663, 5679.432056794288, 5687.03320435527, 5693.117566777156, 5730.627509211888, 5709.8287051388525, 5729.684867332254, 5731.111677689964, 5731.570132240098, 5735.713214339266, 5637.295338082739, 5686.0, 5695.401982791747, 5697.914531282034, 5703.771849126071, 5758.107493338455, 5779.479846813807, 5781.219535362757, 5789.160571717078, 5819.359870414251, 4425.690201685916, 4431.224535706303, 4435.35687325336, 4437.0, 4462.486814016364, 3891.1439483313625, 3938.8030598469963, 3988.142549351903, 3992.2614316350987, 4035.354343305116, 5465.0, 5482.068048431776, 5488.80789172385, 5491.36849262332, 5493.478119578634, 5806.361300256968, 5812.709364531841, 5813.069908814569, 5817.069268916953, 5822.039363505059, 5351.0, 5399.541039011728, 5468.589855760833, 5493.615446918758, 5506.669599824023, 4979.950200497949, 5010.749462526859, 5013.423456302572, 5015.448300686921, 5047.899042019139, 5868.530517558585, 5970.373110823388, 5976.491998180203, 5984.670843103671, 5984.970075149684, 5679.204911312419, 5692.6299790513485, 5748.195252664714, 5777.508911742549, 5778.768849246151, 5991.520678345635, 5994.430529099728, 5997.13041608973, 6006.009008513546, 6010.939890601038, 5513.696746678971, 5731.885362292647, 5733.369329373849, 5734.426557344399, 5739.971300143473, 5781.768729250783, 5843.211166492639, 5847.473727364558, 5850.912236316373, 5888.646681199141, 5626.071698169756, 5637.8590535236945, 5647.237622920853, 5647.576431767552, 5687.914681279702, 5400.0, 5531.557475401878, 5636.689982050862, 5645.717714114196, 5645.802396916089, 5471.316085489314, 5491.725413729378, 5516.9448305516435, 5526.309211348582, 5562.276904002454, 5547.611667183259, 5563.054280772198, 5567.192757050124, 5602.775888964559, 5606.887862242814, 5486.643368181215, 5506.752196151103, 5564.4713752193475, 5565.5825813063375, 5650.23721797552], "value": 5320.47828717596, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.242111465652, 642.3801032004116, 651.150248925153, 652.481277384479, 659.6767583883897, 32847.1788205295, 33683.66316336836, 33781.0, 33833.492497612555, 33842.66157338429, 33483.83258083712, 39423.80288098555, 40050.19899602013, 40067.398989015186, 40073.0, 8887.822243555142, 9006.729798106067, 9019.95490022549, 9040.231580315682, 9041.095890410972, 8486.405951583361, 8734.825303493926, 8857.512836793974, 8859.29125669945, 8865.645374185026, 10712.303700259497, 10987.0, 10996.0, 11002.944985275102, 11032.944835275852, 10512.579496820117, 10596.5231564579, 10628.096611788007, 10630.999999999962, 10638.0, 8225.177482251787, 10272.79454410915, 10429.478526073666, 10512.842307365396, 10532.999365060306, 38952.80523597392, 39417.40873886894, 39426.802865985774, 39528.0, 39528.80235598804, 3887.8250478728523, 4006.559278479365, 4079.816408261606, 4202.600752928467, 4551.34005569194, 29920.401591968257, 31604.683953160406, 33053.66946330554, 34247.4862877057, 34377.0, 4426.336049592554, 4485.461744590637, 4485.663575231838, 4504.054148628792, 4567.634589232886, 311907.0, 313657.0, 313709.0, 314818.0, 315915.0, 65594.34405655978, 65847.0, 66081.6695916527, 66108.66945665241, 66185.0, 69754.65122674355, 69949.95075073878, 69991.65004174947, 70175.0, 70227.29772702309, 19060.71408928867, 19700.21199152018, 19703.42372610188, 19710.507237319183, 19713.112909919088, 14954.476593319181, 15000.474983375529, 15003.0, 15007.174605396589, 15007.174605396807, 18501.259949602136, 19904.104315305845, 20567.0, 20899.268525601532, 20901.686474702892, 7357.889631655529, 7388.44586656003, 7520.774376768706, 7586.734464293723, 7784.532928024337, 1058.116472745251, 1102.1843835561626, 1166.0671462829703, 1192.7316353820322, 1198.1732604502865, 32770.67229327724, 33564.160895977795, 33943.98168054962, 34265.65734342675, 35300.646993529735, 1154.2901115813881, 1172.9648110556698, 1203.4043148641304, 1203.5005472728894, 1303.2897071096274, 15389.923050384676, 16910.096072138942, 17492.47522574325, 17515.824841751673, 17595.0, 453364.0, 461775.0, 462337.0, 463036.0, 463116.0, 59090.40909590935, 59798.70100649469, 59818.40181598216, 60111.0, 60162.699186504666, 1504.9699006019819, 1508.6228442889278, 1511.093343993595, 1536.423841059625, 1609.235613083776, 29258.7074129256, 30663.84668076645, 32514.0, 33014.0, 33173.0, 52107.91568337224, 60332.69833650979, 61462.692686536284, 61628.691856540434, 61636.0, 422876.0, 426382.0, 428033.0, 429830.0, 430298.0, 37313.81343093267, 41661.79169104135, 46978.0, 46998.0, 47362.0, 43616.0, 48938.51061489482, 48949.2657610129, 50102.24846627231, 50505.0, 40107.0, 40247.79876100601, 41259.38110928278, 41470.792646037786, 41832.163356733305, 41443.7927810359, 41511.58488415077, 41538.792306038275, 41811.79094104632, 41925.0, 40683.0, 41366.0, 41979.37030944477, 42211.1557768849, 42660.78669606632, 35998.28003439864, 37034.259314814095, 37190.62809371872, 37802.62197377991, 37828.43257351197, 28169.464748172762, 28599.285017873888, 28735.425291493633, 28933.276668083465, 29041.7095829039], "value": 21153.800166024434, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.9477565304336, 426.6906492792726, 427.4955552448111, 433.6985794872565, 442.46240817406846, 18348.35780747674, 19134.904325478372, 19174.424767256987, 19784.505387365323, 20556.0, 18706.0, 18891.62216755664, 19107.235710571596, 19132.904335478303, 19144.0, 4717.315989181567, 5159.948400516003, 5371.409144994048, 5373.6775793452325, 5377.623566350357, 5222.817201397952, 5238.633295669305, 5278.736063196825, 5281.075811732951, 5299.735013249341, 5350.464953504638, 5355.250264962909, 5360.973195134019, 5588.91616625751, 5864.061750119981, 5712.457316554921, 5889.499392551638, 5907.232059832194, 5932.940670593303, 5937.079752638348, 5944.673042982634, 5945.048792193272, 5981.0, 5985.072313791369, 5993.130996005599, 23621.76378236213, 23946.16188433414, 23972.0, 24407.26778196657, 24431.755682443127, 2460.1143588308196, 2500.2999160235163, 2502.5245203411296, 2991.880324787006, 3026.561148633436, 10375.42935138567, 10634.62778802746, 11710.414479276002, 15228.543143705596, 15423.922880385639, 1921.3851567498407, 1956.0, 1958.0992743338081, 2000.3798822364968, 2037.7860324665844, 75678.62160689216, 76063.0, 76119.0, 77160.0, 78718.0, 11378.886211137948, 11536.538538458535, 11575.189736718517, 11581.0, 11789.0, 16307.918460407622, 16321.183940802912, 16365.754513682305, 16395.262213200196, 16424.1787910604, 8865.290776737846, 8873.201411872833, 8990.28077753778, 9143.77140571491, 9242.953785231166, 9012.27901767857, 9022.278217742565, 9036.548172591476, 9045.140711632384, 9125.726228213165, 4989.476105008922, 4991.3511243538105, 5028.346314979102, 5144.6398752087, 5159.071367153873, 1989.1347263940231, 2007.2874129684044, 2091.518950641331, 2115.862468939514, 2133.136079887648, 1018.3686114608989, 1027.9023492768174, 1037.5797801890246, 1045.1847558904067, 1096.6545538155456, 17503.190555954516, 18756.24975001012, 19535.706964395544, 20847.37457876266, 21023.68464473034, 1044.8798388185303, 1097.5664612478026, 1113.5991043224433, 1147.3632134165618, 1151.1021403305435, 10921.890781092246, 11418.31490110596, 11480.311181329147, 11625.24435911663, 11780.764384712258, 462115.0, 468289.0, 468733.0, 473006.0, 495597.0, 69248.0, 81950.59024704839, 83450.0, 90273.0, 93000.53499732458, 1061.490484567412, 1129.9209055366046, 1142.5429828068673, 1146.1003112556602, 1147.2829481574017, 16992.320307187572, 17046.31814727397, 17112.743308850128, 17428.564285892953, 17769.289228430716, 40477.190456190125, 41118.58881411148, 41329.380059299736, 41399.0, 42019.7899010503, 55284.0, 60965.39034609597, 60997.69501152466, 61866.0, 62461.68769156125, 12503.374831258583, 12730.23618582888, 12917.22496650204, 13003.674908127372, 13279.269640169883, 13793.655158621115, 13961.162330260217, 14100.435982560994, 14435.855641443452, 15203.315850786963, 9166.854143232096, 10005.399676019462, 11405.600803971822, 11544.19190656646, 13440.260785656492, 11931.522739090338, 12443.0, 12840.61478155657, 13152.408141633841, 13267.933660331637, 12253.571125010581, 12409.689757755767, 12609.93695031519, 12675.556355527513, 13134.868651313365, 12485.500579976699, 12594.937025314815, 12812.871871281168, 12926.159799612995, 12936.935315323362, 12444.502219911103, 12562.560310389457, 12772.42524086437, 12803.0, 13295.335233238106], "value": 9781.770201784146, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.1142103316968, 1568.396167475522, 1585.8017747781528, 1770.8848924819886, 1903.6002439487706, 7727.072751269849, 8335.041470230924, 8481.897353344057, 8501.404901656879, 8511.361647876403, 8092.433529652927, 8198.1801819818, 8200.548969806674, 8217.6302066407, 8231.259186673198, 2093.822025127866, 2362.078789272185, 2383.4160630645515, 2386.8806559672034, 2444.4133407982135, 2403.627437747152, 2412.3969007748065, 2415.384077060356, 2419.6733440985504, 2420.3586049696846, 2322.6980492535945, 2376.192094687806, 2376.346504711201, 2378.6550950112223, 2387.0451819272344, 2108.0, 2322.5587138443725, 2371.9644205336936, 2379.4051487128218, 2384.0582969726947, 2317.9072837086665, 2357.3752955466816, 2379.8334116611845, 2389.6773935518654, 2391.1511413448147, 8449.788755281106, 8524.914750852475, 8526.87209691855, 8530.232279094911, 8544.829103417958, 5138.10083235436, 5257.290265814143, 5262.447443018466, 5263.26314315996, 5270.604704647167, 3522.788632682047, 3558.928821423557, 3580.3018411409785, 3583.33708263972, 3594.155373487228, 1174.671092094215, 1201.0931746531312, 1208.788462019143, 1225.0689475998217, 1249.9125061245716, 12272.938635306766, 12289.56986505468, 12300.876991230063, 12327.630171094881, 12342.012638988948, 4512.593866552026, 4558.817647294071, 4578.198815207325, 4650.348951146842, 4708.128996135726, 10430.061294483381, 10445.216608754374, 10455.477226138662, 10459.84310235347, 10462.0, 4839.2983017462275, 5239.1355426354985, 5248.396434410015, 5249.42256351801, 5250.081235783722, 4782.0, 4826.710397376169, 4853.369062021915, 4859.052484765437, 4876.049170411736, 4095.262852686545, 4150.522689890641, 4258.978705106455, 4333.306670932636, 4333.891652708708, 1337.518493342396, 1361.101672895884, 1370.2189751841554, 1371.3897315694421, 1372.766629672958, 971.4899677669139, 1005.1506477026901, 1039.9012093851072, 1093.8796732359433, 1097.8133717268083, 6089.330173680892, 6102.923194402146, 6127.356627554132, 6141.57009009374, 6318.147050148263, 429.3195285472561, 431.44559241374685, 444.5621063252693, 454.4073024050681, 460.8548307283195, 4051.9392209116886, 4092.2224777292217, 4120.958790412057, 4145.440365550612, 4177.603127702863, 10037.247206459544, 10453.686389408178, 10471.16230701542, 10471.738206544896, 10488.056074953138, 10044.146247568893, 10218.080372766486, 10296.433696146783, 10316.071553560216, 10328.328658637314, 8104.432689711663, 8168.0, 8168.101508834024, 8183.304419124322, 8203.30271926881, 5943.64338139713, 6150.538709596709, 6162.691865406801, 6209.96895015522, 6252.374762523711, 9389.295802814953, 9710.223182145553, 9930.900690992998, 9959.502024898582, 9968.651097211563, 9786.0, 9855.063768941938, 10064.094231519199, 10072.0, 10077.0, 6748.325167483213, 7355.7057717690695, 7478.0, 7698.692052317844, 7799.376049916106, 8087.797805054921, 8136.633851476816, 8140.389470789596, 8184.345252379914, 8202.17978202175, 7215.927840721735, 7329.120505539369, 7414.555126692416, 7440.2931721486375, 7462.403007759258, 7280.959067717467, 7417.777466676009, 7540.54756714577, 7558.622068896643, 7651.158372579123, 7031.648417578998, 7049.682764275517, 7053.717851286096, 7080.433565314659, 7089.680964356719, 5028.321176641107, 5139.869228769665, 5173.249878767633, 5231.398389185292, 5239.947600524099, 5090.0, 5106.821261255838, 5109.1059064662795, 5110.821121260738, 5246.580273578181], "value": 4557.7952818992635, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.729168540224, 355.46325049175755, 360.5835260274383, 368.6368926607293, 369.30570527408486, 6030.0, 6156.261248650168, 6216.689165541722, 6218.129461875341, 6238.469730072944, 6136.938630613692, 6251.624902505853, 6257.0, 6269.090981807635, 6269.686515674221, 4775.713457192571, 4806.927896081562, 4814.66297359185, 4818.397700287464, 4825.276208568707, 4593.609543188833, 4680.485146633868, 4759.167145749498, 4813.831515896944, 4829.7585120744, 4739.0, 4765.046990601893, 4765.118453086173, 4794.35276237707, 4795.472498025214, 4776.856694299159, 4779.235322348442, 4784.138855006097, 4792.25720013395, 4797.8320758773625, 4224.66202703783, 4224.683148763855, 4231.534531201565, 4235.894102647428, 4237.216115018731, 5906.852328691774, 5999.340072592011, 6010.939890601082, 6014.0678194879865, 6015.608985415934, 5283.498067683564, 5551.583631227674, 5558.305211848519, 5564.276644036249, 5564.721763911788, 6512.0, 6546.9017964730565, 6547.5089368297095, 6562.507811914078, 6567.047778072153, 4571.085782843445, 4571.291449825282, 4573.314002899591, 4573.63410927125, 4573.908521829545, 6788.694508747119, 6867.416269617089, 6868.278830722802, 6881.277465866062, 6882.5870447773295, 4662.696924699883, 4668.3697700810635, 4671.743054131987, 4675.929861052087, 4681.765911704401, 4643.7684003925415, 4732.5977291929885, 4736.881577960509, 4737.076270127361, 4742.241241401359, 5369.24830523727, 5462.781488740406, 5473.75368108436, 5476.863078422992, 5480.451954804567, 6545.574537655132, 6568.310327415553, 6606.141201643852, 6618.106555615027, 6632.668366581652, 1559.9298031588605, 1599.1364663082038, 1642.0558179046857, 1649.5546202525252, 1650.3233674193523, 1028.717102796737, 1067.524951396621, 1071.212658695858, 1076.69852441315, 1082.242430298794, 6154.107654390088, 6157.4458298753325, 6158.076288556663, 6163.106349579376, 6167.876642467126, 6702.865942681216, 6710.261871194165, 6716.71631645243, 6727.428168605626, 6728.428083612947, 6207.472364848948, 6219.471344935731, 6219.875602487925, 6223.097650840603, 6237.313895471494, 3587.336342776595, 3626.546681664792, 3632.455131730209, 3633.436817293271, 3635.163912300186, 6774.695138718769, 6924.376806087476, 6929.757458488929, 6942.791716248521, 6943.444524438134, 6793.116894803644, 6798.286179951034, 6830.965845170842, 6840.281770414035, 6849.075374824335, 6888.448924086061, 6914.0, 6918.342757438036, 6938.757143499954, 6938.930610693828, 6669.166354205724, 6696.531242812956, 6710.295418981132, 6721.831954201184, 6725.630090344882, 6487.9026814598765, 6488.286288508166, 6607.504437167136, 6651.368120028589, 6659.866802664016, 6842.384185423336, 6913.0, 6913.170419549686, 6915.757948471779, 6917.27368626287, 4647.233206520887, 4649.628029757679, 4658.138244424792, 4658.37111989877, 4663.114008338405, 6571.737130514726, 6600.405963463311, 6701.061851340719, 6708.899366509604, 6720.1599800025, 6693.531452798257, 6710.228323742636, 6739.898901516579, 6750.25747167821, 6752.628605426552, 6627.105340778933, 6635.336466353326, 6636.535442519171, 6640.800775976729, 6643.534952553468, 6508.934910651023, 6516.250631177475, 6520.217573891164, 6521.9673901630185, 6534.313897040933, 6522.934770652233, 6647.0029495576055, 6647.401733843783, 6656.068150459037, 6691.5650482718465, 6492.31830657793, 6522.15212022434, 6528.771492997722, 6528.934710653023, 6541.247756508063], "value": 4951.744662878995, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.9513181643193, 822.0464261456711, 873.4366333714753, 898.2140626951417, 901.3465237702662, 15389.538313850588, 15439.536813895587, 15496.535103946871, 15508.5347439577, 15528.611784705374, 13867.791983120262, 13968.16191028539, 14015.089019213743, 14234.359453824576, 14298.213598252092, 778.307306497218, 893.3255392178896, 894.9373543851933, 913.2009491694768, 914.4741773480242, 905.9365844390895, 909.2407839454064, 910.1444642036498, 910.7449914024083, 912.115248209236, 940.6425558287841, 945.5461378538306, 946.394307643109, 946.6166202687888, 947.6304241345881, 799.0411506192563, 942.1614762861025, 943.6084025129563, 969.8108868770593, 970.3110791338158, 695.0720787748362, 698.7833771530791, 698.7938558125365, 699.1749735312329, 699.5138378826717, 14813.851861481355, 14831.77752333716, 14884.62788430287, 14888.032277901902, 14894.627634309121, 14481.637959051002, 15217.239138043053, 15392.461263855823, 15401.3839446422, 15423.0, 11873.228240164448, 11908.821367679406, 11968.82046769299, 12025.819612705816, 12084.335361555111, 4167.604077612622, 4820.6143508519235, 4823.372961515016, 4868.342773725537, 4890.584300334476, 59977.0, 60152.0, 60481.39518604846, 60819.39180608182, 61297.080543791875, 12284.754304913851, 12348.259104453762, 12383.814242786366, 12395.690107747198, 12488.75022499563, 21435.8928205358, 21531.0, 21536.13855445796, 21549.89225053896, 21556.89221553882, 8937.46375217489, 8965.775855603662, 9009.774755631031, 9223.492707900996, 9301.813963720822, 4965.677230979974, 5100.1074811907765, 5139.691618502902, 5206.167013277857, 5276.736163191902, 3542.326957877995, 3629.219717760694, 3633.5821380541047, 3633.818309084535, 3638.308721342936, 625.0093601641358, 632.6678493790797, 634.3973225435855, 636.2682914648099, 663.2439019517753, 730.6711979609197, 767.0871662721344, 780.0795061827099, 782.941279404047, 792.1009654042588, 9960.452175130438, 10196.133328666998, 10276.897231027595, 10430.739231519272, 10447.320924139907, 650.8958566629317, 660.8843452395812, 664.2892105447222, 686.306830101601, 784.5175217241356, 4621.792019359137, 4906.55840974314, 4954.133026720309, 4956.677815941952, 4998.350214472168, 65477.34522654808, 66151.66924165348, 66226.66886665633, 66370.0, 66452.67415640429, 55416.72291638597, 55551.44448555543, 56162.719186404625, 56840.71579642075, 57136.14295785566, 50405.0, 51996.97066326585, 52489.0, 52901.2064819028, 53510.19734703982, 9777.560009799718, 9806.80386392254, 9807.656732014346, 9994.650187243411, 10001.799964000533, 37558.2488350226, 38205.235895282494, 38514.80742596381, 39762.204755905295, 39993.0, 45941.77029114833, 46907.0, 49438.0, 49901.0, 50239.24641130313, 11913.880861191625, 12130.454129564367, 12140.817887731515, 12199.69500762488, 12413.875861241633, 13144.34278286101, 13614.727705446034, 13628.523001694894, 13827.0, 14068.507602233873, 12802.807957880454, 12963.41664625113, 13013.739725205633, 13182.077254592086, 13503.257320847448, 12598.685032874251, 12708.3010434427, 12906.612801615967, 12935.353232338157, 13351.732965340832, 12706.618801435972, 12762.0, 12817.0, 12929.353532323534, 13211.14127581704, 10698.090662293793, 10879.129669626253, 10913.508892100033, 11097.833532497181, 11123.944380278046, 10468.581256749949, 11210.0, 11478.95591357562, 11617.767644647229, 11871.584494542649], "value": 7234.600516029847, "unit": "score"}], "name": "dromaeo_css", "value": 7512.557492851552, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 110.0, 111.0, 111.0, 111.0, 106.0, 110.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 135.0, 163.0, 189.0, 130.0, 161.0, 154.0, 130.0, 180.0, 130.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0, 161.0, 160.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 175.0, 75.0, 76.0, 75.0, 77.0, 169.0, 76.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 161.0, 92.0, 92.0, 92.0, 152.0, 93.0, 93.0, 141.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 165.0, 163.0, 163.0, 166.0, 157.0, 168.0, 155.0, 160.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 96.0, 96.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 55.0, 55.0, 56.0, 55.0, 75.0, 65.0, 54.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 58.0, 59.0, 59.0, 58.0, 58.0, 59.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 81.0, 74.0, 74.0, 75.0, 74.0, 74.0, 74.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 114.0, 114.0, 113.0, 116.0, 115.0, 113.0, 118.0, 137.0, 116.0], "value": 117.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 163.0, 156.0, 158.0, 158.0, 158.0, 157.0, 160.0, 158.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 65.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1536.4, "alertThreshold": 2.0}]} 04:00:38 INFO - Return code: 0 04:00:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:00:38 ERROR - # TBPL SUCCESS # 04:00:38 INFO - Running post-action listener: _resource_record_post_action 04:00:38 INFO - Running post-run listener: _resource_record_post_run 04:00:39 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 510181376; Read time: 0; Write time: 548760 04:00:39 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 256557056; Read time: 0; Write time: 318696 04:00:39 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 251338752; Read time: 0; Write time: 229752 04:00:39 INFO - Running post-run listener: _upload_blobber_files 04:00:39 INFO - Blob upload gear active. 04:00:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:00:39 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 04:00:39 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'] 04:00:39 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 04:00:40 INFO - (blobuploader) - INFO - Open directory for files ... 04:00:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:00:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:00:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:41 INFO - (blobuploader) - INFO - Done attempting. 04:00:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:00:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:00:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:41 INFO - (blobuploader) - INFO - Done attempting. 04:00:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:00:41 INFO - Return code: 0 04:00:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:00:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:00:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0168125e30cf7f4f2c43478e6ab5cc89999f1c0bb75e5cb63f5541976d9d8e1ae7eaef3432421b0b0175d3e115d18b741850adb2fe552e8dbb2f81913f78bf91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7ed1c96df4daa59539fd20b45f62ad3d4f53c23eabbc536abc34e87bd9b985088351d3d5b04ee22c2648aafa8bdd221cafc16b4251a12c7da41e801421884b2"} 04:00:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:00:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:00:41 INFO - Contents: 04:00:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0168125e30cf7f4f2c43478e6ab5cc89999f1c0bb75e5cb63f5541976d9d8e1ae7eaef3432421b0b0175d3e115d18b741850adb2fe552e8dbb2f81913f78bf91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7ed1c96df4daa59539fd20b45f62ad3d4f53c23eabbc536abc34e87bd9b985088351d3d5b04ee22c2648aafa8bdd221cafc16b4251a12c7da41e801421884b2"} 04:00:41 INFO - Running post-run listener: copy_logs_to_upload_dir 04:00:41 INFO - Copying logs to upload dir... 04:00:41 INFO - mkdir: /builds/slave/test/build/upload/logs 04:00:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.487973 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-01 04:00:41.201883) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 04:00:41.206473) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364 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/0168125e30cf7f4f2c43478e6ab5cc89999f1c0bb75e5cb63f5541976d9d8e1ae7eaef3432421b0b0175d3e115d18b741850adb2fe552e8dbb2f81913f78bf91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7ed1c96df4daa59539fd20b45f62ad3d4f53c23eabbc536abc34e87bd9b985088351d3d5b04ee22c2648aafa8bdd221cafc16b4251a12c7da41e801421884b2"} build_url:https://queue.taskcluster.net/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/EzQysW2MTV6ObGxUh02nTA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0168125e30cf7f4f2c43478e6ab5cc89999f1c0bb75e5cb63f5541976d9d8e1ae7eaef3432421b0b0175d3e115d18b741850adb2fe552e8dbb2f81913f78bf91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7ed1c96df4daa59539fd20b45f62ad3d4f53c23eabbc536abc34e87bd9b985088351d3d5b04ee22c2648aafa8bdd221cafc16b4251a12c7da41e801421884b2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 04:00:41.235145) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 04:00:41.235466) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464777614.366118-2097019364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 04:00:41.320226) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 04:00:41.320529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 04:00:41.320840) ========= ========= Total master_lag: 0.21 =========