builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1462533711.85 results: success (0) buildid: 20160506013623 builduid: 3e330e94e72a44aabac68afc380e9ed1 revision: b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:51.855246) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:51.855734) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:51.856019) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:51.872054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:51.872340) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 04:21:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.9M=0s 2016-05-06 04:21:52 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134238 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:52.019639) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:52.019973) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014717 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:52.069400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 04:21:52.069802) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f --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 b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 04:21:52,176 truncating revision to first 12 chars 2016-05-06 04:21:52,176 Setting DEBUG logging. 2016-05-06 04:21:52,176 attempt 1/10 2016-05-06 04:21:52,176 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b61ad3a6049c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 04:21:53,240 unpacking tar archive at: mozilla-aurora-b61ad3a6049c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.388096 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 04:21:53.471417) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:53.471822) ========= script_repo_revision: b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:53.472309) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:53.472658) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:53.482600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-06 04:21:53.482891) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:21:53 INFO - MultiFileLogger online at 20160506 04:21:53 in /builds/slave/test 04:21:53 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 04:21:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:21:53 INFO - {'append_to_log': False, 04:21:53 INFO - 'base_work_dir': '/builds/slave/test', 04:21:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:21:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:21:53 INFO - 'branch': 'Mozilla-Aurora', 04:21:53 INFO - 'buildbot_json_path': 'buildprops.json', 04:21:53 INFO - 'config_files': ('talos/linux_config.py',), 04:21:53 INFO - 'default_actions': ('clobber', 04:21:53 INFO - 'read-buildbot-config', 04:21:53 INFO - 'download-and-extract', 04:21:53 INFO - 'populate-webroot', 04:21:53 INFO - 'create-virtualenv', 04:21:53 INFO - 'install', 04:21:53 INFO - 'run-tests'), 04:21:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:21:53 INFO - 'download_minidump_stackwalk': True, 04:21:53 INFO - 'download_symbols': 'ondemand', 04:21:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:21:53 INFO - 'tooltool.py': '/tools/tooltool.py', 04:21:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:21:53 INFO - '/tools/misc-python/virtualenv.py')}, 04:21:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:21:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:21:53 INFO - 'installer_path': 'installer.exe', 04:21:53 INFO - 'log_level': 'info', 04:21:53 INFO - 'log_name': 'talos', 04:21:53 INFO - 'log_to_console': True, 04:21:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:21:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:21:53 INFO - 'opt_config_files': (), 04:21:53 INFO - 'pip_index': False, 04:21:53 INFO - 'sps_profile': False, 04:21:53 INFO - 'sps_profile_interval': 0, 04:21:53 INFO - 'suite': 'dromaeojs', 04:21:53 INFO - 'system_bits': '32', 04:21:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:21:53 INFO - 'title': 'talos-linux64-ix-025', 04:21:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:21:53 INFO - 'use_talos_json': True, 04:21:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:21:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:21:53 INFO - 'work_dir': 'build'} 04:21:53 INFO - ##### 04:21:53 INFO - ##### Running clobber step. 04:21:53 INFO - ##### 04:21:53 INFO - Running pre-action listener: _resource_record_pre_action 04:21:53 INFO - Running main action method: clobber 04:21:53 INFO - rmtree: /builds/slave/test/build 04:21:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:21:54 INFO - Running post-action listener: _resource_record_post_action 04:21:54 INFO - ##### 04:21:54 INFO - ##### Running read-buildbot-config step. 04:21:54 INFO - ##### 04:21:54 INFO - Running pre-action listener: _resource_record_pre_action 04:21:54 INFO - Running main action method: read_buildbot_config 04:21:54 INFO - Using buildbot properties: 04:21:54 INFO - { 04:21:54 INFO - "project": "", 04:21:54 INFO - "product": "firefox", 04:21:54 INFO - "script_repo_revision": "production", 04:21:54 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:21:54 INFO - "repository": "", 04:21:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:21:54 INFO - "buildid": "20160506013623", 04:21:54 INFO - "pgo_build": "True", 04:21:54 INFO - "basedir": "/builds/slave/test", 04:21:54 INFO - "buildnumber": 222, 04:21:54 INFO - "slavename": "talos-linux64-ix-025", 04:21:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:21:54 INFO - "platform": "ubuntu64_hw", 04:21:54 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:21:54 INFO - "branch": "mozilla-aurora", 04:21:54 INFO - "repo_path": "releases/mozilla-aurora", 04:21:54 INFO - "revision": "b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f", 04:21:54 INFO - "stage_platform": "linux64-pgo", 04:21:54 INFO - "builduid": "3e330e94e72a44aabac68afc380e9ed1", 04:21:54 INFO - "slavebuilddir": "test" 04:21:54 INFO - } 04:21:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 04:21:54 INFO - Running post-action listener: _resource_record_post_action 04:21:54 INFO - ##### 04:21:54 INFO - ##### Running download-and-extract step. 04:21:54 INFO - ##### 04:21:54 INFO - Running pre-action listener: _resource_record_pre_action 04:21:54 INFO - Running main action method: download_and_extract 04:21:54 INFO - mkdir: /builds/slave/test/build/tests 04:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:54 INFO - https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:21:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:21:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:21:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:55 INFO - Downloaded 1361 bytes. 04:21:55 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:21:55 INFO - Using the following test package requirements: 04:21:55 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:21:55 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:21:55 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:21:55 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:55 INFO - u'jsshell-linux-x86_64.zip'], 04:21:55 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:21:55 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:21:55 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:21:55 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:21:55 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:21:55 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:21:55 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:21:55 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')]} 04:21:55 INFO - https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:21:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:21:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:21:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:56 INFO - Downloaded 23799377 bytes. 04:21:56 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'] 04:21:56 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 04:21:57 INFO - Return code: 0 04:21:57 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 04:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:57 INFO - https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:21:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:21:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:21:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:59 INFO - Downloaded 23799377 bytes. 04:21:59 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'] 04:21:59 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 04:22:00 INFO - Return code: 0 04:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:00 INFO - https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:22:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:22:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:22:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:22:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:22:01 INFO - Downloaded 10840145 bytes. 04:22:01 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'] 04:22:01 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 04:22:01 INFO - Return code: 0 04:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:01 INFO - https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:22:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:22:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:22:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:22:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:22:05 INFO - Downloaded 62706998 bytes. 04:22:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:22:05 INFO - mkdir: /builds/slave/test/properties 04:22:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:22:05 INFO - Writing to file /builds/slave/test/properties/build_url 04:22:05 INFO - Contents: 04:22:05 INFO - build_url:https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:22:05 INFO - Running post-action listener: _resource_record_post_action 04:22:05 INFO - Running post-action listener: set_extra_try_arguments 04:22:05 INFO - ##### 04:22:05 INFO - ##### Running populate-webroot step. 04:22:05 INFO - ##### 04:22:05 INFO - Running pre-action listener: _resource_record_pre_action 04:22:05 INFO - Running main action method: populate_webroot 04:22:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:22:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:22:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:22:05 INFO - '--tppagecycles', 04:22:05 INFO - '7'], 04:22:05 INFO - 'tests': ['tsvgm']}}, 04:22:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:22:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:22:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:22:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:22:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:22:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:22:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:05 INFO - 'talos_options': ['--disable-e10s'], 04:22:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:05 INFO - 'talos_options': ['--disable-e10s'], 04:22:05 INFO - 'tests': ['damp', 'tps']}, 04:22:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:05 INFO - 'tests': ['damp', 'tps']}, 04:22:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:22:05 INFO - 'tests': ['dromaeo_dom']}, 04:22:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:22:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:22:05 INFO - 'tests': ['a11yr', 04:22:05 INFO - 'ts_paint', 04:22:05 INFO - 'tpaint', 04:22:05 INFO - 'sessionrestore', 04:22:05 INFO - 'sessionrestore_no_auto_restore', 04:22:05 INFO - 'tabpaint']}, 04:22:05 INFO - 'other-e10s': {'tests': ['a11yr', 04:22:05 INFO - 'ts_paint', 04:22:05 INFO - 'tpaint', 04:22:05 INFO - 'sessionrestore', 04:22:05 INFO - 'sessionrestore_no_auto_restore', 04:22:05 INFO - 'tabpaint']}, 04:22:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:22:05 INFO - 'ts_paint', 04:22:05 INFO - 'tpaint', 04:22:05 INFO - 'sessionrestore', 04:22:05 INFO - 'sessionrestore_no_auto_restore', 04:22:05 INFO - 'tabpaint']}, 04:22:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:22:05 INFO - 'ts_paint', 04:22:05 INFO - 'tpaint', 04:22:05 INFO - 'sessionrestore', 04:22:05 INFO - 'sessionrestore_no_auto_restore', 04:22:05 INFO - 'tabpaint']}, 04:22:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:22:05 INFO - 'tests': ['a11yr', 04:22:05 INFO - 'ts_paint', 04:22:05 INFO - 'tpaint', 04:22:05 INFO - 'sessionrestore', 04:22:05 INFO - 'sessionrestore_no_auto_restore', 04:22:05 INFO - 'tabpaint']}, 04:22:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:22:05 INFO - 'tests': ['a11yr', 04:22:05 INFO - 'ts_paint', 04:22:05 INFO - 'tpaint', 04:22:05 INFO - 'sessionrestore', 04:22:05 INFO - 'sessionrestore_no_auto_restore', 04:22:05 INFO - 'tabpaint']}, 04:22:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:22:05 INFO - 'tests': ['tsvgx', 04:22:05 INFO - 'tsvgr_opacity', 04:22:05 INFO - 'tart', 04:22:05 INFO - 'tscrollx', 04:22:05 INFO - 'cart']}, 04:22:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:22:05 INFO - 'tsvgr_opacity', 04:22:05 INFO - 'tart', 04:22:05 INFO - 'tscrollx', 04:22:05 INFO - 'cart']}, 04:22:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:05 INFO - 'talos_options': ['--disable-e10s'], 04:22:05 INFO - 'tests': ['tp5o']}, 04:22:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:05 INFO - 'tests': ['tp5o']}, 04:22:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:05 INFO - 'talos_options': ['--disable-e10s', 04:22:05 INFO - '--xperf_path', 04:22:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:05 INFO - 'tests': ['tp5n']}, 04:22:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:05 INFO - 'talos_options': ['--xperf_path', 04:22:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:05 INFO - 'tests': ['tp5n']}}, 04:22:05 INFO - 'talos.zip': {'path': '', 04:22:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:22:05 INFO - Running post-action listener: _resource_record_post_action 04:22:05 INFO - ##### 04:22:05 INFO - ##### Running create-virtualenv step. 04:22:05 INFO - ##### 04:22:05 INFO - Running pre-action listener: _resource_record_pre_action 04:22:05 INFO - Running main action method: create_virtualenv 04:22:05 INFO - Creating virtualenv /builds/slave/test/build/venv 04:22:05 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 04:22:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:22:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:22:05 INFO - Using real prefix '/usr' 04:22:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:22:06 INFO - Installing distribute.............................................................................................................................................................................................done. 04:22:08 INFO - Installing pip.................done. 04:22:08 INFO - Return code: 0 04:22:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:08 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 0x7f8c2b6b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20495a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d8410>, '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 0x20d9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', '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 04:22:08 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 04:22:08 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 04:22:08 INFO - Using env: {'DISPLAY': ':0', 04:22:08 INFO - 'HOME': '/home/cltbld', 04:22:08 INFO - 'LANG': 'en_US.UTF-8', 04:22:08 INFO - 'LANGUAGE': 'en_US:en', 04:22:08 INFO - 'LOGNAME': 'cltbld', 04:22:08 INFO - 'MAIL': '/var/mail/cltbld', 04:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:08 INFO - 'MOZ_NO_REMOTE': '1', 04:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:08 INFO - 'NO_EM_RESTART': '1', 04:22:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:08 INFO - 'PWD': '/builds/slave/test', 04:22:08 INFO - 'SHELL': '/bin/bash', 04:22:08 INFO - 'SHLVL': '1', 04:22:08 INFO - 'TERM': 'linux', 04:22:08 INFO - 'TMOUT': '86400', 04:22:08 INFO - 'USER': 'cltbld', 04:22:08 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', 04:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:08 INFO - '_': '/tools/buildbot/bin/python'} 04:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:08 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 04:22:08 INFO - Cleaning up... 04:22:08 INFO - Return code: 0 04:22:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:08 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 0x7f8c2b6b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20495a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d8410>, '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 0x20d9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', '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 04:22:08 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 04:22:08 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 04:22:08 INFO - Using env: {'DISPLAY': ':0', 04:22:08 INFO - 'HOME': '/home/cltbld', 04:22:08 INFO - 'LANG': 'en_US.UTF-8', 04:22:08 INFO - 'LANGUAGE': 'en_US:en', 04:22:08 INFO - 'LOGNAME': 'cltbld', 04:22:08 INFO - 'MAIL': '/var/mail/cltbld', 04:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:08 INFO - 'MOZ_NO_REMOTE': '1', 04:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:08 INFO - 'NO_EM_RESTART': '1', 04:22:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:08 INFO - 'PWD': '/builds/slave/test', 04:22:08 INFO - 'SHELL': '/bin/bash', 04:22:08 INFO - 'SHLVL': '1', 04:22:08 INFO - 'TERM': 'linux', 04:22:08 INFO - 'TMOUT': '86400', 04:22:08 INFO - 'USER': 'cltbld', 04:22:08 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', 04:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:08 INFO - '_': '/tools/buildbot/bin/python'} 04:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:08 INFO - Downloading/unpacking psutil>=0.7.1 04:22:08 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 04:22:08 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 04:22:08 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 04:22:08 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 04:22:08 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 04:22:08 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 04:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:22:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:10 INFO - Installing collected packages: psutil 04:22:10 INFO - Running setup.py install for psutil 04:22:10 INFO - building 'psutil._psutil_linux' extension 04:22:10 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 04:22:11 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 04:22:11 INFO - building 'psutil._psutil_posix' extension 04:22:11 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 04:22:11 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 04:22:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:11 INFO - Successfully installed psutil 04:22:11 INFO - Cleaning up... 04:22:11 INFO - Return code: 0 04:22:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:22:11 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')]} 04:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:11 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')]} 04:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:11 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 0x7f8c2b6b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20495a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d8410>, '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 0x20d9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', '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 04:22:11 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 04:22:11 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 04:22:11 INFO - Using env: {'DISPLAY': ':0', 04:22:11 INFO - 'HOME': '/home/cltbld', 04:22:11 INFO - 'LANG': 'en_US.UTF-8', 04:22:11 INFO - 'LANGUAGE': 'en_US:en', 04:22:11 INFO - 'LOGNAME': 'cltbld', 04:22:11 INFO - 'MAIL': '/var/mail/cltbld', 04:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:11 INFO - 'MOZ_NO_REMOTE': '1', 04:22:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:11 INFO - 'NO_EM_RESTART': '1', 04:22:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:11 INFO - 'PWD': '/builds/slave/test', 04:22:11 INFO - 'SHELL': '/bin/bash', 04:22:11 INFO - 'SHLVL': '1', 04:22:11 INFO - 'TERM': 'linux', 04:22:11 INFO - 'TMOUT': '86400', 04:22:11 INFO - 'USER': 'cltbld', 04:22:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', 04:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:11 INFO - '_': '/tools/buildbot/bin/python'} 04:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:22:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:22:13 INFO - Installing collected packages: mozsystemmonitor 04:22:13 INFO - Running setup.py install for mozsystemmonitor 04:22:13 INFO - Successfully installed mozsystemmonitor 04:22:13 INFO - Cleaning up... 04:22:13 INFO - Return code: 0 04:22:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8c2b6b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20495a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d8410>, '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 0x20d9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', '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 04:22:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:22:13 INFO - Using env: {'DISPLAY': ':0', 04:22:13 INFO - 'HOME': '/home/cltbld', 04:22:13 INFO - 'LANG': 'en_US.UTF-8', 04:22:13 INFO - 'LANGUAGE': 'en_US:en', 04:22:13 INFO - 'LOGNAME': 'cltbld', 04:22:13 INFO - 'MAIL': '/var/mail/cltbld', 04:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:13 INFO - 'MOZ_NO_REMOTE': '1', 04:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:13 INFO - 'NO_EM_RESTART': '1', 04:22:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:13 INFO - 'PWD': '/builds/slave/test', 04:22:13 INFO - 'SHELL': '/bin/bash', 04:22:13 INFO - 'SHLVL': '1', 04:22:13 INFO - 'TERM': 'linux', 04:22:13 INFO - 'TMOUT': '86400', 04:22:13 INFO - 'USER': 'cltbld', 04:22:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', 04:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:13 INFO - '_': '/tools/buildbot/bin/python'} 04:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:13 INFO - Downloading/unpacking blobuploader==1.2.4 04:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:15 INFO - Downloading blobuploader-1.2.4.tar.gz 04:22:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:22:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:22:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:16 INFO - Downloading docopt-0.6.1.tar.gz 04:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:22:16 INFO - Installing collected packages: blobuploader, requests, docopt 04:22:16 INFO - Running setup.py install for blobuploader 04:22:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:22:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:22:16 INFO - Running setup.py install for requests 04:22:16 INFO - Running setup.py install for docopt 04:22:17 INFO - Successfully installed blobuploader requests docopt 04:22:17 INFO - Cleaning up... 04:22:17 INFO - Return code: 0 04:22:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:17 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 0x7f8c2b6b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20495a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d8410>, '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 0x20d9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', '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 04:22:17 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 04:22:17 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 04:22:17 INFO - Using env: {'DISPLAY': ':0', 04:22:17 INFO - 'HOME': '/home/cltbld', 04:22:17 INFO - 'LANG': 'en_US.UTF-8', 04:22:17 INFO - 'LANGUAGE': 'en_US:en', 04:22:17 INFO - 'LOGNAME': 'cltbld', 04:22:17 INFO - 'MAIL': '/var/mail/cltbld', 04:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:17 INFO - 'MOZ_NO_REMOTE': '1', 04:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:17 INFO - 'NO_EM_RESTART': '1', 04:22:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:17 INFO - 'PWD': '/builds/slave/test', 04:22:17 INFO - 'SHELL': '/bin/bash', 04:22:17 INFO - 'SHLVL': '1', 04:22:17 INFO - 'TERM': 'linux', 04:22:17 INFO - 'TMOUT': '86400', 04:22:17 INFO - 'USER': 'cltbld', 04:22:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', 04:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:17 INFO - '_': '/tools/buildbot/bin/python'} 04:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:17 INFO - Running setup.py (path:/tmp/pip-B5w2Uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:17 INFO - Running setup.py (path:/tmp/pip-UWOHN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:17 INFO - Running setup.py (path:/tmp/pip-Ioh4oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:17 INFO - Running setup.py (path:/tmp/pip-u8xRx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:17 INFO - Running setup.py (path:/tmp/pip-csDNZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:17 INFO - Running setup.py (path:/tmp/pip-DjHWdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:17 INFO - Running setup.py (path:/tmp/pip-nYJxyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:17 INFO - Running setup.py (path:/tmp/pip-zIjPhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:17 INFO - Running setup.py (path:/tmp/pip-LkZ243-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:17 INFO - Running setup.py (path:/tmp/pip-dFozbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:17 INFO - Running setup.py (path:/tmp/pip-FV8ADw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:18 INFO - Running setup.py (path:/tmp/pip-zD5Smi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:18 INFO - Running setup.py (path:/tmp/pip-RaWqXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:18 INFO - Running setup.py (path:/tmp/pip-KT9lcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:18 INFO - Running setup.py (path:/tmp/pip-FgLTJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:18 INFO - Running setup.py (path:/tmp/pip-moomlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:18 INFO - Running setup.py (path:/tmp/pip-PHUqbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:22:18 INFO - Running setup.py install for manifestparser 04:22:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:22:18 INFO - Running setup.py install for mozcrash 04:22:18 INFO - Running setup.py install for mozdebug 04:22:18 INFO - Running setup.py install for mozdevice 04:22:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:22:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:22:18 INFO - Running setup.py install for mozfile 04:22:19 INFO - Running setup.py install for mozhttpd 04:22:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:22:19 INFO - Running setup.py install for mozinfo 04:22:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:22:19 INFO - Running setup.py install for mozInstall 04:22:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:22:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:22:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:22:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:22:19 INFO - Running setup.py install for mozleak 04:22:19 INFO - Running setup.py install for mozlog 04:22:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:22:19 INFO - Running setup.py install for moznetwork 04:22:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:22:19 INFO - Running setup.py install for mozprocess 04:22:19 INFO - Running setup.py install for mozprofile 04:22:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:22:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:22:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:22:19 INFO - Running setup.py install for mozrunner 04:22:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:22:19 INFO - Running setup.py install for mozscreenshot 04:22:20 INFO - Running setup.py install for moztest 04:22:20 INFO - Running setup.py install for mozversion 04:22:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:22:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:22:20 INFO - Cleaning up... 04:22:20 INFO - Return code: 0 04:22:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:20 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 0x7f8c2b6b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20495a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d8410>, '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 0x20d9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', '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 04:22:20 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 04:22:20 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 04:22:20 INFO - Using env: {'DISPLAY': ':0', 04:22:20 INFO - 'HOME': '/home/cltbld', 04:22:20 INFO - 'LANG': 'en_US.UTF-8', 04:22:20 INFO - 'LANGUAGE': 'en_US:en', 04:22:20 INFO - 'LOGNAME': 'cltbld', 04:22:20 INFO - 'MAIL': '/var/mail/cltbld', 04:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:20 INFO - 'MOZ_NO_REMOTE': '1', 04:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:20 INFO - 'NO_EM_RESTART': '1', 04:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:20 INFO - 'PWD': '/builds/slave/test', 04:22:20 INFO - 'SHELL': '/bin/bash', 04:22:20 INFO - 'SHLVL': '1', 04:22:20 INFO - 'TERM': 'linux', 04:22:20 INFO - 'TMOUT': '86400', 04:22:20 INFO - 'USER': 'cltbld', 04:22:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', 04:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:20 INFO - '_': '/tools/buildbot/bin/python'} 04:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:20 INFO - Running setup.py (path:/tmp/pip-d3mL88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:20 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)) 04:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:20 INFO - Running setup.py (path:/tmp/pip-iyE1It-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:20 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)) 04:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:20 INFO - Running setup.py (path:/tmp/pip-reOfZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:20 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)) 04:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:20 INFO - Running setup.py (path:/tmp/pip-tmetce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:20 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)) 04:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:20 INFO - Running setup.py (path:/tmp/pip-f7XWu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:20 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)) 04:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:20 INFO - Running setup.py (path:/tmp/pip-_AsAWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:20 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)) 04:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:20 INFO - Running setup.py (path:/tmp/pip-x0H3Vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:21 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)) 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:21 INFO - Running setup.py (path:/tmp/pip-ZiP5KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:21 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)) 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:21 INFO - Running setup.py (path:/tmp/pip-X9WaTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:21 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)) 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:21 INFO - Running setup.py (path:/tmp/pip-2tM_6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:21 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)) 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:21 INFO - Running setup.py (path:/tmp/pip-MIFCTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:21 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)) 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:21 INFO - Running setup.py (path:/tmp/pip-fXri18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:21 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)) 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:21 INFO - Running setup.py (path:/tmp/pip-JD5M3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:21 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)) 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:21 INFO - Running setup.py (path:/tmp/pip-cWDkcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:21 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)) 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:21 INFO - Running setup.py (path:/tmp/pip-GRut8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:21 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)) 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:21 INFO - Running setup.py (path:/tmp/pip-9ywDZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:21 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)) 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:21 INFO - Running setup.py (path:/tmp/pip-eOcQip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:21 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)) 04:22:21 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)) 04:22:21 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)) 04:22:21 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)) 04:22:21 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)) 04:22:21 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)) 04:22:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:22:21 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 04:22:21 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 04:22:21 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 04:22:21 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 04:22:21 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 04:22:21 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 04:22:23 INFO - Downloading blessings-1.6.tar.gz 04:22:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:22:23 INFO - Installing collected packages: blessings 04:22:23 INFO - Running setup.py install for blessings 04:22:23 INFO - Successfully installed blessings 04:22:23 INFO - Cleaning up... 04:22:23 INFO - Return code: 0 04:22:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:22:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:24 INFO - Reading from file tmpfile_stdout 04:22:24 INFO - Current package versions: 04:22:24 INFO - argparse == 1.2.1 04:22:24 INFO - blessings == 1.6 04:22:24 INFO - blobuploader == 1.2.4 04:22:24 INFO - docopt == 0.6.1 04:22:24 INFO - manifestparser == 1.1 04:22:24 INFO - mozInstall == 1.12 04:22:24 INFO - mozcrash == 0.17 04:22:24 INFO - mozdebug == 0.1 04:22:24 INFO - mozdevice == 0.48 04:22:24 INFO - mozfile == 1.2 04:22:24 INFO - mozhttpd == 0.7 04:22:24 INFO - mozinfo == 0.9 04:22:24 INFO - mozleak == 0.1 04:22:24 INFO - mozlog == 3.1 04:22:24 INFO - moznetwork == 0.27 04:22:24 INFO - mozprocess == 0.22 04:22:24 INFO - mozprofile == 0.28 04:22:24 INFO - mozrunner == 6.11 04:22:24 INFO - mozscreenshot == 0.1 04:22:24 INFO - mozsystemmonitor == 0.0 04:22:24 INFO - moztest == 0.7 04:22:24 INFO - mozversion == 1.4 04:22:24 INFO - psutil == 3.1.1 04:22:24 INFO - requests == 1.2.3 04:22:24 INFO - wsgiref == 0.1.2 04:22:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:24 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 0x7f8c2b6b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20495a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d8410>, '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 0x20d9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', '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 04:22:24 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 04:22:24 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 04:22:24 INFO - Using env: {'DISPLAY': ':0', 04:22:24 INFO - 'HOME': '/home/cltbld', 04:22:24 INFO - 'LANG': 'en_US.UTF-8', 04:22:24 INFO - 'LANGUAGE': 'en_US:en', 04:22:24 INFO - 'LOGNAME': 'cltbld', 04:22:24 INFO - 'MAIL': '/var/mail/cltbld', 04:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:24 INFO - 'MOZ_NO_REMOTE': '1', 04:22:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:24 INFO - 'NO_EM_RESTART': '1', 04:22:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:24 INFO - 'PWD': '/builds/slave/test', 04:22:24 INFO - 'SHELL': '/bin/bash', 04:22:24 INFO - 'SHLVL': '1', 04:22:24 INFO - 'TERM': 'linux', 04:22:24 INFO - 'TMOUT': '86400', 04:22:24 INFO - 'USER': 'cltbld', 04:22:24 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', 04:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:24 INFO - '_': '/tools/buildbot/bin/python'} 04:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:24 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)) 04:22:24 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)) 04:22:24 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)) 04:22:24 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)) 04:22:24 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)) 04:22:24 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)) 04:22:24 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)) 04:22:24 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)) 04:22:24 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)) 04:22:24 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)) 04:22:24 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)) 04:22:24 INFO - Cleaning up... 04:22:24 INFO - Return code: 0 04:22:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:24 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 0x7f8c2b6b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20495a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d8410>, '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 0x20d9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', '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 04:22:24 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 04:22:24 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 04:22:24 INFO - Using env: {'DISPLAY': ':0', 04:22:24 INFO - 'HOME': '/home/cltbld', 04:22:24 INFO - 'LANG': 'en_US.UTF-8', 04:22:24 INFO - 'LANGUAGE': 'en_US:en', 04:22:24 INFO - 'LOGNAME': 'cltbld', 04:22:24 INFO - 'MAIL': '/var/mail/cltbld', 04:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:24 INFO - 'MOZ_NO_REMOTE': '1', 04:22:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:24 INFO - 'NO_EM_RESTART': '1', 04:22:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:24 INFO - 'PWD': '/builds/slave/test', 04:22:24 INFO - 'SHELL': '/bin/bash', 04:22:24 INFO - 'SHLVL': '1', 04:22:24 INFO - 'TERM': 'linux', 04:22:24 INFO - 'TMOUT': '86400', 04:22:24 INFO - 'USER': 'cltbld', 04:22:24 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', 04:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:24 INFO - '_': '/tools/buildbot/bin/python'} 04:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:24 INFO - Downloading/unpacking jsonschema 04:22:24 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 04:22:24 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 04:22:24 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 04:22:24 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 04:22:24 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 04:22:24 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 04:22:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:22:26 INFO - Downloading/unpacking functools32 (from jsonschema) 04:22:26 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 04:22:26 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 04:22:26 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 04:22:26 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 04:22:26 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 04:22:26 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 04:22:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:22:26 INFO - warning: no files found matching '*.txt' 04:22:26 INFO - no previously-included directories found matching 'build' 04:22:26 INFO - no previously-included directories found matching 'dist' 04:22:26 INFO - no previously-included directories found matching '.git*' 04:22:26 INFO - Installing collected packages: jsonschema, functools32 04:22:26 INFO - Running setup.py install for functools32 04:22:26 INFO - warning: no files found matching '*.txt' 04:22:26 INFO - no previously-included directories found matching 'build' 04:22:26 INFO - no previously-included directories found matching 'dist' 04:22:26 INFO - no previously-included directories found matching '.git*' 04:22:26 INFO - Successfully installed jsonschema functools32 04:22:26 INFO - Cleaning up... 04:22:26 INFO - Return code: 0 04:22:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:26 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 0x7f8c2b6b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20495a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d8410>, '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 0x20d9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', '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 04:22:26 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 04:22:26 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 04:22:26 INFO - Using env: {'DISPLAY': ':0', 04:22:26 INFO - 'HOME': '/home/cltbld', 04:22:26 INFO - 'LANG': 'en_US.UTF-8', 04:22:26 INFO - 'LANGUAGE': 'en_US:en', 04:22:26 INFO - 'LOGNAME': 'cltbld', 04:22:26 INFO - 'MAIL': '/var/mail/cltbld', 04:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:26 INFO - 'MOZ_NO_REMOTE': '1', 04:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:26 INFO - 'NO_EM_RESTART': '1', 04:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:26 INFO - 'PWD': '/builds/slave/test', 04:22:26 INFO - 'SHELL': '/bin/bash', 04:22:26 INFO - 'SHLVL': '1', 04:22:26 INFO - 'TERM': 'linux', 04:22:26 INFO - 'TMOUT': '86400', 04:22:26 INFO - 'USER': 'cltbld', 04:22:26 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', 04:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:26 INFO - '_': '/tools/buildbot/bin/python'} 04:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:27 INFO - Downloading/unpacking flake8 04:22:27 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 04:22:27 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 04:22:27 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 04:22:27 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 04:22:27 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 04:22:27 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 04:22:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:22:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:22:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:22:29 INFO - no previously-included directories found matching 'docs/_build' 04:22:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:22:29 INFO - Running setup.py install for pep8 04:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:22:29 INFO - no previously-included directories found matching 'docs/_build' 04:22:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:22:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:22:29 INFO - Cleaning up... 04:22:29 INFO - Return code: 0 04:22:29 INFO - Running post-action listener: _resource_record_post_action 04:22:29 INFO - Running post-action listener: _start_resource_monitoring 04:22:30 INFO - Starting resource monitoring. 04:22:30 INFO - ##### 04:22:30 INFO - ##### Running install step. 04:22:30 INFO - ##### 04:22:30 INFO - Running pre-action listener: _resource_record_pre_action 04:22:30 INFO - Running main action method: install 04:22:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:30 INFO - Reading from file tmpfile_stdout 04:22:30 INFO - Detecting whether we're running mozinstall >=1.0... 04:22:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:22:30 INFO - Reading from file tmpfile_stdout 04:22:30 INFO - Output received: 04:22:30 INFO - Usage: mozinstall [options] installer 04:22:30 INFO - Options: 04:22:30 INFO - -h, --help show this help message and exit 04:22:30 INFO - -d DEST, --destination=DEST 04:22:30 INFO - Directory to install application into. [default: 04:22:30 INFO - "/builds/slave/test"] 04:22:30 INFO - --app=APP Application being installed. [default: firefox] 04:22:30 INFO - mkdir: /builds/slave/test/build/application 04:22:30 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'] 04:22:30 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 04:22:46 INFO - Reading from file tmpfile_stdout 04:22:46 INFO - Output received: 04:22:46 INFO - /builds/slave/test/build/application/firefox/firefox 04:22:46 INFO - Running post-action listener: _resource_record_post_action 04:22:46 INFO - ##### 04:22:46 INFO - ##### Running run-tests step. 04:22:46 INFO - ##### 04:22:46 INFO - Running pre-action listener: _resource_record_pre_action 04:22:46 INFO - Running main action method: run_tests 04:22:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:22:46 INFO - Python 2.7.3 04:22:46 INFO - Return code: 0 04:22:46 INFO - grabbing minidump binary from tooltool 04:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:46 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 0x20d8410>, '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 0x20d9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:22:46 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 04:22:46 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 04:22:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:22:46 INFO - Return code: 0 04:22:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:22:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:22:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:22:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:22:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:22:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:22:47 INFO - Return code: 0 04:22:47 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/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:22:47 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/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:22:47 INFO - Using env: {'DISPLAY': ':0', 04:22:47 INFO - 'HOME': '/home/cltbld', 04:22:47 INFO - 'LANG': 'en_US.UTF-8', 04:22:47 INFO - 'LANGUAGE': 'en_US:en', 04:22:47 INFO - 'LOGNAME': 'cltbld', 04:22:47 INFO - 'MAIL': '/var/mail/cltbld', 04:22:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:22:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:47 INFO - 'MOZ_NO_REMOTE': '1', 04:22:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:47 INFO - 'NO_EM_RESTART': '1', 04:22:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:47 INFO - 'PWD': '/builds/slave/test', 04:22:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:22:47 INFO - 'SHELL': '/bin/bash', 04:22:47 INFO - 'SHLVL': '1', 04:22:47 INFO - 'TERM': 'linux', 04:22:47 INFO - 'TMOUT': '86400', 04:22:47 INFO - 'USER': 'cltbld', 04:22:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851', 04:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:47 INFO - '_': '/tools/buildbot/bin/python'} 04:22:47 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/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:22:47 INFO - mozversion application_buildid: 20160506013623 04:22:47 INFO - mozversion application_changeset: b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f 04:22:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:22:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:22:47 INFO - mozversion application_name: Firefox 04:22:47 INFO - mozversion application_remotingname: firefox-dev 04:22:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:22:47 INFO - mozversion application_vendor: Mozilla 04:22:47 INFO - mozversion application_version: 48.0a2 04:22:47 INFO - mozversion platform_buildid: 20160506013623 04:22:47 INFO - mozversion platform_changeset: b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f 04:22:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:22:47 INFO - mozversion platform_version: 48.0a2 04:22:47 INFO - using testdate: 1462533767 04:22:47 INFO - actual date: 1462533767 04:22:47 INFO - starting webserver on 'localhost:49575' 04:22:47 INFO - SUITE-START | Running 2 tests 04:22:47 INFO - TEST-START | dromaeo_css 04:22:47 INFO - operating with platform_type : linux_ 04:22:47 INFO - Initialising browser for dromaeo_css test... 04:22:47 INFO - TEST-INFO | started process 15538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplYrx8Y/profile http://localhost:49575/getInfo.html) 04:22:51 INFO - PROCESS | 15538 | __metrics Screen width/height:1600/1200 04:22:51 INFO - PROCESS | 15538 | colorDepth:24 04:22:51 INFO - PROCESS | 15538 | Browser inner width/height: 1024/697 04:22:51 INFO - PROCESS | 15538 | __metrics 04:22:52 ERROR - PROCESS | 15538 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:22:53 INFO - TEST-INFO | 15538: exit 0 04:22:53 INFO - Browser initialized. 04:22:53 INFO - Running cycle 1/1 for dromaeo_css test... 04:22:53 INFO - TEST-INFO | started process 15629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplYrx8Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:04 INFO - PROCESS | 15629 | RSS: Main: 141570048 04:23:04 INFO - PROCESS | 15629 | 04:23:55 INFO - PROCESS | 15629 | 1462533835923 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] 04:26:03 INFO - PROCESS | 15629 | Cycle 1(1): loaded http://localhost:49575/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49575/tests/dromaeo/cssquery-ext.html) 04:26:04 INFO - PROCESS | 15629 | RSS: Main: 250011648 04:26:04 INFO - PROCESS | 15629 | 04:29:06 INFO - PROCESS | 15629 | Cycle 1(1): loaded http://localhost:49575/tests/dromaeo/cssquery-ext.html (next: http://localhost:49575/tests/dromaeo/cssquery-jquery.html) 04:29:07 INFO - PROCESS | 15629 | RSS: Main: 231378944 04:29:07 INFO - PROCESS | 15629 | 04:32:09 INFO - PROCESS | 15629 | Cycle 1(1): loaded http://localhost:49575/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49575/tests/dromaeo/cssquery-mootools.html) 04:32:09 INFO - PROCESS | 15629 | RSS: Main: 220491776 04:32:09 INFO - PROCESS | 15629 | 04:35:11 INFO - PROCESS | 15629 | Cycle 1(1): loaded http://localhost:49575/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49575/tests/dromaeo/cssquery-prototype.html) 04:35:12 INFO - PROCESS | 15629 | RSS: Main: 216809472 04:35:12 INFO - PROCESS | 15629 | 04:38:14 INFO - PROCESS | 15629 | Cycle 1(1): loaded http://localhost:49575/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49575/tests/dromaeo/cssquery-yui.html) 04:38:15 INFO - PROCESS | 15629 | RSS: Main: 215543808 04:38:15 INFO - PROCESS | 15629 | 04:41:17 INFO - PROCESS | 15629 | Cycle 1(1): loaded http://localhost:49575/tests/dromaeo/cssquery-yui.html (next: http://localhost:49575/tests/dromaeo/cssquery-dojo.html) 04:41:17 INFO - PROCESS | 15629 | RSS: Main: 254595072 04:41:17 INFO - PROCESS | 15629 | 04:41:17 INFO - PROCESS | 15629 | __start_tp_report 04:41:17 INFO - PROCESS | 15629 | _x_x_mozilla_page_load 04:41:17 INFO - PROCESS | 15629 | _x_x_mozilla_page_load_details 04:41:17 INFO - PROCESS | 15629 | |i|pagename|runs| 04:41:17 INFO - PROCESS | 15629 | |0;dojo.html;3277.88527401541;3335.8332083395826;3351.463765797473;3363.142398688334;3382.1206486313567;5468.343798744157;5488.341399032117;5499.202615620738;5509.586780991427;5512.503874651291;5504.339479262484;5525.4474552544725;5525.778968841241;5546.611737178389;5579.888402231953;4945.233488809223;5009.148444764399;5075.568576670988;5085.262636917645;5147.330846989886;4949.183384741514;4965.577925876305;4995.950040499603;5001.14980453322;5002.7993281612335;4991.5258050485145;5069.087564238435;5099.056674515208;5105.821296254632;5126.871828204287;5053.69677819332;5079.415867175267;5083.6441449098575;5088.898222035576;5090.872728181788;4870.707757534559;4875.561199492027;4953.257011448276;4992.450830408652;5029.647924645276;5384.946150538483;5440.020796256672;5448.700321482317;5450.509454149106;5456.263404440429;5826.155207494932;5832.6792026438525;5833.82498525045;5836.970815145897;5846.41535846412;5866.325372582165;5871.295444546639;5969.70151492428;6010.909836352458;6036.034234522499;5395.082835917903;5427.592930530226;5454.59090568209;5471.425500322488;5474.206240095164;5879.706014699248;5957.851053723605;5958.493528050164;5962.880742385215;5992.041273396323;5568.053430916754;5648.265725455664;5666.716664166775;5672.858178545569;5693.857653558694;5880.647161170344;5881.911771323434;5895.705214739246;5898.705064746831;5903.498202652737;5685.857853553694;5810.302763668386;5855.970720146372;5873.970630146822;5876.294844618673;5899.439553242435;5902.822915312548;5913.2608423947;5914.526837852962;5942.6731529766275;4496.033352829158;4500.257457519538;4508.57168568992;4515.63874890008;4551.749653769075;3936.1143742658246;3964.940525892114;4005.2790497710107;4032.5967403259438;4075.449814275094;5445.727713614304;5462;5471.50756431923;5473.0969390051;5517.44825517445;5751.798687045934;5753.59724819267;5754.251947246831;5762.827115186551;5779.306483222041;5393.7303134843105;5492.231087647732;5502;5589;5590.24531688225;4879.560839524389;4920.507949205123;4931.334269873521;4941.061198372369;4946.678465899705;5843.707814609253;5878.265216847894;5915.319738230072;5917.142014407887;5918.496927761188;5624.184493248456;5862.501687356623;5889.293284805851;5922.289325280994;5931.822045338647;5966.731497082555;5966.820995370146;5976.641401515923;5978.133170690313;5986.700664966821;5666.03677374839;5670.659760414388;5679.801206957736;5694.544436444991;5696.487316141567;5793.507551858139;5829.446202610745;5841.415858414124;5844.94155058461;5893.351731309467;5693.686847223443;5704.657720536781;5721.084626459747;5721.742521586455;5733.197352370588;5645.887082258414;5650.547956163579;5700.2304688868135;5700.372958974426;5700.743466544099;5642.943570564242;5669.31968163823;5674.886502270014;5679.659220446786;5734.713264336683;5738.684372359393;5739.282589676291;5785.218995435731;5798.478136967693;5808.883822323445;5603.971980140073;5692.886142277049;5708.514776244066;5729.914051289151;5803.187553742564 04:41:17 INFO - PROCESS | 15629 | |1;ext.html;603.4237303375277;653.7123665587142;677.0352248046532;679.7552880962854;691.9515633905626;33287.50068748968;33933.321333573345;39821.99999999996;40350.59649403505;40422.79788601053;43008;43527;43652;43759.562404375945;43774;8084.1107478177355;8682.956585217082;8846.734597962071;8850.911490885106;8853;10477.26659133861;10826;10827.945860270727;10833.079188269006;10834.187435942336;10446.58213671456;10553.788924221511;10561.947190264038;10566.52450639723;10572.101371383442;10461.110805581535;10534.315269507457;10548.894511054945;10555.366677999345;10559.102476289525;10295.845562316572;10364.170866330676;10436.582536698523;10763.623273185402;10790.352578845215;41503.7924810374;41838.11728472226;41997.160056798995;42022.579774202175;42039.15921681549;3098.612673415823;3800.923981520382;3910.237503686782;3956.802159891994;4335.783210839477;29711;32476;32736.836315818506;32739.836300818344;33245.50131748002;4343.84796532123;4403.757793321366;4429.092036132585;4429.6899217054815;4465.129299786543;270828.64585676946;271423;272096;272313;273434;38370;56123;56915.14627280511;56995.14507282394;57050.714746426005;37620;37789.62210377916;37835.432468513;37846;37854.24291514154;16974.83025169757;17191.140442978052;17219.22513486896;17275;17309.221085051202;12590.740925907336;13274.800877986838;13476.797848032287;13553.39009744564;13577.52478663242;9038.367314287936;9107.453552786854;9166.312526560534;9210.493422861808;9221.354505184572;3572.1069732566857;3579.83890724918;3591.1381268495898;3620.5836328822525;3682.4844521766972;1134.750354921916;1152.8904754048351;1166.416791604198;1186.4957393107895;1285.607889593683;32717;33066;33161.50257746136;33402;33482.83258583691;1020.3418794877412;1021.2340744441668;1142.2232881640564;1237.7957636989795;1251.4232067594896;15751.527454176394;15835.366585336458;15979.12114833672;15979.365983864782;16268.51194464168;489160;492811;494844;495501;496291;55729.72135139298;56235.71882140563;56243.43756562464;56278;56307.71846140743;1371.5199680111882;1416.7037160997572;1500.4973333933256;1534.0872181052257;1586.1276298036034;29770.255743606584;30057.69942300549;30666.233344166576;31220.37559248848;31260.843695781376;46691.766541167075;47807.760961194974;47830.760846195546;47931.76034119807;47970.28044579264;282003;287297;288632;288871;289763;26661.466770664865;28220.294492637848;29466.852665736533;29727.554086688284;29894;43457;43708;43970.78014609907;44135.55864441315;44495.55504444914;36310.818445908655;36673;37339.25321493609;37573;37832.62167378401;36117;36505.452418213215;36674.08314792151;36741.63258367382;36755;39313;39748.40377394284;40150.59849401469;40522.59477405188;40787.59212407838;33812.323753525285;34658.82670586631;35010.474842876865;35085.68425957633;35153.64846351606;27530.724692752818;28048.29879253035;28108.71891281061;28233.479299363386;28306.575401368584 04:41:17 INFO - PROCESS | 15629 | |2;jquery.html;419.51965000074915;423.3987737412875;424.07551537647953;435.43828461284943;443.7293251116818;13549.59351219465;18163.273469061238;18739.594530410224;18767.906160469196;19515.609687806234;15750;18724.438266851983;19955.800441995576;20271.391858244275;20283.08726107325;5575.358833734122;5754.1944127822135;5772.682502462363;5781.566382521307;5785.681787501686;5729.799457019005;5753.510951569101;5758.251427314464;5765.394633563457;5768.942310576904;4303.117860838521;4446.666500012496;6034.939650603504;6438.098666186737;6443.710033048524;6280.214973128359;6290.465310448617;6294.937050629481;6295.118683384329;6347.587406818565;5586.329640443173;5678.886422271531;5701.600887937846;5715.31416230055;5717.885642287172;23947.281581552583;24208.757912420828;24323.756762432327;25013.874930625414;25167.496650066896;2677.651905252305;2745.2999485131363;2905.3172504461436;3041.8783248670024;3195.913389447599;12196.573119940847;14392.208428536427;15307.387704491806;15600.921995390065;15934;2044.1516770540356;2295.6900818389636;2495.46347535279;2542.275451496333;2573.3309339571847;84125.58832052574;87873.56063219707;88412.5579372099;88958.55520722484;89107;18140.727889081674;18312.725309120375;19010.80989190118;19055.61888762217;19081;33753.15617109592;33840.83079584586;34252;34293.82853085768;34375;10616.93830616932;11389.145814063813;11442.14183936208;11479.794621564783;11552.537898484135;9663.420194788336;9675.516224188763;9723.65967191145;9789.608415663437;9896.356736812084;7578.962105189439;8862.158094980967;9521.381110227952;9547.618095276111;9604.51977401141;3567.8929632111076;3583.33708263972;3590.3537363274863;3599.8200089995394;3614.5120408744483;945.3193700535603;1057.7831544533353;1058.0636137018794;1065.4566171252718;1137.5279259107378;18448.446546603624;18880.716789248174;18917;19367.515812104528;19485.02574871251;1031.298716872534;1061.0768631290825;1069.909057730086;1083.1876092930302;1099.483242875847;10077.748056298651;10268.64059757905;10377.014183652542;10413.53139108742;10643.563118978838;503028;504358;506769;517806;522345;94204;97487;97613;98626.37908756528;98881;1111.6164923101517;1119.0879433261866;1129.0346753525782;1130.1806190511813;1131.8585176852894;16606.335746570003;16810.915945420194;16821.990680559207;16929.91535042317;17108.48674539766;37528;38599.42100868545;38707.41938870863;39563.80218098891;39666.60333396629;55355.16967245414;57487.42512574821;57582;57602;57826.7108664454;8938.731838044869;8967.10328967098;9018.729438116867;9142.3600347975;9202.987671356012;10141.898581014095;13727.519536816562;13736.45054197861;13809.861901380858;14003.089799163023;11573.305601663928;12418.875811241773;12668.809967850306;12767.744645107232;12807.231566106064;12104.576339828063;12223.816642750544;12231.633051008484;12374.195677280948;12470.875291247334;12504.374781261082;12624;12662.493500259887;12827.166234194747;12838.16551924122;8861.556922153995;8884.955575222082;8963.103689630985;8996.01043885159;8997.955010224907;8877.467351958903;11116.722081948015;11837.289762614271;11945.820812687643;12170.330631815335 04:41:17 INFO - PROCESS | 15629 | |3;mootools.html;1426.3224968140141;1544.6061254380134;1567.4984005118367;1746.9650606987861;1880.078761406911;7495.362894153996;8228.876566851495;8381.95809020954;8383.329333653308;8393.664253429863;7958.602069896511;8141.674333026672;8146.551939643317;8149.4702844315225;8176.91823081769;2101.695254188142;2144.281665642012;2272.454610893386;2296.0815673730476;2296.5980953333183;2357.905683772647;2370.490344575916;2372.3357459911253;2375.9643605345846;2377.5720370333333;2253.763354847734;2267.2178098555974;2275.7369659838782;2369.4668699542553;2372.620380739082;2052.1688716070016;2269.466675331296;2278.646809744484;2282.2240438251074;2337.111897478947;2310.3992961829877;2352.9764702352927;2356.3873392917794;2358.929232123039;2359.044586942291;7994.2405471480115;8038.196180381915;8051.033875934867;8061.395395345373;8067.95966020172;5067.797288108472;5180.8963820723375;5196.558292545138;5213.139831927728;5226.895462090775;3368.4778859276853;3393.8472768725464;3499.947500787465;3516.4197907345256;3517.43721004638;982;1003.6085926488676;1134.659602119361;1144.3191301175787;1166.1661911733067;11910.880891191064;11939.104567157498;11958.58144964922;11999.160058795887;12036.879631203663;4426.690131690751;4590.288505281686;4605.217113090783;4635.536446355338;4694.882627934329;10108.191344692406;10109.29234953561;10156;10164.237682173718;10202.030807073315;5304.867378315495;5304.946950530522;5305.018571564273;5314.256004159421;5319.760610772524;4326.6538676905775;4693.647976401715;4725.787339569659;4781.163296423112;4887.560119589254;3930.272899513599;4038.394240863894;4063.593640635913;4067.6745860331102;4122.40225167349;1282.660095074806;1286.7040580666312;1290.2387591320978;1292.4894666606638;1303.7718399280088;970.3713287618023;978.4080631218153;985.8422652375585;1001.1940387987739;1012.336919317848;5590;5616.129499927518;5628.493435590816;5700.693677285754;5784.88430231393;417.8788151436049;418.7361961964004;420.459709273582;423.0396998812739;429.1974008603931;3866.574676785551;3896.6687831534637;3902.239063382613;3908.9804550977065;3918.686505079587;10303.124234440007;10700.89299106999;10751.139908807276;10759.83860242097;10803.081738052197;10614.681559553226;10623.946880265548;10632.946835265775;10633;10634.09610183143;7838.333741631911;8207.95896020516;8230.382721295926;8312.667493300321;8316.043654979634;5654.858628534155;5666;5763.567732420001;5797.8550536236935;5838.1826544282985;9352.438853668802;9357.57890894925;9573.042695730372;9598.712038638852;9659.372140810825;9549.952250238704;9552.42685438876;9688.079632434907;9764.267679923893;9872.851907221253;6953.965230173817;7311.926880731125;7432.554046757212;7442.1069471661585;7508.211637778173;8025.518468891885;8039.959800200962;8055.556944367881;8083.757487275391;8092.312153467021;7260;7411.295926886937;7510.286522780327;7515.6993720250575;7526.887096693445;6895.931040689529;6897.241303456515;6973.442124630119;7103.715851365888;7291.234420385783;6574.506911981525;6685.130932978682;6737.124173857367;6742.42689371409;6747.730090796314;4744.810207591658;4827.61379089679;4838.225883858566;4872.780724867461;4882.731449770296;5084.847454576368;5085.745712714275;5125.051865404912;5133.153029750049;5133.307003554472 04:41:17 INFO - PROCESS | 15629 | |4;prototype.html;331.70478274335846;333.2119537294299;336.71042903103324;339.8453703564878;339.8674516938393;6213.440790328869;6248.406401391866;6338.714757835897;6341.619502829833;6376.139221205136;6252.593581417216;6256.436920677138;6262.874742505159;6279;6283.371662833714;4545.068261006494;4642.442906851165;4749.786259618326;4764.332993380929;4773.928391074137;4738.384010078685;4741.668083234175;4764.118638051954;4766.142094423002;4769.332293478916;4481.0813783174535;4715.221988371914;4718.268668356411;4723.338732577442;4724.291356296549;4573.565511276423;4602.309653551961;4604.1482325769675;4688.953110468886;4690.0854333405;4106.67146628272;4119.237940980928;4119.8970025749295;4128.876133715993;4129.772862492562;5966.045432730785;6020.187274717945;6020.789272375446;6034.758609655652;6044.939550604482;5484.149956756709;5486.231927530149;5490.066688662897;5493.697846618435;5498.010358135534;6373.534087159933;6520.315366886503;6560.901586476207;6575.079488871562;6580.868382632369;4490.236659767815;4520.50274469808;4521.751303678297;4523.140603285398;4530.275155975029;6792.320767923217;6898.172219333662;6906.792796216121;6910.827229319257;6916.239213686541;4663.27719203524;4670.019295947821;4673.509281525391;4677.836275730333;4679.485256621769;4732.384789977281;4732.645051621143;4740.810367585258;4742.976285118552;4746.833860814924;5452.318460192476;5476.041692703761;5486.451354864482;5495.917561236584;5496.5053145217125;6502.642354670538;6636.568623039487;6641.933580664228;6649;6649.468042556584;1633.2813562032668;1662.4680102367126;1672.3059930128861;1676.0865328396053;1676.5892356372767;1030.577463240068;1074.5379486820586;1077.5151181968147;1091.1925175370168;1099.5217080569978;6285.120083188357;6413.134226879405;6441.645709486023;6518.511111666644;6523.7716679915975;6847.417969472551;6910.44716422695;6910.792676219721;6910.930890691129;6923.307669233036;6405.455536279468;6408.231012278463;6417.679116044179;6425.871482570323;6427.164468619049;3656.670899619047;3719.2891270015552;3719.7210209234418;3726.795026273581;3727.6086010968456;6945.617991010442;7086.114235720535;7095.254998225215;7116.893246601305;7156.427485801123;6957.652117394211;6960.79117626472;6961.303869612998;6988.580685158805;6991.545549539263;7108.07595012645;7120.572765633975;7123.964380178066;7126.643667816692;7133.964330178316;6875.724971001304;6878.931210687829;6879.174499060145;6885.724571017304;6889.483288753464;6598.934010660024;6775.728970841308;6782.728690852311;6795;6804.897926531205;7119.572825630479;7133.429325654039;7138.571685698875;7144.285571442814;7148.213696493485;4642.326862604971;4646.233371493666;4649.976750116228;4651.09303685778;4653.115907977473;6879.793606191823;6880.139982502187;6882.277360877036;6891.793246202622;6892.827679307857;6533.41199292066;6703.832404189934;6703.865922681422;6716.093327400738;6721.462283017249;6637.469002479694;6671.5997040177745;6681;6683.465322774069;6684.298148694317;6573.211214654272;6574.309697481695;6578.572392794453;6624.403803657694;6639.302873198438;6731.259561448139;6732.629705366252;6739.460843132636;6740;6749.223839258351;6433.163688720437;6566.277709452052;6585.407313341822;6587.341265873374;6599.472042236705 04:41:17 INFO - PROCESS | 15629 | |5;yui.html;873.5981448533674;874.1302404107913;915.8580420034892;925.4724806860092;928.7028150991683;13984.650383740387;14025.579232623038;14072.155670659768;14075.788863167061;15268.694626107472;13738.107023043494;13962.790558141636;14018.299085045732;14091.718165636681;14247.14517128973;863.5984267315681;870.9695160669378;873.1399571422176;879.4811061473729;879.551428771328;872.650939624149;880.4805164952677;881.964721411146;882.1134759566627;882.3779235638891;913.8720579118929;915.8397280475923;919.0533750237266;921.2906062332;923.9676611318605;910.0990019880304;911.6809116809097;917.298266825872;918.3020904112856;918.591226904028;671.4796033074358;674.6019848289533;675.2707076357522;675.5170053411834;676.4284179868004;13484.595462136152;13534.864651353459;13574.932125339408;13582.185068895798;13584.660383490393;12922.16005959619;13257.535986240435;13998.790018149735;14095;14222.857771422257;12385.98414992771;13013.804792928113;13056.21662700241;13085.28030958297;13287.800682989762;4067.6745860331102;4127.112670775768;4128.153728485683;4654.069186162747;4666.580007799281;50650.49349506495;54001.72999134979;54220.728896355264;57078.289911156055;57087.429125709044;11149.498272577754;11157.553697851996;11603.361815100081;11714.88285117155;11924;19820.60358792845;19853.404397868086;19899;19900.800991990185;19923.402297931087;8697.608607612672;8765.254953329038;8816.559172041372;8818.162274583905;9043.819123617492;4698.976505117453;4859.829905953275;4866.513348665105;4906.730129842822;4943.975280123648;3292.456744637156;3356.1274068741814;3358.1604598850286;3360.7479439042168;3364.2262279675324;648.9188851393576;652.6051738698114;654.1855390039336;664.3622122762202;672.1497305908031;640.8878446271884;662.3244290823429;692.9099217101846;720.477653701073;722.9096362954631;8586.914130858737;8922.509261990654;9149.725508234764;9350.859737103949;9589.668985033562;713.7680253917498;769.8768197088439;820.2822530285999;830.0993422136928;836.6318819719304;4206.8737937861915;4280.76455794928;4287.356896465555;4310.870673879788;4391.187630288407;59907.40092599018;60023;60432.69783651054;60909.695451523345;60929.39070609326;53195.20207196895;55509;55637.88724225574;55812.16281755777;55979.440205598235;50027.749861250464;50519.74740126276;50654.24018639723;50834;51112.233316500286;8573.22840944293;8653.480791152551;8764;8791.361204676095;8987.382271190987;36706;37176;37251;40212.798936005136;40337.79831100826;47579.76210118927;49174.75412622914;49238.75380623074;49709.254361183885;50853.23720144127;12780.680482988;12922;12927.935360323138;12983.091183617056;13170.07809453329;13701.383437745126;14145.787813182606;14176.858231417555;14433.855661443671;14940.252987350807;13254.867451325363;13266.336683165997;13268.402921868732;13411.731765364833;13448.1258718183;13081.149725267827;13160.670983225496;13559.932200338935;13580.45678172862;13757.518486852912;13056.34718264064;13341;13453.260070695815;13552;13561.525346612822;11422.885771142182;11447.771044578894;11626.53493860236;11673.299602023906;12116.818247726114;10885.455727213766;11211.943940280247;11390.145739069769;11450.82823757661;11527.423628818693 04:41:17 INFO - PROCESS | 15629 | __end_tp_report 04:41:17 INFO - PROCESS | 15629 | __start_cc_report 04:41:17 INFO - PROCESS | 15629 | _x_x_mozilla_cycle_collect,868 04:41:17 INFO - PROCESS | 15629 | __end_cc_report 04:41:17 INFO - PROCESS | 15629 | __startTimestamp1462534877807__endTimestamp 04:41:17 INFO - PROCESS | 15629 | 04:41:17 INFO - PROCESS | 15629 | ------- Summary: start ------- 04:41:17 INFO - PROCESS | 15629 | Number of tests: 6 04:41:17 INFO - PROCESS | 15629 | 04:41:17 INFO - PROCESS | 15629 | [#0] dojo.html Cycles:165 Average:5436.02 Median:5666.04 stddev:583.90 (10.3%) stddev-sans-first:560.61 04:41:17 INFO - PROCESS | 15629 | Values: 3277.9 3335.8 3351.5 3363.1 3382.1 5468.3 5488.3 5499.2 5509.6 5512.5 5504.3 5525.4 5525.8 5546.6 5579.9 4945.2 5009.1 5075.6 5085.3 5147.3 4949.2 4965.6 4996.0 5001.1 5002.8 4991.5 5069.1 5099.1 5105.8 5126.9 5053.7 5079.4 5083.6 5088.9 5090.9 4870.7 4875.6 4953.3 4992.5 5029.6 5384.9 5440.0 5448.7 5450.5 5456.3 5826.2 5832.7 5833.8 5837.0 5846.4 5866.3 5871.3 5969.7 6010.9 6036.0 5395.1 5427.6 5454.6 5471.4 5474.2 5879.7 5957.9 5958.5 5962.9 5992.0 5568.1 5648.3 5666.7 5672.9 5693.9 5880.6 5881.9 5895.7 5898.7 5903.5 5685.9 5810.3 5856.0 5874.0 5876.3 5899.4 5902.8 5913.3 5914.5 5942.7 4496.0 4500.3 4508.6 4515.6 4551.7 3936.1 3964.9 4005.3 4032.6 4075.4 5445.7 5462.0 5471.5 5473.1 5517.4 5751.8 5753.6 5754.3 5762.8 5779.3 5393.7 5492.2 5502.0 5589.0 5590.2 4879.6 4920.5 4931.3 4941.1 4946.7 5843.7 5878.3 5915.3 5917.1 5918.5 5624.2 5862.5 5889.3 5922.3 5931.8 5966.7 5966.8 5976.6 5978.1 5986.7 5666.0 5670.7 5679.8 5694.5 5696.5 5793.5 5829.4 5841.4 5844.9 5893.4 5693.7 5704.7 5721.1 5721.7 5733.2 5645.9 5650.5 5700.2 5700.4 5700.7 5642.9 5669.3 5674.9 5679.7 5734.7 5738.7 5739.3 5785.2 5798.5 5808.9 5604.0 5692.9 5708.5 5729.9 5803.2 04:41:17 INFO - PROCESS | 15629 | 04:41:17 INFO - PROCESS | 15629 | [#1] ext.html Cycles:180 Average:51081.87 Median:35048.08 stddev:96694.29 (275.9%) stddev-sans-first:96891.26 04:41:17 INFO - PROCESS | 15629 | Values: 603.4 653.7 677.0 679.8 692.0 33287.5 33933.3 39822.0 40350.6 40422.8 43008.0 43527.0 43652.0 43759.6 43774.0 8084.1 8683.0 8846.7 8850.9 8853.0 10477.3 10826.0 10827.9 10833.1 10834.2 10446.6 10553.8 10561.9 10566.5 10572.1 10461.1 10534.3 10548.9 10555.4 10559.1 10295.8 10364.2 10436.6 10763.6 10790.4 41503.8 41838.1 41997.2 42022.6 42039.2 3098.6 3800.9 3910.2 3956.8 4335.8 29711.0 32476.0 32736.8 32739.8 33245.5 4343.8 4403.8 4429.1 4429.7 4465.1 270828.6 271423.0 272096.0 272313.0 273434.0 38370.0 56123.0 56915.1 56995.1 57050.7 37620.0 37789.6 37835.4 37846.0 37854.2 16974.8 17191.1 17219.2 17275.0 17309.2 12590.7 13274.8 13476.8 13553.4 13577.5 9038.4 9107.5 9166.3 9210.5 9221.4 3572.1 3579.8 3591.1 3620.6 3682.5 1134.8 1152.9 1166.4 1186.5 1285.6 32717.0 33066.0 33161.5 33402.0 33482.8 1020.3 1021.2 1142.2 1237.8 1251.4 15751.5 15835.4 15979.1 15979.4 16268.5 489160.0 492811.0 494844.0 495501.0 496291.0 55729.7 56235.7 56243.4 56278.0 56307.7 1371.5 1416.7 1500.5 1534.1 1586.1 29770.3 30057.7 30666.2 31220.4 31260.8 46691.8 47807.8 47830.8 47931.8 47970.3 282003.0 287297.0 288632.0 288871.0 289763.0 26661.5 28220.3 29466.9 29727.6 29894.0 43457.0 43708.0 43970.8 44135.6 44495.6 36310.8 36673.0 37339.3 37573.0 37832.6 36117.0 36505.5 36674.1 36741.6 36755.0 39313.0 39748.4 40150.6 40522.6 40787.6 33812.3 34658.8 35010.5 35085.7 35153.6 27530.7 28048.3 28108.7 28233.5 28306.6 04:41:17 INFO - PROCESS | 15629 | 04:41:17 INFO - PROCESS | 15629 | [#2] jquery.html Cycles:180 Average:31062.50 Median:2973.60 stddev:84142.11 (2829.6%) stddev-sans-first:84346.69 04:41:17 INFO - PROCESS | 15629 | Values: 419.5 423.4 424.1 435.4 443.7 13549.6 18163.3 18739.6 18767.9 19515.6 15750.0 18724.4 19955.8 20271.4 20283.1 5575.4 5754.2 5772.7 5781.6 5785.7 5729.8 5753.5 5758.3 5765.4 5768.9 4303.1 4446.7 6034.9 6438.1 6443.7 6280.2 6290.5 6294.9 6295.1 6347.6 5586.3 5678.9 5701.6 5715.3 5717.9 23947.3 24208.8 24323.8 25013.9 25167.5 2677.7 2745.3 2905.3 3041.9 3195.9 12196.6 14392.2 15307.4 15600.9 15934.0 2044.2 2295.7 2495.5 2542.3 2573.3 84125.6 87873.6 88412.6 88958.6 89107.0 18140.7 18312.7 19010.8 19055.6 19081.0 33753.2 33840.8 34252.0 34293.8 34375.0 10616.9 11389.1 11442.1 11479.8 11552.5 9663.4 9675.5 9723.7 9789.6 9896.4 7579.0 8862.2 9521.4 9547.6 9604.5 3567.9 3583.3 3590.4 3599.8 3614.5 945.3 1057.8 1058.1 1065.5 1137.5 18448.4 18880.7 18917.0 19367.5 19485.0 1031.3 1061.1 1069.9 1083.2 1099.5 10077.7 10268.6 10377.0 10413.5 10643.6 503028.0 504358.0 506769.0 517806.0 522345.0 94204.0 97487.0 97613.0 98626.4 98881.0 1111.6 1119.1 1129.0 1130.2 1131.9 16606.3 16810.9 16822.0 16929.9 17108.5 37528.0 38599.4 38707.4 39563.8 39666.6 55355.2 57487.4 57582.0 57602.0 57826.7 8938.7 8967.1 9018.7 9142.4 9203.0 10141.9 13727.5 13736.5 13809.9 14003.1 11573.3 12418.9 12668.8 12767.7 12807.2 12104.6 12223.8 12231.6 12374.2 12470.9 12504.4 12624.0 12662.5 12827.2 12838.2 8861.6 8885.0 8963.1 8996.0 8998.0 8877.5 11116.7 11837.3 11945.8 12170.3 04:41:17 INFO - PROCESS | 15629 | 04:41:17 INFO - PROCESS | 15629 | [#3] mootools.html Cycles:180 Average:5586.42 Median:4804.39 stddev:3153.31 (65.6%) stddev-sans-first:3146.66 04:41:17 INFO - PROCESS | 15629 | Values: 1426.3 1544.6 1567.5 1747.0 1880.1 7495.4 8228.9 8382.0 8383.3 8393.7 7958.6 8141.7 8146.6 8149.5 8176.9 2101.7 2144.3 2272.5 2296.1 2296.6 2357.9 2370.5 2372.3 2376.0 2377.6 2253.8 2267.2 2275.7 2369.5 2372.6 2052.2 2269.5 2278.6 2282.2 2337.1 2310.4 2353.0 2356.4 2358.9 2359.0 7994.2 8038.2 8051.0 8061.4 8068.0 5067.8 5180.9 5196.6 5213.1 5226.9 3368.5 3393.8 3499.9 3516.4 3517.4 982.0 1003.6 1134.7 1144.3 1166.2 11910.9 11939.1 11958.6 11999.2 12036.9 4426.7 4590.3 4605.2 4635.5 4694.9 10108.2 10109.3 10156.0 10164.2 10202.0 5304.9 5304.9 5305.0 5314.3 5319.8 4326.7 4693.6 4725.8 4781.2 4887.6 3930.3 4038.4 4063.6 4067.7 4122.4 1282.7 1286.7 1290.2 1292.5 1303.8 970.4 978.4 985.8 1001.2 1012.3 5590.0 5616.1 5628.5 5700.7 5784.9 417.9 418.7 420.5 423.0 429.2 3866.6 3896.7 3902.2 3909.0 3918.7 10303.1 10700.9 10751.1 10759.8 10803.1 10614.7 10623.9 10632.9 10633.0 10634.1 7838.3 8208.0 8230.4 8312.7 8316.0 5654.9 5666.0 5763.6 5797.9 5838.2 9352.4 9357.6 9573.0 9598.7 9659.4 9550.0 9552.4 9688.1 9764.3 9872.9 6954.0 7311.9 7432.6 7442.1 7508.2 8025.5 8040.0 8055.6 8083.8 8092.3 7260.0 7411.3 7510.3 7515.7 7526.9 6895.9 6897.2 6973.4 7103.7 7291.2 6574.5 6685.1 6737.1 6742.4 6747.7 4744.8 4827.6 4838.2 4872.8 4882.7 5084.8 5085.7 5125.1 5133.2 5133.3 04:41:17 INFO - PROCESS | 15629 | 04:41:17 INFO - PROCESS | 15629 | [#4] prototype.html Cycles:180 Average:5545.66 Median:6374.84 stddev:1696.36 (26.6%) stddev-sans-first:1655.36 04:41:17 INFO - PROCESS | 15629 | Values: 331.7 333.2 336.7 339.8 339.9 6213.4 6248.4 6338.7 6341.6 6376.1 6252.6 6256.4 6262.9 6279.0 6283.4 4545.1 4642.4 4749.8 4764.3 4773.9 4738.4 4741.7 4764.1 4766.1 4769.3 4481.1 4715.2 4718.3 4723.3 4724.3 4573.6 4602.3 4604.1 4689.0 4690.1 4106.7 4119.2 4119.9 4128.9 4129.8 5966.0 6020.2 6020.8 6034.8 6044.9 5484.1 5486.2 5490.1 5493.7 5498.0 6373.5 6520.3 6560.9 6575.1 6580.9 4490.2 4520.5 4521.8 4523.1 4530.3 6792.3 6898.2 6906.8 6910.8 6916.2 4663.3 4670.0 4673.5 4677.8 4679.5 4732.4 4732.6 4740.8 4743.0 4746.8 5452.3 5476.0 5486.5 5495.9 5496.5 6502.6 6636.6 6641.9 6649.0 6649.5 1633.3 1662.5 1672.3 1676.1 1676.6 1030.6 1074.5 1077.5 1091.2 1099.5 6285.1 6413.1 6441.6 6518.5 6523.8 6847.4 6910.4 6910.8 6910.9 6923.3 6405.5 6408.2 6417.7 6425.9 6427.2 3656.7 3719.3 3719.7 3726.8 3727.6 6945.6 7086.1 7095.3 7116.9 7156.4 6957.7 6960.8 6961.3 6988.6 6991.5 7108.1 7120.6 7124.0 7126.6 7134.0 6875.7 6878.9 6879.2 6885.7 6889.5 6598.9 6775.7 6782.7 6795.0 6804.9 7119.6 7133.4 7138.6 7144.3 7148.2 4642.3 4646.2 4650.0 4651.1 4653.1 6879.8 6880.1 6882.3 6891.8 6892.8 6533.4 6703.8 6703.9 6716.1 6721.5 6637.5 6671.6 6681.0 6683.5 6684.3 6573.2 6574.3 6578.6 6624.4 6639.3 6731.3 6732.6 6739.5 6740.0 6749.2 6433.2 6566.3 6585.4 6587.3 6599.5 04:41:17 INFO - PROCESS | 15629 | 04:41:17 INFO - PROCESS | 15629 | [#5] yui.html Cycles:180 Average:15267.43 Median:26139.37 stddev:17309.38 (66.2%) stddev-sans-first:17324.18 04:41:17 INFO - PROCESS | 15629 | Values: 873.6 874.1 915.9 925.5 928.7 13984.7 14025.6 14072.2 14075.8 15268.7 13738.1 13962.8 14018.3 14091.7 14247.1 863.6 871.0 873.1 879.5 879.6 872.7 880.5 882.0 882.1 882.4 913.9 915.8 919.1 921.3 924.0 910.1 911.7 917.3 918.3 918.6 671.5 674.6 675.3 675.5 676.4 13484.6 13534.9 13574.9 13582.2 13584.7 12922.2 13257.5 13998.8 14095.0 14222.9 12386.0 13013.8 13056.2 13085.3 13287.8 4067.7 4127.1 4128.2 4654.1 4666.6 50650.5 54001.7 54220.7 57078.3 57087.4 11149.5 11157.6 11603.4 11714.9 11924.0 19820.6 19853.4 19899.0 19900.8 19923.4 8697.6 8765.3 8816.6 8818.2 9043.8 4699.0 4859.8 4866.5 4906.7 4944.0 3292.5 3356.1 3358.2 3360.7 3364.2 648.9 652.6 654.2 664.4 672.1 640.9 662.3 692.9 720.5 722.9 8586.9 8922.5 9149.7 9350.9 9589.7 713.8 769.9 820.3 830.1 836.6 4206.9 4280.8 4287.4 4310.9 4391.2 59907.4 60023.0 60432.7 60909.7 60929.4 53195.2 55509.0 55637.9 55812.2 55979.4 50027.7 50519.7 50654.2 50834.0 51112.2 8573.2 8653.5 8764.0 8791.4 8987.4 36706.0 37176.0 37251.0 40212.8 40337.8 47579.8 49174.8 49238.8 49709.3 50853.2 12780.7 12922.0 12927.9 12983.1 13170.1 13701.4 14145.8 14176.9 14433.9 14940.3 13254.9 13266.3 13268.4 13411.7 13448.1 13081.1 13160.7 13559.9 13580.5 13757.5 13056.3 13341.0 13453.3 13552.0 13561.5 11422.9 11447.8 11626.5 11673.3 12116.8 10885.5 11211.9 11390.1 11450.8 11527.4 04:41:17 INFO - PROCESS | 15629 | -------- Summary: end -------- 04:41:17 INFO - PROCESS | 15629 | 04:41:18 INFO - TEST-INFO | 15629: exit 0 04:41:18 INFO - TEST-OK | dromaeo_css | took 1111203ms 04:41:18 INFO - TEST-START | kraken 04:41:18 INFO - operating with platform_type : linux_ 04:41:18 INFO - Initialising browser for kraken test... 04:41:18 INFO - TEST-INFO | started process 15821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOK3gRL/profile http://localhost:49575/getInfo.html) 04:41:22 INFO - PROCESS | 15821 | __metrics Screen width/height:1600/1200 04:41:22 INFO - PROCESS | 15821 | colorDepth:24 04:41:22 INFO - PROCESS | 15821 | Browser inner width/height: 1024/697 04:41:22 INFO - PROCESS | 15821 | __metrics 04:41:23 ERROR - PROCESS | 15821 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:41:24 INFO - TEST-INFO | 15821: exit 0 04:41:24 INFO - Browser initialized. 04:41:24 INFO - Running cycle 1/1 for kraken test... 04:41:24 INFO - TEST-INFO | started process 15913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOK3gRL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:41:36 INFO - PROCESS | 15913 | RSS: Main: 141815808 04:41:36 INFO - PROCESS | 15913 | 04:41:38 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:49575/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49575/tests/kraken/driver.html?testName=audio-beat-detection) 04:41:39 INFO - PROCESS | 15913 | RSS: Main: 197201920 04:41:39 INFO - PROCESS | 15913 | 04:41:42 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:49575/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49575/tests/kraken/driver.html?testName=audio-dft) 04:41:42 INFO - PROCESS | 15913 | RSS: Main: 181833728 04:41:42 INFO - PROCESS | 15913 | 04:41:45 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:49575/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49575/tests/kraken/driver.html?testName=audio-fft) 04:41:46 INFO - PROCESS | 15913 | RSS: Main: 273080320 04:41:46 INFO - PROCESS | 15913 | 04:41:48 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:49575/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49575/tests/kraken/driver.html?testName=audio-oscillator) 04:41:48 INFO - PROCESS | 15913 | RSS: Main: 179314688 04:41:48 INFO - PROCESS | 15913 | 04:41:50 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:49575/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49575/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:41:51 INFO - PROCESS | 15913 | RSS: Main: 177893376 04:41:51 INFO - PROCESS | 15913 | 04:41:54 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:49575/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49575/tests/kraken/driver.html?testName=imaging-darkroom) 04:41:55 INFO - PROCESS | 15913 | RSS: Main: 211759104 04:41:55 INFO - PROCESS | 15913 | 04:41:58 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:49575/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49575/tests/kraken/driver.html?testName=imaging-desaturate) 04:41:59 INFO - PROCESS | 15913 | RSS: Main: 212770816 04:41:59 INFO - PROCESS | 15913 | 04:42:01 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:49575/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49575/tests/kraken/driver.html?testName=json-parse-financial) 04:42:02 INFO - PROCESS | 15913 | RSS: Main: 212725760 04:42:02 INFO - PROCESS | 15913 | 04:42:03 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:49575/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49575/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:42:04 INFO - PROCESS | 15913 | RSS: Main: 192950272 04:42:04 INFO - PROCESS | 15913 | 04:42:06 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:49575/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49575/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:42:06 INFO - PROCESS | 15913 | RSS: Main: 195960832 04:42:06 INFO - PROCESS | 15913 | 04:42:08 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:49575/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49575/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:42:09 INFO - PROCESS | 15913 | RSS: Main: 210395136 04:42:09 INFO - PROCESS | 15913 | 04:42:11 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:49575/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:42:12 INFO - PROCESS | 15913 | RSS: Main: 213168128 04:42:12 INFO - PROCESS | 15913 | 04:42:15 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:49575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:42:15 INFO - PROCESS | 15913 | RSS: Main: 209649664 04:42:15 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:49575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49575/tests/kraken/driver.html?testName=ai-astar) 04:42:17 INFO - PROCESS | 15913 | RSS: Main: 273657856 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | __start_tp_report 04:42:17 INFO - PROCESS | 15913 | _x_x_mozilla_page_load 04:42:17 INFO - PROCESS | 15913 | _x_x_mozilla_page_load_details 04:42:17 INFO - PROCESS | 15913 | |i|pagename|runs| 04:42:17 INFO - PROCESS | 15913 | |0;ai-astar;112;111;111;112;110;111;105;109;109;110 04:42:17 INFO - PROCESS | 15913 | |1;audio-beat-detection;157;125;153;182;127;158;157;128;188;127 04:42:17 INFO - PROCESS | 15913 | |2;audio-dft;163;161;163;161;161;160;160;161;160;159 04:42:17 INFO - PROCESS | 15913 | |3;audio-fft;74;76;73;177;76;75;75;75;165;75 04:42:17 INFO - PROCESS | 15913 | |4;audio-oscillator;91;92;147;93;93;91;155;92;91;153 04:42:17 INFO - PROCESS | 15913 | |5;imaging-gaussian-blur;117;117;117;117;118;116;118;118;116;116 04:42:17 INFO - PROCESS | 15913 | |6;imaging-darkroom;146;146;146;146;147;146;146;146;147;146 04:42:17 INFO - PROCESS | 15913 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;94;94 04:42:17 INFO - PROCESS | 15913 | |8;json-parse-financial;54;56;54;55;53;54;55;73;55;52 04:42:17 INFO - PROCESS | 15913 | |9;json-stringify-tinderbox;59;57;57;57;58;58;57;63;58;58 04:42:17 INFO - PROCESS | 15913 | |10;stanford-crypto-aes;72;71;71;71;73;74;75;73;72;72 04:42:17 INFO - PROCESS | 15913 | |11;stanford-crypto-ccm;120;122;126;112;111;113;111;113;128;115 04:42:17 INFO - PROCESS | 15913 | |12;stanford-crypto-pbkdf2;164;163;156;157;156;155;155;162;157;161 04:42:17 INFO - PROCESS | 15913 | |13;stanford-crypto-sha256-iterative;66;66;67;67;64;66;66;65;65;65 04:42:17 INFO - PROCESS | 15913 | __end_tp_report 04:42:17 INFO - PROCESS | 15913 | __start_cc_report 04:42:17 INFO - PROCESS | 15913 | _x_x_mozilla_cycle_collect,1611 04:42:17 INFO - PROCESS | 15913 | __end_cc_report 04:42:17 INFO - PROCESS | 15913 | __startTimestamp1462534937650__endTimestamp 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | ------- Summary: start ------- 04:42:17 INFO - PROCESS | 15913 | Number of tests: 14 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.05 (1.9%) stddev-sans-first:2.05 04:42:17 INFO - PROCESS | 15913 | Values: 112.0 111.0 111.0 112.0 110.0 111.0 105.0 109.0 109.0 110.0 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:157.00 stddev:23.11 (14.7%) stddev-sans-first:24.38 04:42:17 INFO - PROCESS | 15913 | Values: 157.0 125.0 153.0 182.0 127.0 158.0 157.0 128.0 188.0 127.0 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.29 (0.8%) stddev-sans-first:1.12 04:42:17 INFO - PROCESS | 15913 | Values: 163.0 161.0 163.0 161.0 161.0 160.0 160.0 161.0 160.0 159.0 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.00 stddev:40.64 (54.2%) stddev-sans-first:42.45 04:42:17 INFO - PROCESS | 15913 | Values: 74.0 76.0 73.0 177.0 76.0 75.0 75.0 75.0 165.0 75.0 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:91.50 stddev:28.97 (31.7%) stddev-sans-first:29.91 04:42:17 INFO - PROCESS | 15913 | Values: 91.0 92.0 147.0 93.0 93.0 91.0 155.0 92.0 91.0 153.0 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 04:42:17 INFO - PROCESS | 15913 | Values: 117.0 117.0 117.0 117.0 118.0 116.0 118.0 118.0 116.0 116.0 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 04:42:17 INFO - PROCESS | 15913 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:42:17 INFO - PROCESS | 15913 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 94.0 94.0 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.00 stddev:6.05 (11.0%) stddev-sans-first:6.36 04:42:17 INFO - PROCESS | 15913 | Values: 54.0 56.0 54.0 55.0 53.0 54.0 55.0 73.0 55.0 52.0 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:1.81 (3.1%) stddev-sans-first:1.90 04:42:17 INFO - PROCESS | 15913 | Values: 59.0 57.0 57.0 57.0 58.0 58.0 57.0 63.0 58.0 58.0 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:72.50 stddev:1.35 (1.9%) stddev-sans-first:1.42 04:42:17 INFO - PROCESS | 15913 | Values: 72.0 71.0 71.0 71.0 73.0 74.0 75.0 73.0 72.0 72.0 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:117.50 stddev:6.40 (5.4%) stddev-sans-first:6.70 04:42:17 INFO - PROCESS | 15913 | Values: 120.0 122.0 126.0 112.0 111.0 113.0 111.0 113.0 128.0 115.0 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:159.00 stddev:3.50 (2.2%) stddev-sans-first:3.12 04:42:17 INFO - PROCESS | 15913 | Values: 164.0 163.0 156.0 157.0 156.0 155.0 155.0 162.0 157.0 161.0 04:42:17 INFO - PROCESS | 15913 | 04:42:17 INFO - PROCESS | 15913 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 04:42:17 INFO - PROCESS | 15913 | Values: 66.0 66.0 67.0 67.0 64.0 66.0 66.0 65.0 65.0 65.0 04:42:17 INFO - PROCESS | 15913 | -------- Summary: end -------- 04:42:17 INFO - PROCESS | 15913 | 04:42:18 INFO - TEST-INFO | 15913: exit 0 04:42:18 INFO - TEST-OK | kraken | took 60082ms 04:42:18 INFO - SUITE-END | took 1171s 04:42:18 INFO - Completed test suite (00:19:31) 04:42:18 INFO - javascript benchmark 04:42:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3277.88527401541, 3335.8332083395826, 3351.463765797473, 3363.142398688334, 3382.1206486313567, 5468.343798744157, 5488.341399032117, 5499.202615620738, 5509.586780991427, 5512.503874651291, 5504.339479262484, 5525.4474552544725, 5525.778968841241, 5546.611737178389, 5579.888402231953, 4945.233488809223, 5009.148444764399, 5075.568576670988, 5085.262636917645, 5147.330846989886, 4949.183384741514, 4965.577925876305, 4995.950040499603, 5001.14980453322, 5002.7993281612335, 4991.5258050485145, 5069.087564238435, 5099.056674515208, 5105.821296254632, 5126.871828204287, 5053.69677819332, 5079.415867175267, 5083.6441449098575, 5088.898222035576, 5090.872728181788, 4870.707757534559, 4875.561199492027, 4953.257011448276, 4992.450830408652, 5029.647924645276, 5384.946150538483, 5440.020796256672, 5448.700321482317, 5450.509454149106, 5456.263404440429, 5826.155207494932, 5832.6792026438525, 5833.82498525045, 5836.970815145897, 5846.41535846412, 5866.325372582165, 5871.295444546639, 5969.70151492428, 6010.909836352458, 6036.034234522499, 5395.082835917903, 5427.592930530226, 5454.59090568209, 5471.425500322488, 5474.206240095164, 5879.706014699248, 5957.851053723605, 5958.493528050164, 5962.880742385215, 5992.041273396323, 5568.053430916754, 5648.265725455664, 5666.716664166775, 5672.858178545569, 5693.857653558694, 5880.647161170344, 5881.911771323434, 5895.705214739246, 5898.705064746831, 5903.498202652737, 5685.857853553694, 5810.302763668386, 5855.970720146372, 5873.970630146822, 5876.294844618673, 5899.439553242435, 5902.822915312548, 5913.2608423947, 5914.526837852962, 5942.6731529766275, 4496.033352829158, 4500.257457519538, 4508.57168568992, 4515.63874890008, 4551.749653769075, 3936.1143742658246, 3964.940525892114, 4005.2790497710107, 4032.5967403259438, 4075.449814275094, 5445.727713614304, 5462.0, 5471.50756431923, 5473.0969390051, 5517.44825517445, 5751.798687045934, 5753.59724819267, 5754.251947246831, 5762.827115186551, 5779.306483222041, 5393.7303134843105, 5492.231087647732, 5502.0, 5589.0, 5590.24531688225, 4879.560839524389, 4920.507949205123, 4931.334269873521, 4941.061198372369, 4946.678465899705, 5843.707814609253, 5878.265216847894, 5915.319738230072, 5917.142014407887, 5918.496927761188, 5624.184493248456, 5862.501687356623, 5889.293284805851, 5922.289325280994, 5931.822045338647, 5966.731497082555, 5966.820995370146, 5976.641401515923, 5978.133170690313, 5986.700664966821, 5666.03677374839, 5670.659760414388, 5679.801206957736, 5694.544436444991, 5696.487316141567, 5793.507551858139, 5829.446202610745, 5841.415858414124, 5844.94155058461, 5893.351731309467, 5693.686847223443, 5704.657720536781, 5721.084626459747, 5721.742521586455, 5733.197352370588, 5645.887082258414, 5650.547956163579, 5700.2304688868135, 5700.372958974426, 5700.743466544099, 5642.943570564242, 5669.31968163823, 5674.886502270014, 5679.659220446786, 5734.713264336683, 5738.684372359393, 5739.282589676291, 5785.218995435731, 5798.478136967693, 5808.883822323445, 5603.971980140073, 5692.886142277049, 5708.514776244066, 5729.914051289151, 5803.187553742564], "value": 5399.320695378928, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.4237303375277, 653.7123665587142, 677.0352248046532, 679.7552880962854, 691.9515633905626, 33287.50068748968, 33933.321333573345, 39821.99999999996, 40350.59649403505, 40422.79788601053, 43008.0, 43527.0, 43652.0, 43759.562404375945, 43774.0, 8084.1107478177355, 8682.956585217082, 8846.734597962071, 8850.911490885106, 8853.0, 10477.26659133861, 10826.0, 10827.945860270727, 10833.079188269006, 10834.187435942336, 10446.58213671456, 10553.788924221511, 10561.947190264038, 10566.52450639723, 10572.101371383442, 10461.110805581535, 10534.315269507457, 10548.894511054945, 10555.366677999345, 10559.102476289525, 10295.845562316572, 10364.170866330676, 10436.582536698523, 10763.623273185402, 10790.352578845215, 41503.7924810374, 41838.11728472226, 41997.160056798995, 42022.579774202175, 42039.15921681549, 3098.612673415823, 3800.923981520382, 3910.237503686782, 3956.802159891994, 4335.783210839477, 29711.0, 32476.0, 32736.836315818506, 32739.836300818344, 33245.50131748002, 4343.84796532123, 4403.757793321366, 4429.092036132585, 4429.6899217054815, 4465.129299786543, 270828.64585676946, 271423.0, 272096.0, 272313.0, 273434.0, 38370.0, 56123.0, 56915.14627280511, 56995.14507282394, 57050.714746426005, 37620.0, 37789.62210377916, 37835.432468513, 37846.0, 37854.24291514154, 16974.83025169757, 17191.140442978052, 17219.22513486896, 17275.0, 17309.221085051202, 12590.740925907336, 13274.800877986838, 13476.797848032287, 13553.39009744564, 13577.52478663242, 9038.367314287936, 9107.453552786854, 9166.312526560534, 9210.493422861808, 9221.354505184572, 3572.1069732566857, 3579.83890724918, 3591.1381268495898, 3620.5836328822525, 3682.4844521766972, 1134.750354921916, 1152.8904754048351, 1166.416791604198, 1186.4957393107895, 1285.607889593683, 32717.0, 33066.0, 33161.50257746136, 33402.0, 33482.83258583691, 1020.3418794877412, 1021.2340744441668, 1142.2232881640564, 1237.7957636989795, 1251.4232067594896, 15751.527454176394, 15835.366585336458, 15979.12114833672, 15979.365983864782, 16268.51194464168, 489160.0, 492811.0, 494844.0, 495501.0, 496291.0, 55729.72135139298, 56235.71882140563, 56243.43756562464, 56278.0, 56307.71846140743, 1371.5199680111882, 1416.7037160997572, 1500.4973333933256, 1534.0872181052257, 1586.1276298036034, 29770.255743606584, 30057.69942300549, 30666.233344166576, 31220.37559248848, 31260.843695781376, 46691.766541167075, 47807.760961194974, 47830.760846195546, 47931.76034119807, 47970.28044579264, 282003.0, 287297.0, 288632.0, 288871.0, 289763.0, 26661.466770664865, 28220.294492637848, 29466.852665736533, 29727.554086688284, 29894.0, 43457.0, 43708.0, 43970.78014609907, 44135.55864441315, 44495.55504444914, 36310.818445908655, 36673.0, 37339.25321493609, 37573.0, 37832.62167378401, 36117.0, 36505.452418213215, 36674.08314792151, 36741.63258367382, 36755.0, 39313.0, 39748.40377394284, 40150.59849401469, 40522.59477405188, 40787.59212407838, 33812.323753525285, 34658.82670586631, 35010.474842876865, 35085.68425957633, 35153.64846351606, 27530.724692752818, 28048.29879253035, 28108.71891281061, 28233.479299363386, 28306.575401368584], "value": 18908.62114433629, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.51965000074915, 423.3987737412875, 424.07551537647953, 435.43828461284943, 443.7293251116818, 13549.59351219465, 18163.273469061238, 18739.594530410224, 18767.906160469196, 19515.609687806234, 15750.0, 18724.438266851983, 19955.800441995576, 20271.391858244275, 20283.08726107325, 5575.358833734122, 5754.1944127822135, 5772.682502462363, 5781.566382521307, 5785.681787501686, 5729.799457019005, 5753.510951569101, 5758.251427314464, 5765.394633563457, 5768.942310576904, 4303.117860838521, 4446.666500012496, 6034.939650603504, 6438.098666186737, 6443.710033048524, 6280.214973128359, 6290.465310448617, 6294.937050629481, 6295.118683384329, 6347.587406818565, 5586.329640443173, 5678.886422271531, 5701.600887937846, 5715.31416230055, 5717.885642287172, 23947.281581552583, 24208.757912420828, 24323.756762432327, 25013.874930625414, 25167.496650066896, 2677.651905252305, 2745.2999485131363, 2905.3172504461436, 3041.8783248670024, 3195.913389447599, 12196.573119940847, 14392.208428536427, 15307.387704491806, 15600.921995390065, 15934.0, 2044.1516770540356, 2295.6900818389636, 2495.46347535279, 2542.275451496333, 2573.3309339571847, 84125.58832052574, 87873.56063219707, 88412.5579372099, 88958.55520722484, 89107.0, 18140.727889081674, 18312.725309120375, 19010.80989190118, 19055.61888762217, 19081.0, 33753.15617109592, 33840.83079584586, 34252.0, 34293.82853085768, 34375.0, 10616.93830616932, 11389.145814063813, 11442.14183936208, 11479.794621564783, 11552.537898484135, 9663.420194788336, 9675.516224188763, 9723.65967191145, 9789.608415663437, 9896.356736812084, 7578.962105189439, 8862.158094980967, 9521.381110227952, 9547.618095276111, 9604.51977401141, 3567.8929632111076, 3583.33708263972, 3590.3537363274863, 3599.8200089995394, 3614.5120408744483, 945.3193700535603, 1057.7831544533353, 1058.0636137018794, 1065.4566171252718, 1137.5279259107378, 18448.446546603624, 18880.716789248174, 18917.0, 19367.515812104528, 19485.02574871251, 1031.298716872534, 1061.0768631290825, 1069.909057730086, 1083.1876092930302, 1099.483242875847, 10077.748056298651, 10268.64059757905, 10377.014183652542, 10413.53139108742, 10643.563118978838, 503028.0, 504358.0, 506769.0, 517806.0, 522345.0, 94204.0, 97487.0, 97613.0, 98626.37908756528, 98881.0, 1111.6164923101517, 1119.0879433261866, 1129.0346753525782, 1130.1806190511813, 1131.8585176852894, 16606.335746570003, 16810.915945420194, 16821.990680559207, 16929.91535042317, 17108.48674539766, 37528.0, 38599.42100868545, 38707.41938870863, 39563.80218098891, 39666.60333396629, 55355.16967245414, 57487.42512574821, 57582.0, 57602.0, 57826.7108664454, 8938.731838044869, 8967.10328967098, 9018.729438116867, 9142.3600347975, 9202.987671356012, 10141.898581014095, 13727.519536816562, 13736.45054197861, 13809.861901380858, 14003.089799163023, 11573.305601663928, 12418.875811241773, 12668.809967850306, 12767.744645107232, 12807.231566106064, 12104.576339828063, 12223.816642750544, 12231.633051008484, 12374.195677280948, 12470.875291247334, 12504.374781261082, 12624.0, 12662.493500259887, 12827.166234194747, 12838.16551924122, 8861.556922153995, 8884.955575222082, 8963.103689630985, 8996.01043885159, 8997.955010224907, 8877.467351958903, 11116.722081948015, 11837.289762614271, 11945.820812687643, 12170.330631815335], "value": 10461.799557184624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.3224968140141, 1544.6061254380134, 1567.4984005118367, 1746.9650606987861, 1880.078761406911, 7495.362894153996, 8228.876566851495, 8381.95809020954, 8383.329333653308, 8393.664253429863, 7958.602069896511, 8141.674333026672, 8146.551939643317, 8149.4702844315225, 8176.91823081769, 2101.695254188142, 2144.281665642012, 2272.454610893386, 2296.0815673730476, 2296.5980953333183, 2357.905683772647, 2370.490344575916, 2372.3357459911253, 2375.9643605345846, 2377.5720370333333, 2253.763354847734, 2267.2178098555974, 2275.7369659838782, 2369.4668699542553, 2372.620380739082, 2052.1688716070016, 2269.466675331296, 2278.646809744484, 2282.2240438251074, 2337.111897478947, 2310.3992961829877, 2352.9764702352927, 2356.3873392917794, 2358.929232123039, 2359.044586942291, 7994.2405471480115, 8038.196180381915, 8051.033875934867, 8061.395395345373, 8067.95966020172, 5067.797288108472, 5180.8963820723375, 5196.558292545138, 5213.139831927728, 5226.895462090775, 3368.4778859276853, 3393.8472768725464, 3499.947500787465, 3516.4197907345256, 3517.43721004638, 982.0, 1003.6085926488676, 1134.659602119361, 1144.3191301175787, 1166.1661911733067, 11910.880891191064, 11939.104567157498, 11958.58144964922, 11999.160058795887, 12036.879631203663, 4426.690131690751, 4590.288505281686, 4605.217113090783, 4635.536446355338, 4694.882627934329, 10108.191344692406, 10109.29234953561, 10156.0, 10164.237682173718, 10202.030807073315, 5304.867378315495, 5304.946950530522, 5305.018571564273, 5314.256004159421, 5319.760610772524, 4326.6538676905775, 4693.647976401715, 4725.787339569659, 4781.163296423112, 4887.560119589254, 3930.272899513599, 4038.394240863894, 4063.593640635913, 4067.6745860331102, 4122.40225167349, 1282.660095074806, 1286.7040580666312, 1290.2387591320978, 1292.4894666606638, 1303.7718399280088, 970.3713287618023, 978.4080631218153, 985.8422652375585, 1001.1940387987739, 1012.336919317848, 5590.0, 5616.129499927518, 5628.493435590816, 5700.693677285754, 5784.88430231393, 417.8788151436049, 418.7361961964004, 420.459709273582, 423.0396998812739, 429.1974008603931, 3866.574676785551, 3896.6687831534637, 3902.239063382613, 3908.9804550977065, 3918.686505079587, 10303.124234440007, 10700.89299106999, 10751.139908807276, 10759.83860242097, 10803.081738052197, 10614.681559553226, 10623.946880265548, 10632.946835265775, 10633.0, 10634.09610183143, 7838.333741631911, 8207.95896020516, 8230.382721295926, 8312.667493300321, 8316.043654979634, 5654.858628534155, 5666.0, 5763.567732420001, 5797.8550536236935, 5838.1826544282985, 9352.438853668802, 9357.57890894925, 9573.042695730372, 9598.712038638852, 9659.372140810825, 9549.952250238704, 9552.42685438876, 9688.079632434907, 9764.267679923893, 9872.851907221253, 6953.965230173817, 7311.926880731125, 7432.554046757212, 7442.1069471661585, 7508.211637778173, 8025.518468891885, 8039.959800200962, 8055.556944367881, 8083.757487275391, 8092.312153467021, 7260.0, 7411.295926886937, 7510.286522780327, 7515.6993720250575, 7526.887096693445, 6895.931040689529, 6897.241303456515, 6973.442124630119, 7103.715851365888, 7291.234420385783, 6574.506911981525, 6685.130932978682, 6737.124173857367, 6742.42689371409, 6747.730090796314, 4744.810207591658, 4827.61379089679, 4838.225883858566, 4872.780724867461, 4882.731449770296, 5084.847454576368, 5085.745712714275, 5125.051865404912, 5133.153029750049, 5133.307003554472], "value": 4427.44459022382, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.70478274335846, 333.2119537294299, 336.71042903103324, 339.8453703564878, 339.8674516938393, 6213.440790328869, 6248.406401391866, 6338.714757835897, 6341.619502829833, 6376.139221205136, 6252.593581417216, 6256.436920677138, 6262.874742505159, 6279.0, 6283.371662833714, 4545.068261006494, 4642.442906851165, 4749.786259618326, 4764.332993380929, 4773.928391074137, 4738.384010078685, 4741.668083234175, 4764.118638051954, 4766.142094423002, 4769.332293478916, 4481.0813783174535, 4715.221988371914, 4718.268668356411, 4723.338732577442, 4724.291356296549, 4573.565511276423, 4602.309653551961, 4604.1482325769675, 4688.953110468886, 4690.0854333405, 4106.67146628272, 4119.237940980928, 4119.8970025749295, 4128.876133715993, 4129.772862492562, 5966.045432730785, 6020.187274717945, 6020.789272375446, 6034.758609655652, 6044.939550604482, 5484.149956756709, 5486.231927530149, 5490.066688662897, 5493.697846618435, 5498.010358135534, 6373.534087159933, 6520.315366886503, 6560.901586476207, 6575.079488871562, 6580.868382632369, 4490.236659767815, 4520.50274469808, 4521.751303678297, 4523.140603285398, 4530.275155975029, 6792.320767923217, 6898.172219333662, 6906.792796216121, 6910.827229319257, 6916.239213686541, 4663.27719203524, 4670.019295947821, 4673.509281525391, 4677.836275730333, 4679.485256621769, 4732.384789977281, 4732.645051621143, 4740.810367585258, 4742.976285118552, 4746.833860814924, 5452.318460192476, 5476.041692703761, 5486.451354864482, 5495.917561236584, 5496.5053145217125, 6502.642354670538, 6636.568623039487, 6641.933580664228, 6649.0, 6649.468042556584, 1633.2813562032668, 1662.4680102367126, 1672.3059930128861, 1676.0865328396053, 1676.5892356372767, 1030.577463240068, 1074.5379486820586, 1077.5151181968147, 1091.1925175370168, 1099.5217080569978, 6285.120083188357, 6413.134226879405, 6441.645709486023, 6518.511111666644, 6523.7716679915975, 6847.417969472551, 6910.44716422695, 6910.792676219721, 6910.930890691129, 6923.307669233036, 6405.455536279468, 6408.231012278463, 6417.679116044179, 6425.871482570323, 6427.164468619049, 3656.670899619047, 3719.2891270015552, 3719.7210209234418, 3726.795026273581, 3727.6086010968456, 6945.617991010442, 7086.114235720535, 7095.254998225215, 7116.893246601305, 7156.427485801123, 6957.652117394211, 6960.79117626472, 6961.303869612998, 6988.580685158805, 6991.545549539263, 7108.07595012645, 7120.572765633975, 7123.964380178066, 7126.643667816692, 7133.964330178316, 6875.724971001304, 6878.931210687829, 6879.174499060145, 6885.724571017304, 6889.483288753464, 6598.934010660024, 6775.728970841308, 6782.728690852311, 6795.0, 6804.897926531205, 7119.572825630479, 7133.429325654039, 7138.571685698875, 7144.285571442814, 7148.213696493485, 4642.326862604971, 4646.233371493666, 4649.976750116228, 4651.09303685778, 4653.115907977473, 6879.793606191823, 6880.139982502187, 6882.277360877036, 6891.793246202622, 6892.827679307857, 6533.41199292066, 6703.832404189934, 6703.865922681422, 6716.093327400738, 6721.462283017249, 6637.469002479694, 6671.5997040177745, 6681.0, 6683.465322774069, 6684.298148694317, 6573.211214654272, 6574.309697481695, 6578.572392794453, 6624.403803657694, 6639.302873198438, 6731.259561448139, 6732.629705366252, 6739.460843132636, 6740.0, 6749.223839258351, 6433.163688720437, 6566.277709452052, 6585.407313341822, 6587.341265873374, 6599.472042236705], "value": 4985.190525578651, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.5981448533674, 874.1302404107913, 915.8580420034892, 925.4724806860092, 928.7028150991683, 13984.650383740387, 14025.579232623038, 14072.155670659768, 14075.788863167061, 15268.694626107472, 13738.107023043494, 13962.790558141636, 14018.299085045732, 14091.718165636681, 14247.14517128973, 863.5984267315681, 870.9695160669378, 873.1399571422176, 879.4811061473729, 879.551428771328, 872.650939624149, 880.4805164952677, 881.964721411146, 882.1134759566627, 882.3779235638891, 913.8720579118929, 915.8397280475923, 919.0533750237266, 921.2906062332, 923.9676611318605, 910.0990019880304, 911.6809116809097, 917.298266825872, 918.3020904112856, 918.591226904028, 671.4796033074358, 674.6019848289533, 675.2707076357522, 675.5170053411834, 676.4284179868004, 13484.595462136152, 13534.864651353459, 13574.932125339408, 13582.185068895798, 13584.660383490393, 12922.16005959619, 13257.535986240435, 13998.790018149735, 14095.0, 14222.857771422257, 12385.98414992771, 13013.804792928113, 13056.21662700241, 13085.28030958297, 13287.800682989762, 4067.6745860331102, 4127.112670775768, 4128.153728485683, 4654.069186162747, 4666.580007799281, 50650.49349506495, 54001.72999134979, 54220.728896355264, 57078.289911156055, 57087.429125709044, 11149.498272577754, 11157.553697851996, 11603.361815100081, 11714.88285117155, 11924.0, 19820.60358792845, 19853.404397868086, 19899.0, 19900.800991990185, 19923.402297931087, 8697.608607612672, 8765.254953329038, 8816.559172041372, 8818.162274583905, 9043.819123617492, 4698.976505117453, 4859.829905953275, 4866.513348665105, 4906.730129842822, 4943.975280123648, 3292.456744637156, 3356.1274068741814, 3358.1604598850286, 3360.7479439042168, 3364.2262279675324, 648.9188851393576, 652.6051738698114, 654.1855390039336, 664.3622122762202, 672.1497305908031, 640.8878446271884, 662.3244290823429, 692.9099217101846, 720.477653701073, 722.9096362954631, 8586.914130858737, 8922.509261990654, 9149.725508234764, 9350.859737103949, 9589.668985033562, 713.7680253917498, 769.8768197088439, 820.2822530285999, 830.0993422136928, 836.6318819719304, 4206.8737937861915, 4280.76455794928, 4287.356896465555, 4310.870673879788, 4391.187630288407, 59907.40092599018, 60023.0, 60432.69783651054, 60909.695451523345, 60929.39070609326, 53195.20207196895, 55509.0, 55637.88724225574, 55812.16281755777, 55979.440205598235, 50027.749861250464, 50519.74740126276, 50654.24018639723, 50834.0, 51112.233316500286, 8573.22840944293, 8653.480791152551, 8764.0, 8791.361204676095, 8987.382271190987, 36706.0, 37176.0, 37251.0, 40212.798936005136, 40337.79831100826, 47579.76210118927, 49174.75412622914, 49238.75380623074, 49709.254361183885, 50853.23720144127, 12780.680482988, 12922.0, 12927.935360323138, 12983.091183617056, 13170.07809453329, 13701.383437745126, 14145.787813182606, 14176.858231417555, 14433.855661443671, 14940.252987350807, 13254.867451325363, 13266.336683165997, 13268.402921868732, 13411.731765364833, 13448.1258718183, 13081.149725267827, 13160.670983225496, 13559.932200338935, 13580.45678172862, 13757.518486852912, 13056.34718264064, 13341.0, 13453.260070695815, 13552.0, 13561.525346612822, 11422.885771142182, 11447.771044578894, 11626.53493860236, 11673.299602023906, 12116.818247726114, 10885.455727213766, 11211.943940280247, 11390.145739069769, 11450.82823757661, 11527.423628818693], "value": 7049.502896936548, "unit": "score"}], "name": "dromaeo_css", "value": 7414.9207020438835, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 111.0, 112.0, 110.0, 111.0, 105.0, 109.0, 109.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 153.0, 182.0, 127.0, 158.0, 157.0, 128.0, 188.0, 127.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 161.0, 161.0, 160.0, 160.0, 161.0, 160.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 73.0, 177.0, 76.0, 75.0, 75.0, 75.0, 165.0, 75.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 147.0, 93.0, 93.0, 91.0, 155.0, 92.0, 91.0, 153.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 118.0, 118.0, 116.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 55.0, 53.0, 54.0, 55.0, 73.0, 55.0, 52.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 57.0, 57.0, 58.0, 58.0, 57.0, 63.0, 58.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 71.0, 71.0, 73.0, 74.0, 75.0, 73.0, 72.0, 72.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 122.0, 126.0, 112.0, 111.0, 113.0, 111.0, 113.0, 128.0, 115.0], "value": 117.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 156.0, 157.0, 156.0, 155.0, 155.0, 162.0, 157.0, 161.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 64.0, 66.0, 66.0, 65.0, 65.0, 65.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1511.2, "alertThreshold": 2.0}]} 04:42:18 INFO - Return code: 0 04:42:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:42:18 ERROR - # TBPL SUCCESS # 04:42:18 INFO - Running post-action listener: _resource_record_post_action 04:42:18 INFO - Running post-run listener: _resource_record_post_run 04:42:20 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 40960; Write bytes: 504983552; Read time: 68; Write time: 593048 04:42:20 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 259756032; Read time: 0; Write time: 340672 04:42:20 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 40960; Write bytes: 245227520; Read time: 68; Write time: 252376 04:42:20 INFO - Running post-run listener: _upload_blobber_files 04:42:20 INFO - Blob upload gear active. 04:42:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:42:20 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:42:20 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:42:20 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:42:20 INFO - (blobuploader) - INFO - Open directory for files ... 04:42:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:42:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:42:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:21 INFO - (blobuploader) - INFO - Done attempting. 04:42:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:42:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:42:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:21 INFO - (blobuploader) - INFO - Done attempting. 04:42:21 INFO - (blobuploader) - INFO - Iteration through files over. 04:42:21 INFO - Return code: 0 04:42:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:42:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:42:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25d2b4bc9f7f8cb0d092994b621212fe1085b438d737e1a0e3a6500ea665de6197b26de715124ef628e5ba7df99e4c5646befbd54f761d600b08deccb52661c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/adc89361610777447b62ee78fd11229147aa4d642bc8aaf160d3eb9663723cb50fb4d762b86a82a0791d63ea4dfde49dcb790e8dfeca3a565c222c23c5342b80"} 04:42:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:42:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:42:21 INFO - Contents: 04:42:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25d2b4bc9f7f8cb0d092994b621212fe1085b438d737e1a0e3a6500ea665de6197b26de715124ef628e5ba7df99e4c5646befbd54f761d600b08deccb52661c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/adc89361610777447b62ee78fd11229147aa4d642bc8aaf160d3eb9663723cb50fb4d762b86a82a0791d63ea4dfde49dcb790e8dfeca3a565c222c23c5342b80"} 04:42:21 INFO - Running post-run listener: copy_logs_to_upload_dir 04:42:21 INFO - Copying logs to upload dir... 04:42:21 INFO - mkdir: /builds/slave/test/build/upload/logs 04:42:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.462732 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-06 04:42:21.948625) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 04:42:21.949298) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851 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/25d2b4bc9f7f8cb0d092994b621212fe1085b438d737e1a0e3a6500ea665de6197b26de715124ef628e5ba7df99e4c5646befbd54f761d600b08deccb52661c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/adc89361610777447b62ee78fd11229147aa4d642bc8aaf160d3eb9663723cb50fb4d762b86a82a0791d63ea4dfde49dcb790e8dfeca3a565c222c23c5342b80"} build_url:https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011119 build_url: 'https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/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/25d2b4bc9f7f8cb0d092994b621212fe1085b438d737e1a0e3a6500ea665de6197b26de715124ef628e5ba7df99e4c5646befbd54f761d600b08deccb52661c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/adc89361610777447b62ee78fd11229147aa4d642bc8aaf160d3eb9663723cb50fb4d762b86a82a0791d63ea4dfde49dcb790e8dfeca3a565c222c23c5342b80"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 04:42:21.981438) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:42:21.981763) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1462533711.323666-1035846851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:42:22.063252) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 04:42:22.063567) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 04:42:22.063860) ========= ========= Total master_lag: 0.16 =========