builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1461338495.62 results: success (0) buildid: 20160422065559 builduid: 987f10bf376a459ebff0581fcf25fca4 revision: 005449bf12df9fa386f1644823961cebd94ed0e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 08:21:35.616220) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 08:21:35.616683) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 08:21:35.616980) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 08:21:35.702738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:21:35.703054) ========= 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=62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 08:21:36-- 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% 43.2M=0s 2016-04-22 08:21:36 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110641 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:21:35.826618) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:21:35.826922) ========= 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=62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014845 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:21:35.876844) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:21:35.877212) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 005449bf12df9fa386f1644823961cebd94ed0e7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 005449bf12df9fa386f1644823961cebd94ed0e7 --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=62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 08:21:36,258 truncating revision to first 12 chars 2016-04-22 08:21:36,258 Setting DEBUG logging. 2016-04-22 08:21:36,258 attempt 1/10 2016-04-22 08:21:36,258 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/005449bf12df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 08:21:36,798 unpacking tar archive at: mozilla-central-005449bf12df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.850334 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:21:36.740283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 08:21:36.740607) ========= script_repo_revision: 005449bf12df9fa386f1644823961cebd94ed0e7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 08:21:36.741028) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 08:21:36.741303) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 08:21:36.924039) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-22 08:21:36.924422) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:21:37 INFO - MultiFileLogger online at 20160422 08:21:37 in /builds/slave/test 08:21:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:21:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:21:37 INFO - {'append_to_log': False, 08:21:37 INFO - 'base_work_dir': '/builds/slave/test', 08:21:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:21:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:21:37 INFO - 'branch': 'Firefox-Non-PGO', 08:21:37 INFO - 'buildbot_json_path': 'buildprops.json', 08:21:37 INFO - 'config_files': ('talos/linux_config.py',), 08:21:37 INFO - 'default_actions': ('clobber', 08:21:37 INFO - 'read-buildbot-config', 08:21:37 INFO - 'download-and-extract', 08:21:37 INFO - 'populate-webroot', 08:21:37 INFO - 'create-virtualenv', 08:21:37 INFO - 'install', 08:21:37 INFO - 'run-tests'), 08:21:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:21:37 INFO - 'download_minidump_stackwalk': True, 08:21:37 INFO - 'download_symbols': 'ondemand', 08:21:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:21:37 INFO - 'tooltool.py': '/tools/tooltool.py', 08:21:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:21:37 INFO - '/tools/misc-python/virtualenv.py')}, 08:21:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:21:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:21:37 INFO - 'installer_path': 'installer.exe', 08:21:37 INFO - 'log_level': 'info', 08:21:37 INFO - 'log_name': 'talos', 08:21:37 INFO - 'log_to_console': True, 08:21:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:21:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:21:37 INFO - 'opt_config_files': (), 08:21:37 INFO - 'pip_index': False, 08:21:37 INFO - 'sps_profile': False, 08:21:37 INFO - 'sps_profile_interval': 0, 08:21:37 INFO - 'suite': 'dromaeojs-e10s', 08:21:37 INFO - 'system_bits': '32', 08:21:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:21:37 INFO - 'title': 'talos-linux64-ix-018', 08:21:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:21:37 INFO - 'use_talos_json': True, 08:21:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:21:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:21:37 INFO - 'work_dir': 'build'} 08:21:37 INFO - ##### 08:21:37 INFO - ##### Running clobber step. 08:21:37 INFO - ##### 08:21:37 INFO - Running pre-action listener: _resource_record_pre_action 08:21:37 INFO - Running main action method: clobber 08:21:37 INFO - rmtree: /builds/slave/test/build 08:21:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:21:38 INFO - Running post-action listener: _resource_record_post_action 08:21:38 INFO - ##### 08:21:38 INFO - ##### Running read-buildbot-config step. 08:21:38 INFO - ##### 08:21:38 INFO - Running pre-action listener: _resource_record_pre_action 08:21:38 INFO - Running main action method: read_buildbot_config 08:21:38 INFO - Using buildbot properties: 08:21:38 INFO - { 08:21:38 INFO - "project": "", 08:21:38 INFO - "product": "firefox", 08:21:38 INFO - "script_repo_revision": "production", 08:21:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:21:38 INFO - "repository": "", 08:21:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:21:38 INFO - "buildid": "20160422065559", 08:21:38 INFO - "pgo_build": "False", 08:21:38 INFO - "basedir": "/builds/slave/test", 08:21:38 INFO - "buildnumber": 333, 08:21:38 INFO - "slavename": "talos-linux64-ix-018", 08:21:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:21:38 INFO - "platform": "ubuntu64_hw", 08:21:38 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:21:38 INFO - "branch": "mozilla-central", 08:21:38 INFO - "repo_path": "mozilla-central", 08:21:38 INFO - "revision": "005449bf12df9fa386f1644823961cebd94ed0e7", 08:21:38 INFO - "stage_platform": "linux64", 08:21:38 INFO - "builduid": "987f10bf376a459ebff0581fcf25fca4", 08:21:38 INFO - "slavebuilddir": "test" 08:21:38 INFO - } 08:21:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:21:38 INFO - Running post-action listener: _resource_record_post_action 08:21:38 INFO - ##### 08:21:38 INFO - ##### Running download-and-extract step. 08:21:38 INFO - ##### 08:21:38 INFO - Running pre-action listener: _resource_record_pre_action 08:21:38 INFO - Running main action method: download_and_extract 08:21:38 INFO - mkdir: /builds/slave/test/build/tests 08:21:38 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')]} 08:21:38 INFO - https://queue.taskcluster.net/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:21:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:21:39 INFO - Downloaded 1361 bytes. 08:21:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:39 INFO - Using the following test package requirements: 08:21:39 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:21:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:21:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:39 INFO - u'jsshell-linux-x86_64.zip'], 08:21:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:21:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:21:39 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:21:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:21:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:21:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:39 INFO - https://queue.taskcluster.net/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:21:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:21:40 INFO - Downloaded 22281183 bytes. 08:21:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:21:41 INFO - Return code: 0 08:21:41 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:41 INFO - https://queue.taskcluster.net/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:21:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:21:42 INFO - Downloaded 22281183 bytes. 08:21:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:21:43 INFO - Return code: 0 08:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:43 INFO - https://queue.taskcluster.net/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:21:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:21:44 INFO - Downloaded 10845952 bytes. 08:21:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:21:45 INFO - Return code: 0 08:21:45 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')]} 08:21:45 INFO - https://queue.taskcluster.net/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:21:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:21:48 INFO - Downloaded 54634652 bytes. 08:21:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:48 INFO - mkdir: /builds/slave/test/properties 08:21:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:21:48 INFO - Writing to file /builds/slave/test/properties/build_url 08:21:48 INFO - Contents: 08:21:48 INFO - build_url:https://queue.taskcluster.net/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:48 INFO - Running post-action listener: _resource_record_post_action 08:21:48 INFO - Running post-action listener: set_extra_try_arguments 08:21:48 INFO - ##### 08:21:48 INFO - ##### Running populate-webroot step. 08:21:48 INFO - ##### 08:21:48 INFO - Running pre-action listener: _resource_record_pre_action 08:21:48 INFO - Running main action method: populate_webroot 08:21:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:21:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:21:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:21:48 INFO - '--tppagecycles', 08:21:48 INFO - '7'], 08:21:48 INFO - 'tests': ['tsvgm']}}, 08:21:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:21:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:21:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:21:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:21:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['damp', 'tps']}, 08:21:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'tests': ['damp', 'tps']}, 08:21:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['dromaeo_dom']}, 08:21:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:21:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['a11yr', 08:21:48 INFO - 'ts_paint', 08:21:48 INFO - 'tpaint', 08:21:48 INFO - 'sessionrestore', 08:21:48 INFO - 'sessionrestore_no_auto_restore', 08:21:48 INFO - 'tabpaint']}, 08:21:48 INFO - 'other-e10s': {'tests': ['a11yr', 08:21:48 INFO - 'ts_paint', 08:21:48 INFO - 'tpaint', 08:21:48 INFO - 'sessionrestore', 08:21:48 INFO - 'sessionrestore_no_auto_restore', 08:21:48 INFO - 'tabpaint']}, 08:21:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:21:48 INFO - 'ts_paint', 08:21:48 INFO - 'tpaint', 08:21:48 INFO - 'sessionrestore', 08:21:48 INFO - 'sessionrestore_no_auto_restore', 08:21:48 INFO - 'tabpaint']}, 08:21:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:21:48 INFO - 'ts_paint', 08:21:48 INFO - 'tpaint', 08:21:48 INFO - 'sessionrestore', 08:21:48 INFO - 'sessionrestore_no_auto_restore', 08:21:48 INFO - 'tabpaint']}, 08:21:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['a11yr', 08:21:48 INFO - 'ts_paint', 08:21:48 INFO - 'tpaint', 08:21:48 INFO - 'sessionrestore', 08:21:48 INFO - 'sessionrestore_no_auto_restore', 08:21:48 INFO - 'tabpaint']}, 08:21:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['a11yr', 08:21:48 INFO - 'ts_paint', 08:21:48 INFO - 'tpaint', 08:21:48 INFO - 'sessionrestore', 08:21:48 INFO - 'sessionrestore_no_auto_restore', 08:21:48 INFO - 'tabpaint']}, 08:21:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['tsvgx', 08:21:48 INFO - 'tsvgr_opacity', 08:21:48 INFO - 'tart', 08:21:48 INFO - 'tscrollx', 08:21:48 INFO - 'cart']}, 08:21:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:21:48 INFO - 'tsvgr_opacity', 08:21:48 INFO - 'tart', 08:21:48 INFO - 'tscrollx', 08:21:48 INFO - 'cart']}, 08:21:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'talos_options': ['--disable-e10s'], 08:21:48 INFO - 'tests': ['tp5o']}, 08:21:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'tests': ['tp5o']}, 08:21:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'talos_options': ['--disable-e10s', 08:21:48 INFO - '--xperf_path', 08:21:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:48 INFO - 'tests': ['tp5n']}, 08:21:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:48 INFO - 'talos_options': ['--xperf_path', 08:21:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:48 INFO - 'tests': ['tp5n']}}, 08:21:48 INFO - 'talos.zip': {'path': '', 08:21:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:21:48 INFO - Running post-action listener: _resource_record_post_action 08:21:48 INFO - ##### 08:21:48 INFO - ##### Running create-virtualenv step. 08:21:48 INFO - ##### 08:21:48 INFO - Running pre-action listener: _resource_record_pre_action 08:21:48 INFO - Running main action method: create_virtualenv 08:21:48 INFO - Creating virtualenv /builds/slave/test/build/venv 08:21:48 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 08:21:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:21:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:21:49 INFO - Using real prefix '/usr' 08:21:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:21:49 INFO - Installing distribute.............................................................................................................................................................................................done. 08:21:51 INFO - Installing pip.................done. 08:21:51 INFO - Return code: 0 08:21:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:51 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 0x7fa477325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031410>, '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 0x2032310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20327a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', '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 08:21:51 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 08:21:51 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 08:21:51 INFO - Using env: {'DISPLAY': ':0', 08:21:51 INFO - 'HOME': '/home/cltbld', 08:21:51 INFO - 'LANG': 'en_US.UTF-8', 08:21:51 INFO - 'LANGUAGE': 'en_US:en', 08:21:51 INFO - 'LOGNAME': 'cltbld', 08:21:51 INFO - 'MAIL': '/var/mail/cltbld', 08:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:51 INFO - 'MOZ_NO_REMOTE': '1', 08:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:51 INFO - 'NO_EM_RESTART': '1', 08:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:51 INFO - 'PWD': '/builds/slave/test', 08:21:51 INFO - 'SHELL': '/bin/bash', 08:21:51 INFO - 'SHLVL': '1', 08:21:51 INFO - 'TERM': 'linux', 08:21:51 INFO - 'TMOUT': '86400', 08:21:51 INFO - 'USER': 'cltbld', 08:21:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', 08:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:51 INFO - '_': '/tools/buildbot/bin/python'} 08:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:51 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 08:21:51 INFO - Cleaning up... 08:21:51 INFO - Return code: 0 08:21:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:51 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 0x7fa477325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031410>, '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 0x2032310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20327a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', '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 08:21:51 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 08:21:51 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 08:21:51 INFO - Using env: {'DISPLAY': ':0', 08:21:51 INFO - 'HOME': '/home/cltbld', 08:21:51 INFO - 'LANG': 'en_US.UTF-8', 08:21:51 INFO - 'LANGUAGE': 'en_US:en', 08:21:51 INFO - 'LOGNAME': 'cltbld', 08:21:51 INFO - 'MAIL': '/var/mail/cltbld', 08:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:51 INFO - 'MOZ_NO_REMOTE': '1', 08:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:51 INFO - 'NO_EM_RESTART': '1', 08:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:51 INFO - 'PWD': '/builds/slave/test', 08:21:51 INFO - 'SHELL': '/bin/bash', 08:21:51 INFO - 'SHLVL': '1', 08:21:51 INFO - 'TERM': 'linux', 08:21:51 INFO - 'TMOUT': '86400', 08:21:51 INFO - 'USER': 'cltbld', 08:21:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', 08:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:51 INFO - '_': '/tools/buildbot/bin/python'} 08:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:51 INFO - Downloading/unpacking psutil>=0.7.1 08:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:21:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:54 INFO - Installing collected packages: psutil 08:21:54 INFO - Running setup.py install for psutil 08:21:54 INFO - building 'psutil._psutil_linux' extension 08:21:54 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 08:21:54 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 08:21:54 INFO - building 'psutil._psutil_posix' extension 08:21:54 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 08:21:54 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 08:21:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:54 INFO - Successfully installed psutil 08:21:54 INFO - Cleaning up... 08:21:54 INFO - Return code: 0 08:21:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08: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')]} 08:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa477325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031410>, '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 0x2032310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20327a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', '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 08:21:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:21:54 INFO - Using env: {'DISPLAY': ':0', 08:21:54 INFO - 'HOME': '/home/cltbld', 08:21:54 INFO - 'LANG': 'en_US.UTF-8', 08:21:54 INFO - 'LANGUAGE': 'en_US:en', 08:21:54 INFO - 'LOGNAME': 'cltbld', 08:21:54 INFO - 'MAIL': '/var/mail/cltbld', 08:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:54 INFO - 'MOZ_NO_REMOTE': '1', 08:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:54 INFO - 'NO_EM_RESTART': '1', 08:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:54 INFO - 'PWD': '/builds/slave/test', 08:21:54 INFO - 'SHELL': '/bin/bash', 08:21:54 INFO - 'SHLVL': '1', 08:21:54 INFO - 'TERM': 'linux', 08:21:54 INFO - 'TMOUT': '86400', 08:21:54 INFO - 'USER': 'cltbld', 08:21:54 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', 08:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:54 INFO - '_': '/tools/buildbot/bin/python'} 08:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:21:56 INFO - Installing collected packages: mozsystemmonitor 08:21:56 INFO - Running setup.py install for mozsystemmonitor 08:21:56 INFO - Successfully installed mozsystemmonitor 08:21:56 INFO - Cleaning up... 08:21:56 INFO - Return code: 0 08:21:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:21:56 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')]} 08:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:56 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')]} 08:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:56 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 0x7fa477325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031410>, '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 0x2032310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20327a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', '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 08:21:56 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 08:21:56 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 08:21:56 INFO - Using env: {'DISPLAY': ':0', 08:21:56 INFO - 'HOME': '/home/cltbld', 08:21:56 INFO - 'LANG': 'en_US.UTF-8', 08:21:56 INFO - 'LANGUAGE': 'en_US:en', 08:21:56 INFO - 'LOGNAME': 'cltbld', 08:21:56 INFO - 'MAIL': '/var/mail/cltbld', 08:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:56 INFO - 'MOZ_NO_REMOTE': '1', 08:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:56 INFO - 'NO_EM_RESTART': '1', 08:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:56 INFO - 'PWD': '/builds/slave/test', 08:21:56 INFO - 'SHELL': '/bin/bash', 08:21:56 INFO - 'SHLVL': '1', 08:21:56 INFO - 'TERM': 'linux', 08:21:56 INFO - 'TMOUT': '86400', 08:21:56 INFO - 'USER': 'cltbld', 08:21:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', 08:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:56 INFO - '_': '/tools/buildbot/bin/python'} 08:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:57 INFO - Downloading/unpacking blobuploader==1.2.4 08:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:58 INFO - Downloading blobuploader-1.2.4.tar.gz 08:21:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:21:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:21:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 INFO - Downloading docopt-0.6.1.tar.gz 08:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:21:59 INFO - Installing collected packages: blobuploader, requests, docopt 08:21:59 INFO - Running setup.py install for blobuploader 08:21:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:21:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:21:59 INFO - Running setup.py install for requests 08:22:00 INFO - Running setup.py install for docopt 08:22:00 INFO - Successfully installed blobuploader requests docopt 08:22:00 INFO - Cleaning up... 08:22:00 INFO - Return code: 0 08:22:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08: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')]} 08:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:00 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 0x7fa477325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031410>, '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 0x2032310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20327a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', '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 08:22:00 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 08:22:00 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 08:22:00 INFO - Using env: {'DISPLAY': ':0', 08:22:00 INFO - 'HOME': '/home/cltbld', 08:22:00 INFO - 'LANG': 'en_US.UTF-8', 08:22:00 INFO - 'LANGUAGE': 'en_US:en', 08:22:00 INFO - 'LOGNAME': 'cltbld', 08:22:00 INFO - 'MAIL': '/var/mail/cltbld', 08:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:00 INFO - 'MOZ_NO_REMOTE': '1', 08:22:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:00 INFO - 'NO_EM_RESTART': '1', 08:22:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:00 INFO - 'PWD': '/builds/slave/test', 08:22:00 INFO - 'SHELL': '/bin/bash', 08:22:00 INFO - 'SHLVL': '1', 08:22:00 INFO - 'TERM': 'linux', 08:22:00 INFO - 'TMOUT': '86400', 08:22:00 INFO - 'USER': 'cltbld', 08:22:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', 08:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:00 INFO - '_': '/tools/buildbot/bin/python'} 08:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:00 INFO - Running setup.py (path:/tmp/pip-zau8x3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:00 INFO - Running setup.py (path:/tmp/pip-xi3TtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:00 INFO - Running setup.py (path:/tmp/pip-miz7Qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:00 INFO - Running setup.py (path:/tmp/pip-y1JlcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:00 INFO - Running setup.py (path:/tmp/pip-CQ2xGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:00 INFO - Running setup.py (path:/tmp/pip-AHtr51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:00 INFO - Running setup.py (path:/tmp/pip-kHixbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:00 INFO - Running setup.py (path:/tmp/pip-S5BSRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:01 INFO - Running setup.py (path:/tmp/pip-FhjIOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:01 INFO - Running setup.py (path:/tmp/pip-DG7mAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:01 INFO - Running setup.py (path:/tmp/pip-FrjEPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:01 INFO - Running setup.py (path:/tmp/pip-VgQdDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:01 INFO - Running setup.py (path:/tmp/pip-HBdy92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:01 INFO - Running setup.py (path:/tmp/pip-OTglik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:01 INFO - Running setup.py (path:/tmp/pip-zbp3oM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:01 INFO - Running setup.py (path:/tmp/pip-E6YjYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:01 INFO - Running setup.py (path:/tmp/pip-AGgUn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:22:01 INFO - Running setup.py install for manifestparser 08:22:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:22:01 INFO - Running setup.py install for mozcrash 08:22:01 INFO - Running setup.py install for mozdebug 08:22:01 INFO - Running setup.py install for mozdevice 08:22:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:22:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:22:02 INFO - Running setup.py install for mozfile 08:22:02 INFO - Running setup.py install for mozhttpd 08:22:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:22:02 INFO - Running setup.py install for mozinfo 08:22:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:22:02 INFO - Running setup.py install for mozInstall 08:22:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:22:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:22:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:22:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:22:02 INFO - Running setup.py install for mozleak 08:22:02 INFO - Running setup.py install for mozlog 08:22:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:22:02 INFO - Running setup.py install for moznetwork 08:22:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:22:02 INFO - Running setup.py install for mozprocess 08:22:02 INFO - Running setup.py install for mozprofile 08:22:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:22:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:22:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:22:02 INFO - Running setup.py install for mozrunner 08:22:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:22:03 INFO - Running setup.py install for mozscreenshot 08:22:03 INFO - Running setup.py install for moztest 08:22:03 INFO - Running setup.py install for mozversion 08:22:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:22:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:22:03 INFO - Cleaning up... 08:22:03 INFO - Return code: 0 08:22:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:03 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')]} 08:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:03 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')]} 08:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:03 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 0x7fa477325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031410>, '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 0x2032310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20327a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', '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 08:22:03 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 08:22:03 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 08:22:03 INFO - Using env: {'DISPLAY': ':0', 08:22:03 INFO - 'HOME': '/home/cltbld', 08:22:03 INFO - 'LANG': 'en_US.UTF-8', 08:22:03 INFO - 'LANGUAGE': 'en_US:en', 08:22:03 INFO - 'LOGNAME': 'cltbld', 08:22:03 INFO - 'MAIL': '/var/mail/cltbld', 08:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:03 INFO - 'MOZ_NO_REMOTE': '1', 08:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:03 INFO - 'NO_EM_RESTART': '1', 08:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:03 INFO - 'PWD': '/builds/slave/test', 08:22:03 INFO - 'SHELL': '/bin/bash', 08:22:03 INFO - 'SHLVL': '1', 08:22:03 INFO - 'TERM': 'linux', 08:22:03 INFO - 'TMOUT': '86400', 08:22:03 INFO - 'USER': 'cltbld', 08:22:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', 08:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:03 INFO - '_': '/tools/buildbot/bin/python'} 08:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:03 INFO - Running setup.py (path:/tmp/pip-_zGZRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:03 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)) 08:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:03 INFO - Running setup.py (path:/tmp/pip-5xc7yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:03 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)) 08:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:03 INFO - Running setup.py (path:/tmp/pip-4w94HE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:03 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)) 08:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:03 INFO - Running setup.py (path:/tmp/pip-suNQUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:03 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)) 08:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:03 INFO - Running setup.py (path:/tmp/pip-7EEuDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:03 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)) 08:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:03 INFO - Running setup.py (path:/tmp/pip-yBqtuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:04 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)) 08:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:04 INFO - Running setup.py (path:/tmp/pip-mcrAWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:04 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)) 08:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:04 INFO - Running setup.py (path:/tmp/pip-lLwT0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:04 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)) 08:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:04 INFO - Running setup.py (path:/tmp/pip-gdfNRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:04 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)) 08:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:04 INFO - Running setup.py (path:/tmp/pip-wooLM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:04 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)) 08:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:04 INFO - Running setup.py (path:/tmp/pip-c78W4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:04 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)) 08:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:04 INFO - Running setup.py (path:/tmp/pip-eZKgTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:04 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)) 08:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:04 INFO - Running setup.py (path:/tmp/pip-DpXBEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:04 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)) 08:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:04 INFO - Running setup.py (path:/tmp/pip-TRfeQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:04 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)) 08:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:04 INFO - Running setup.py (path:/tmp/pip-G608Cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:04 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)) 08:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:04 INFO - Running setup.py (path:/tmp/pip-s3Z_X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:04 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)) 08:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:04 INFO - Running setup.py (path:/tmp/pip-7G3XUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:04 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)) 08:22:04 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)) 08:22:04 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)) 08:22:04 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)) 08:22:04 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)) 08:22:04 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)) 08:22:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:22:04 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 08:22:04 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 08:22:04 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 08:22:04 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 08:22:04 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 08:22:04 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 08:22:06 INFO - Downloading blessings-1.6.tar.gz 08:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:22:06 INFO - Installing collected packages: blessings 08:22:06 INFO - Running setup.py install for blessings 08:22:06 INFO - Successfully installed blessings 08:22:06 INFO - Cleaning up... 08:22:06 INFO - Return code: 0 08:22:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:22:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:07 INFO - Reading from file tmpfile_stdout 08:22:07 INFO - Current package versions: 08:22:07 INFO - argparse == 1.2.1 08:22:07 INFO - blessings == 1.6 08:22:07 INFO - blobuploader == 1.2.4 08:22:07 INFO - docopt == 0.6.1 08:22:07 INFO - manifestparser == 1.1 08:22:07 INFO - mozInstall == 1.12 08:22:07 INFO - mozcrash == 0.17 08:22:07 INFO - mozdebug == 0.1 08:22:07 INFO - mozdevice == 0.48 08:22:07 INFO - mozfile == 1.2 08:22:07 INFO - mozhttpd == 0.7 08:22:07 INFO - mozinfo == 0.9 08:22:07 INFO - mozleak == 0.1 08:22:07 INFO - mozlog == 3.1 08:22:07 INFO - moznetwork == 0.27 08:22:07 INFO - mozprocess == 0.22 08:22:07 INFO - mozprofile == 0.28 08:22:07 INFO - mozrunner == 6.11 08:22:07 INFO - mozscreenshot == 0.1 08:22:07 INFO - mozsystemmonitor == 0.0 08:22:07 INFO - moztest == 0.7 08:22:07 INFO - mozversion == 1.4 08:22:07 INFO - psutil == 3.1.1 08:22:07 INFO - requests == 1.2.3 08:22:07 INFO - wsgiref == 0.1.2 08:22:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:07 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')]} 08:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:07 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')]} 08:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:07 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 0x7fa477325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031410>, '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 0x2032310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20327a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', '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 08:22:07 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 08:22:07 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 08:22:07 INFO - Using env: {'DISPLAY': ':0', 08:22:07 INFO - 'HOME': '/home/cltbld', 08:22:07 INFO - 'LANG': 'en_US.UTF-8', 08:22:07 INFO - 'LANGUAGE': 'en_US:en', 08:22:07 INFO - 'LOGNAME': 'cltbld', 08:22:07 INFO - 'MAIL': '/var/mail/cltbld', 08:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:07 INFO - 'MOZ_NO_REMOTE': '1', 08:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:07 INFO - 'NO_EM_RESTART': '1', 08:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:07 INFO - 'PWD': '/builds/slave/test', 08:22:07 INFO - 'SHELL': '/bin/bash', 08:22:07 INFO - 'SHLVL': '1', 08:22:07 INFO - 'TERM': 'linux', 08:22:07 INFO - 'TMOUT': '86400', 08:22:07 INFO - 'USER': 'cltbld', 08:22:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', 08:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:07 INFO - '_': '/tools/buildbot/bin/python'} 08:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:07 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)) 08:22:07 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)) 08:22:07 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)) 08:22:07 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)) 08:22:07 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)) 08:22:07 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)) 08:22:07 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)) 08:22:07 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)) 08:22:07 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)) 08:22:07 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)) 08:22:07 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)) 08:22:07 INFO - Cleaning up... 08:22:07 INFO - Return code: 0 08:22:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:22:07 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')]} 08:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:07 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')]} 08:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:07 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 0x7fa477325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031410>, '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 0x2032310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20327a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', '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 08:22:07 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 08:22:07 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 08:22:07 INFO - Using env: {'DISPLAY': ':0', 08:22:07 INFO - 'HOME': '/home/cltbld', 08:22:07 INFO - 'LANG': 'en_US.UTF-8', 08:22:07 INFO - 'LANGUAGE': 'en_US:en', 08:22:07 INFO - 'LOGNAME': 'cltbld', 08:22:07 INFO - 'MAIL': '/var/mail/cltbld', 08:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:07 INFO - 'MOZ_NO_REMOTE': '1', 08:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:07 INFO - 'NO_EM_RESTART': '1', 08:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:07 INFO - 'PWD': '/builds/slave/test', 08:22:07 INFO - 'SHELL': '/bin/bash', 08:22:07 INFO - 'SHLVL': '1', 08:22:07 INFO - 'TERM': 'linux', 08:22:07 INFO - 'TMOUT': '86400', 08:22:07 INFO - 'USER': 'cltbld', 08:22:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', 08:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:07 INFO - '_': '/tools/buildbot/bin/python'} 08:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:07 INFO - Downloading/unpacking jsonschema 08:22:07 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 08:22:07 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 08:22:07 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 08:22:07 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 08:22:07 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 08:22:07 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 08:22:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:22:09 INFO - Downloading/unpacking functools32 (from jsonschema) 08:22:09 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 08:22:09 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 08:22:09 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 08:22:09 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 08:22:09 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 08:22:09 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 08:22:09 INFO - Downloading functools32-3.2.3-2.tar.gz 08:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:22:09 INFO - warning: no files found matching '*.txt' 08:22:09 INFO - no previously-included directories found matching 'build' 08:22:09 INFO - no previously-included directories found matching 'dist' 08:22:09 INFO - no previously-included directories found matching '.git*' 08:22:09 INFO - Installing collected packages: jsonschema, functools32 08:22:09 INFO - Running setup.py install for functools32 08:22:09 INFO - warning: no files found matching '*.txt' 08:22:09 INFO - no previously-included directories found matching 'build' 08:22:09 INFO - no previously-included directories found matching 'dist' 08:22:09 INFO - no previously-included directories found matching '.git*' 08:22:09 INFO - Successfully installed jsonschema functools32 08:22:09 INFO - Cleaning up... 08:22:09 INFO - Return code: 0 08:22:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:09 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 0x7fa477325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031410>, '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 0x2032310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20327a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', '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 08:22:09 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 08:22:09 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 08:22:09 INFO - Using env: {'DISPLAY': ':0', 08:22:09 INFO - 'HOME': '/home/cltbld', 08:22:09 INFO - 'LANG': 'en_US.UTF-8', 08:22:09 INFO - 'LANGUAGE': 'en_US:en', 08:22:09 INFO - 'LOGNAME': 'cltbld', 08:22:09 INFO - 'MAIL': '/var/mail/cltbld', 08:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:09 INFO - 'MOZ_NO_REMOTE': '1', 08:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:09 INFO - 'NO_EM_RESTART': '1', 08:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:09 INFO - 'PWD': '/builds/slave/test', 08:22:09 INFO - 'SHELL': '/bin/bash', 08:22:09 INFO - 'SHLVL': '1', 08:22:09 INFO - 'TERM': 'linux', 08:22:09 INFO - 'TMOUT': '86400', 08:22:09 INFO - 'USER': 'cltbld', 08:22:09 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', 08:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:09 INFO - '_': '/tools/buildbot/bin/python'} 08:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:10 INFO - Downloading/unpacking flake8 08:22:10 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 08:22:10 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 08:22:10 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 08:22:10 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 08:22:10 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 08:22:10 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 08:22:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:22:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:22:12 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 08:22:12 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 08:22:12 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 08:22:12 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 08:22:12 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 08:22:12 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 08:22:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:22:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:22:12 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 08:22:12 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 08:22:12 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 08:22:12 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 08:22:12 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 08:22:12 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 08:22:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:22:12 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 08:22:12 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 08:22:12 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 08:22:12 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 08:22:12 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 08:22:12 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 08:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:22:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:22:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:22:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:22:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:22:12 INFO - no previously-included directories found matching 'docs/_build' 08:22:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:22:12 INFO - Running setup.py install for pep8 08:22:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:22:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:22:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:22:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:22:12 INFO - no previously-included directories found matching 'docs/_build' 08:22:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:22:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:22:12 INFO - Cleaning up... 08:22:13 INFO - Return code: 0 08:22:13 INFO - Running post-action listener: _resource_record_post_action 08:22:13 INFO - Running post-action listener: _start_resource_monitoring 08:22:13 INFO - Starting resource monitoring. 08:22:13 INFO - ##### 08:22:13 INFO - ##### Running install step. 08:22:13 INFO - ##### 08:22:13 INFO - Running pre-action listener: _resource_record_pre_action 08:22:13 INFO - Running main action method: install 08:22:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:13 INFO - Reading from file tmpfile_stdout 08:22:13 INFO - Detecting whether we're running mozinstall >=1.0... 08:22:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:22:13 INFO - Reading from file tmpfile_stdout 08:22:13 INFO - Output received: 08:22:13 INFO - Usage: mozinstall [options] installer 08:22:13 INFO - Options: 08:22:13 INFO - -h, --help show this help message and exit 08:22:13 INFO - -d DEST, --destination=DEST 08:22:13 INFO - Directory to install application into. [default: 08:22:13 INFO - "/builds/slave/test"] 08:22:13 INFO - --app=APP Application being installed. [default: firefox] 08:22:13 INFO - mkdir: /builds/slave/test/build/application 08:22:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:22:29 INFO - Reading from file tmpfile_stdout 08:22:29 INFO - Output received: 08:22:29 INFO - /builds/slave/test/build/application/firefox/firefox 08:22:29 INFO - Running post-action listener: _resource_record_post_action 08:22:29 INFO - ##### 08:22:29 INFO - ##### Running run-tests step. 08:22:29 INFO - ##### 08:22:29 INFO - Running pre-action listener: _resource_record_pre_action 08:22:29 INFO - Running main action method: run_tests 08:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:22:29 INFO - Python 2.7.3 08:22:29 INFO - Return code: 0 08:22:29 INFO - grabbing minidump binary from tooltool 08:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:29 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 0x2031410>, '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 0x2032310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20327a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:22:29 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 08:22:29 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 08:22:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:22:29 INFO - Return code: 0 08:22:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:22:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:22:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:22:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:22:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:22:30 INFO - Return code: 0 08:22:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:22:30 INFO - Using env: {'DISPLAY': ':0', 08:22:30 INFO - 'HOME': '/home/cltbld', 08:22:30 INFO - 'LANG': 'en_US.UTF-8', 08:22:30 INFO - 'LANGUAGE': 'en_US:en', 08:22:30 INFO - 'LOGNAME': 'cltbld', 08:22:30 INFO - 'MAIL': '/var/mail/cltbld', 08:22:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:22:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:30 INFO - 'MOZ_NO_REMOTE': '1', 08:22:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:30 INFO - 'NO_EM_RESTART': '1', 08:22:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:30 INFO - 'PWD': '/builds/slave/test', 08:22:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:22:30 INFO - 'SHELL': '/bin/bash', 08:22:30 INFO - 'SHLVL': '1', 08:22:30 INFO - 'TERM': 'linux', 08:22:30 INFO - 'TMOUT': '86400', 08:22:30 INFO - 'USER': 'cltbld', 08:22:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730', 08:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:30 INFO - '_': '/tools/buildbot/bin/python'} 08:22:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:22:30 INFO - mozversion application_buildid: 20160422065559 08:22:30 INFO - mozversion application_changeset: 005449bf12df9fa386f1644823961cebd94ed0e7 08:22:30 INFO - mozversion application_display_name: Nightly 08:22:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:22:30 INFO - mozversion application_name: Firefox 08:22:30 INFO - mozversion application_remotingname: firefox 08:22:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:22:30 INFO - mozversion application_vendor: Mozilla 08:22:30 INFO - mozversion application_version: 48.0a1 08:22:30 INFO - mozversion platform_buildid: 20160422065559 08:22:30 INFO - mozversion platform_changeset: 005449bf12df9fa386f1644823961cebd94ed0e7 08:22:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:22:30 INFO - mozversion platform_version: 48.0a1 08:22:30 INFO - using testdate: 1461338550 08:22:30 INFO - actual date: 1461338550 08:22:30 INFO - starting webserver on 'localhost:60332' 08:22:30 INFO - SUITE-START | Running 2 tests 08:22:30 INFO - TEST-START | dromaeo_css 08:22:30 INFO - operating with platform_type : linux_ 08:22:30 INFO - Initialising browser for dromaeo_css test... 08:22:30 INFO - TEST-INFO | started process 1429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdchnkQ/profile http://localhost:60332/getInfo.html) 08:22:34 INFO - PROCESS | 1429 | 08:22:34 INFO - PROCESS | 1429 | (process:1495): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:22:35 INFO - PROCESS | 1429 | __metrics Screen width/height:1600/1200 08:22:35 INFO - PROCESS | 1429 | colorDepth:24 08:22:35 INFO - PROCESS | 1429 | Browser inner width/height: 1024/697 08:22:35 INFO - PROCESS | 1429 | __metrics 08:22:35 ERROR - PROCESS | 1429 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:22:36 INFO - TEST-INFO | 1429: exit 0 08:22:36 INFO - Browser initialized. 08:22:36 INFO - Running cycle 1/1 for dromaeo_css test... 08:22:36 INFO - TEST-INFO | started process 1546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdchnkQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:38 INFO - PROCESS | 1546 | 08:22:38 INFO - PROCESS | 1546 | (process:1606): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:22:48 INFO - PROCESS | 1546 | RSS: Main: 165253120 08:22:48 INFO - PROCESS | 1546 | 08:23:38 INFO - PROCESS | 1546 | 1461338618331 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] 08:25:50 INFO - PROCESS | 1546 | Cycle 1(1): loaded http://localhost:60332/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60332/tests/dromaeo/cssquery-ext.html) 08:25:51 INFO - PROCESS | 1546 | RSS: Main: 167591936 08:25:51 INFO - PROCESS | 1546 | 08:28:53 INFO - PROCESS | 1546 | Cycle 1(1): loaded http://localhost:60332/tests/dromaeo/cssquery-ext.html (next: http://localhost:60332/tests/dromaeo/cssquery-jquery.html) 08:28:54 INFO - PROCESS | 1546 | RSS: Main: 165875712 08:28:54 INFO - PROCESS | 1546 | 08:31:55 INFO - PROCESS | 1546 | Cycle 1(1): loaded http://localhost:60332/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60332/tests/dromaeo/cssquery-mootools.html) 08:31:56 INFO - PROCESS | 1546 | RSS: Main: 167202816 08:31:56 INFO - PROCESS | 1546 | 08:34:58 INFO - PROCESS | 1546 | Cycle 1(1): loaded http://localhost:60332/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60332/tests/dromaeo/cssquery-prototype.html) 08:34:58 INFO - PROCESS | 1546 | RSS: Main: 164777984 08:34:58 INFO - PROCESS | 1546 | 08:38:01 INFO - PROCESS | 1546 | Cycle 1(1): loaded http://localhost:60332/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60332/tests/dromaeo/cssquery-yui.html) 08:38:02 INFO - PROCESS | 1546 | RSS: Main: 165769216 08:38:02 INFO - PROCESS | 1546 | 08:41:04 INFO - PROCESS | 1546 | Cycle 1(1): loaded http://localhost:60332/tests/dromaeo/cssquery-yui.html (next: http://localhost:60332/tests/dromaeo/cssquery-dojo.html) 08:41:04 INFO - PROCESS | 1546 | RSS: Main: 167899136 08:41:04 INFO - PROCESS | 1546 | 08:41:04 INFO - PROCESS | 1546 | __start_tp_report 08:41:04 INFO - PROCESS | 1546 | _x_x_mozilla_page_load 08:41:04 INFO - PROCESS | 1546 | _x_x_mozilla_page_load_details 08:41:04 INFO - PROCESS | 1546 | |i|pagename|runs| 08:41:04 INFO - PROCESS | 1546 | |0;dojo.html;2635.9341016474586;2699.406130651257;2729.5632698768177;2730.140005898142;2737.425140720449;4713.363695901053;4724.90550188996;4759.167145749489;4766.904661906764;4787.473377928433;4675.602573781232;4787.305840653104;4867.732274724889;4903.60771138309;4918.04098200851;4473.194824931511;4486.214912390335;4541.65937554683;4547.340635607851;4582.221022426195;4446.866594002185;4451.955480445203;4476.597106260436;4483.798229079699;4496.2581174106235;4371.606555410029;4402.559744025604;4409.5149533551285;4424.159409712144;4457.175422546807;4358.825646974149;4382.627476664487;4411.955880441219;4421.292593185075;4464.6874718769695;4432.623227025707;4451.087527056946;4451.443569553806;4458.353538736865;4487.0352874131895;4713.835015774432;4763.737994410306;4764.809407623691;4799.3760811094335;4812.302216178669;5109.20807274873;5110.310108135392;5150.819721309736;5154.917467331865;5176.818811341623;5043.117454445457;5167.09575824233;5187.559057480119;5190.455002224788;5195.246689230041;4821.132196204681;4830.782614782343;4846.5638092571835;4868.31843541908;4892.437369702458;5291.100512912814;5328.227407025959;5328.626996110235;5349.491798279158;5385.5960802939935;4934.481879402611;5046.873828154252;5116.130257856174;5129.8204562840865;5135.563477104488;5103.515166059218;5116.718580478109;5118.97440512795;5121.718305493234;5124.743762811844;5033.421156567042;5069.949300507022;5070.239464080344;5089.491050894955;5123.180291153398;5155.226715992556;5163.40620828602;5183.170692689152;5186.5850731941355;5220.269162317279;4268.87193384199;4411.20598292304;4425.468943726709;4447.977760111244;4489.214387482243;3865.40086286626;3887.2419878123496;3890.4164375343357;3908.257431088084;3931.8623848165175;4443.800028998703;4449.377087207794;4457.598816106566;4469.865904022885;4503.234450143418;5081.161608334583;5255.421903590602;5263.289455923478;5303.124984377535;5323.680579165262;4420.115976804652;4456.509783923766;4459.331100334911;4466.932996005063;4486.237339652202;4673.719576825401;4687.9765601171775;4691.671582989158;4694.718316900929;4741.905161896742;4722.5513576210205;4803.3995750531185;4813.302071199586;4835.323054772335;4867.464578896389;5225.817096401608;5250.133727934848;5256.816011439581;5267.288915996444;5273.261743355856;4836.588889944394;4859.805607775649;4873.829415970424;4878.048780487771;4929.211326187793;5004.47453017428;5099.668521546236;5120.743962801919;5154.845354639367;5168.328117344721;5149.201873709581;5149.459306772735;5166.199239117943;5171.405288391733;5189.896202076013;5002.499750024968;5066.986602679405;5071.518205770446;5087.440381557952;5101.974490127525;4914.70511769295;4966.950330496648;5010.649254552292;5030.84907452777;5053.69677819332;4744.620430365493;4923.975380123076;4928.383952005999;4932.506749325039;4985.351904252424;4963.751812409293;5015;5043.167877300204;5054.16606259963;5054.570361519312;4847.418309802846;4847.854564363075;4885.071836351224;4904.681195722266;4941.061198372297 08:41:04 INFO - PROCESS | 1546 | |1;ext.html;568.1960026562415;595.8927393069246;597.1222303214275;623.0529595015576;645.464264660332;34657.30685386291;35598.11004724877;35889.282214355764;36101.09747256317;36143.819280903626;38885.41671874917;39790.801045994805;39930.201395972064;40061.79969100158;40099.59900400995;7650.540967541951;7865.095514015876;7903.525788452683;7906.2884340409355;7911.56486393251;7688.500247483924;7705.73029943952;7780.338671212954;7783.922160778405;7803.960980195091;7783.766487005399;7783.883241751379;7797.727079552188;7808.648610812499;7815.882761758578;7681.193474685161;7705.383569314441;7761.107472640662;7791.649375778104;7797.961010194913;7781.144074151839;7862.410319226081;7896.921030789734;7899.8025049373655;7904.881426778603;35357.82321088404;35675.643243567494;35819.82090089533;35860.64139358599;35895.82052089749;2926.6488021437563;2994.5208766597457;3044.588980487628;3059.434004709136;3281.3109247058146;27259;28607.28481787972;28634.570481442795;28832.135035948955;29014.85492572545;3348.263382055968;3442.225499262671;3571.8928432146818;3580.6598373154507;3624.2026754114054;210681;212942;213721;214186;214720;32812;52578.73710631422;52808;52843.47156528462;53112.468875311526;31810.204744881565;32048;32113.357732845212;32162;32226;12484.75030499385;12763.936180319039;12769.872301277053;12771.169873958348;12821;9638.228941684649;9687.273454490942;9697.9030209697;9702.660406885725;9730.075642813921;7941.324987376138;7950.840983180419;8078.434509584273;8127.878081828777;8187.508749474931;3200.855961481739;3219.597550306212;3221.275213077039;3233.5958005249345;3302.339532093591;935.6351023100996;938.432248489654;939.618068197117;992.593036854886;1062.516554967488;27937.441251174863;28342.149735507966;29379.706202937698;29498;29756.40487190244;929.702495201529;934.3693007220099;955.1880901233895;957.3920560444029;970.9514524273758;13344.199348039148;14178.716425671635;14386.784198237036;14404.783928241084;14736.778948315783;355050;361549;362827;363723;364306;48236.7588162064;48695.75652121717;48963;48990.755046225255;49131.263031054565;1217.7990631545695;1243.570968016033;1267.7211013576998;1267.9366031698378;1364.0451683821366;26363.736362636897;27384.31539211456;27486;27786.44427111487;27937.58093628638;43243.78378108215;43429;43959.78020109879;44110.77944610256;44136.67589972306;316134;322330;322866;323076;323462;25361.49277014486;25371.87314063418;25761.227163185133;25852.482950340513;25943.61084583695;40787.592124079565;41748.58251417447;41884;42153.57846421497;42496.15007699891;35164;35188.47217291794;35295;35511.644883550834;35850.46224306586;34703.30593388169;34909.65090349064;35107.29785404226;35213.82393088018;35387.82306088556;31275.53086703747;34962.300753985284;35958.28083438369;36726;36782;28721.85639071875;29526.40947181087;30076.84961575178;30105.548416773327;30266.394672106875;23761.287161385186;24090.39774005664;24489.265322040366;24517.264482065566;24679.38301542404 08:41:04 INFO - PROCESS | 1546 | |2;jquery.html;383.854135428537;385.5335044596039;386.48404380152493;391.49301654357606;396.2293339454762;14843.109413435188;16526;16743.07913064781;16849.91575042123;16880.746788798162;12734.299613521276;14466.927665361685;15352.846471535282;15364.769528457055;15476.613084672861;4633.467151277604;4793.712377257359;4840.467548569654;4840.983393487354;4846.806127754886;3564.1624218308675;5853.853653658672;6199.101130336098;6204.410580994799;6215.627062376272;5216.556592689626;6116.357782432848;6135.447809697126;6139.7851075212375;6147.170132032164;5511.200875872996;5520.089185284423;5558.749856256478;5558.8610284743;5561.944380556203;5179.482051794828;5344.866378340534;5393.083175860113;5416.756245968941;5423.322084739408;12384.380780960915;12502.124851260416;12548.24710517372;12612.936935315265;12737.490500379974;2000.3698834867116;2013.8791672499697;2024.251027119975;2027.7465316835396;2411.626197939322;9811.43017117265;9913.206943444507;10309.381437113721;10797.892021079768;13543.051986360959;1699.8810083294175;1740.477856643002;1769.716845304758;1799.5321216483678;1804.6932021556368;66099;68130;68763.3123668762;68876.6556167221;69649;10028.648997285205;10104;10179.452198551808;10211.132053775513;10318.1745460363;13828.23944683032;13837.446502139801;13933.721325573635;13957.930210348883;14024.509142179975;7114.359707626339;7208.819779505554;7232.963835180791;7327.157376901618;7367.668454919542;6890.517663763589;6922.480813938974;6970.407515361251;7058.364747172779;7092.645367731593;4087.8773636790943;4108.589141085868;4142.047329114321;4335.631471324973;4371.650267978554;1670.7159782836948;1701.4640388277653;1726.2577091850624;1737.148797089417;1844.9354272600394;856.6958729651009;935.9204467620328;940.1209868772582;994.0109590957044;1013.0679774607379;15529.767053494206;16047.598810029842;16273.349066037463;16500.669986600442;17122;873.8296032273772;886.6409104312763;898.8022635020285;902.2195800632405;934.6775362499926;9075.410098343587;9149.725508234764;9254.583543740548;9284.396514226553;9482.620695172116;394421;395779;397991;399759;402082;74251;76693.6165319181;76839.2316076832;78525;79226;909.7452713240303;917.2799352508249;917.8623206519076;919.4621146629297;919.5953780336764;14332.641683957985;14411.207383594003;14643;14671.486497972519;14680.3393847275;33094.5035824458;33575.83212083924;34022.82988585041;34181.65818341785;34880;48762.5123748758;49149.262761059326;49358;49412.75293623509;49555.75222123866;7667.731629392944;7863.488873223222;7926.405519586169;7956.84086318282;8012.679492820455;8330.625121869409;9470.816147981503;10955.397453140155;11080.501377438195;11203.327800332007;9728.659496917573;9872.506374681381;9972.900270997487;9999.250056245664;10170.338927969658;9759.609615615296;9801.215902727907;9932.950335248277;10027.097561219525;10165.644202452879;9990.400575965465;10034.247431442525;10155.7461063474;10182.134518566005;10227.693169204937;7713.112992005991;7757.224277572198;7786.143524212219;7850.685972561262;7852.764417067498;9400.623975040922;9649.758756031155;9766.56050477716;9870.654527091518;10008.44953527563 08:41:04 INFO - PROCESS | 1546 | |3;mootools.html;1366.2622184020627;1428.086024944036;1501.5645462815785;1708.9230984605692;1769.4249368955084;7018.403435707971;7693.3845292376545;7719.382449404048;7950.125486196521;7965.641546130423;7756.573388463632;7772.922270777304;7794.259545343198;7820.06159260888;7825.373970082394;2258.322503249027;2299.666548350488;2303.873286969216;2311.711036120485;2312.537492501498;2236.944076398087;2239.6528538076623;2276.4764104256033;2307.40007598024;2314.537092581482;2286.9199578014773;2296.0586159674535;2314.085936055257;2315.617923042696;2316.2124877541632;2233.2853486884205;2238.9664155037685;2244.6633005049293;2245.8764767937837;2260.547890421922;2238.9664155037526;2250.0662225176534;2250.223672832886;2255.267038212571;2255.379770563092;7943.841123177504;7955.562444065574;7958.60206989654;8017.919820801776;8045.436819422643;4681.204195286809;4852.126617208901;4883.975580122112;4886.853394398174;4887.8513549315885;2864.570314452828;2872.339361946743;3041.422129795332;3056.327607926275;3074.6617872034058;941.204682043672;949.6818565780471;958.6740508227166;964.6671898195111;983.8278301297245;10888.510017049251;10911.672649820519;10970.232083754061;10990.120790336754;11012;4225.471816022997;4325.567443255649;4444.8444304449185;4496.775161241991;4532.79602417892;9062.229710474683;9078.682246121354;9080.31897607682;9082.273418126533;9136.040715724886;4803.159447096814;4813.542713442217;4826.493218212037;4829.275608658659;4854.393200849894;3776.6034566370686;4288.742675439421;4324.891877703019;4326.697131200785;4404.779761011937;3675.5221821163614;3736.4955730976512;3752.45589389537;3814.6757525610633;3818.5035945327486;1228.336698182989;1252.267423557211;1257.9182353147198;1268.289757735671;1268.9111762176558;679.2053297641771;747.5253214209016;763.9809004774925;781.5545139270561;790.9644066017044;5119.795208191631;5140.049090918192;5155.74221288934;5180.974095129575;5216.40011398694;424.3613361890335;426.97738915297685;432.5479873532166;435.4926510615098;438.3424862705941;3509.771864828778;3625.220577575834;3651.1054791576234;3663.9084022899106;3667.651573100551;9596.136347728738;10043.799124017478;10045.598176073021;10084.49577521121;10097.394156350643;9331.72004839856;9888.901110988942;9939.204863611038;9968.451735154636;10003.949980250052;7196.820079498055;7343.265673432614;7348.926510734825;7358.080239970004;7362.926370736332;4966.726830024239;5094.133997220407;5183.637145399785;5199.220116982332;5222.42553319127;8503.914960850312;8530.10433904431;8567.914320856711;8579.785505362415;8596.65613375483;8589.914100858912;8735.213830755263;9068.90931090707;9089.31830112731;9118.088191181094;6090.116933044772;6595.175603049619;6761.425278851353;6840.179178498612;6854.828629284308;7398.445116616168;7438.925610743823;7455.329020388191;7490.5131166474;7499.362554182955;6510.6093634380195;6724.226713927961;6738.292479289604;6765.289644587444;6842.213145488333;6495;6502.707378167899;6540.574862633914;6627.3372662733345;6670.799876003728;6120.296165940974;6127.234095738033;6178.969105154445;6186.133941248138;6194.969025154845;4330.328799036154;4439.240695530917;4489.124620699063;4506;4516;4267.16790225903;4299.69902106862;4339.284018136972;4403.163398954189;4465.263231566885 08:41:04 INFO - PROCESS | 1546 | |4;prototype.html;315.161669957912;318.19179284617076;320.1739512058888;321.7844044490191;324.7337183509522;5356.839294821157;5434.1305391137375;5434.83695489135;5466.316710411199;5466.508014278714;5337.306150200468;5354.170103633934;5361.544268737152;5366.812161574346;5368;3940.113474468243;4034.9193016139807;4201.096764195698;4207.558206388331;4210.010647497836;4200.781773285744;4203.327467605184;4213.0087637777215;4213.7893105344765;4234.597713217255;4175.185838761443;4176.415301857743;4180.289350810354;4180.331147016478;4193.4693836749675;4074.694397920153;4137.172565486914;4155.31437312843;4163.333866581347;4167;3640.672339489459;3651.8904432867057;3658.5426821647293;3662.3773958426864;3677.2829298286847;5108.667936584147;5115.181570948667;5132.307138536325;5145.048166089286;5148.073346797575;4739.573438390527;4782.043591281723;4812.061647978646;4815.9036819263765;4818.301346304801;5630.634008789457;5648.632838865502;5678.148277758328;5678.290213723285;5690.60165788395;4001.97999010006;4047.028713108862;4047.291723948297;4051.8581849635416;4057.5739547347694;5673.23411339468;5958.791442299499;5973.8805223895715;5985.401459854023;6009.308929473123;4090.406891000788;4109.116539943867;4112.136451345191;4118.4440100586635;4124.711270211116;4161.4382058421725;4169.874903752892;4175.248455278079;4201.894952626209;4203.180379825904;4660.766961651904;4758.381410416624;4766.165920963817;4768.332433459318;4786.401699787527;5651.378348381757;5660.915086273627;5674.602777805597;5676.0918253080135;5678.68767217807;1455.5706066710345;1487.360435012955;1489.508462207469;1491.075533169442;1495.3271028037427;896.6996056321206;971.7862070344513;987.7135630667026;1007.4861820471613;1013.8428543575758;4773.880652983703;4781.187198176319;4827.565519103297;4831.396075490564;4850.733209673432;5804.709764511757;5806.390329015477;5825.213596164548;5832.270966129234;5835.328937172195;4758.833440829554;4837.105135549864;4843.225083986616;4851.248056551241;4879.853604391874;3119.5008798592116;3156.2425017995515;3163.557102005721;3165.1770539659856;3178.825164615922;5419.891602167934;5421.1055175895535;5431.103867861838;5431.809886654027;5438.619296649196;5757.337906140848;5955.851103722355;5961.433663801932;5997.280326360865;6006.879862402728;5321.733913304397;5380.78476860929;5394.056040192951;5410.540104091197;5416.51251387377;5585.9720701397855;5799.652020878761;5825.883482330414;5842.561807864512;5852.473277405054;5683.277453268116;5690.743916523684;5699.116636921284;5714.485696287354;5727.427257274239;5380.677159370451;5383.865403364947;5400;5414.75633596497;5416.079266524622;3772.830222639933;4033.838646454109;4051.8176682049966;4151.709380343347;4163.646090082377;5868.501177399798;5871.324797648154;5896.70516474166;5919.91120133207;5951.7619295227705;5655.406182350794;5730.341010783646;5732.942670573408;5744.712764361681;5747.166660834239;5500.9174862377895;5626.774929002794;5663.32040155184;5663.490285874291;5665.376808550974;5377.569794416516;5551.916721249266;5576.5817563683695;5587.3015873015875;5597.916031259616;5553.472420120243;5724.112762521816;5771.68255745938;5778.104393818965;5787.623804452697;5532.2254884315425;5561.443855614568;5568.470995255444;5569.248151499658;5573.916391254215 08:41:04 INFO - PROCESS | 1546 | |5;yui.html;699.5313140196068;731.645152101231;744.13680131048;744.650014493188;755.4409736794767;11867.7626447471;12153.210041347305;12207.938960305197;12222.877771222285;12223.205491643037;11193.10455163587;13066.869331306683;13579.185248885075;13606.319684015785;13617.523386681469;789.8617741895174;794.7496538590354;798.3972101063689;798.9520628762264;799.7200979657132;635.3963734452266;779.298631231893;795.6340083561569;798.9360851131925;805.8025783682976;813.4590497319275;820.3601191070974;820.8809722590221;822.7367242482408;824.1881746479743;812.6261919517059;814.9975530097983;816.5753808019826;821.6836517940636;824.381713714714;603.1826874584962;603.3061978724502;604.4892066204051;604.8246008657484;604.8760004199173;13195.73608527824;13303.53437629688;13315.467381304834;13391.531296404677;13430.932845335808;11919.225250358699;12060.336681482515;12098.213616114925;12106.697332566668;12235.449404776806;8912.55437228136;8913.420627659247;9073.047330030384;9107.271418286522;9199.816003679956;3249.138978170763;3297.3240485700376;3320.9169770755925;3330.2673411849355;3343.4650455927176;43873.12253754907;47076.293855592536;47600;47809.76095119502;47875.52124478745;9593.760155996157;9874.555644995993;9953.651622193333;10012.299139060342;10088.546015429323;16034.358625654842;16530;16690;16695.74956375655;16728.749068763736;6738.528303018742;6800.353966373186;6801.4558835293055;6860.108185935796;6888.586684798928;3790.981045094757;3804.980975095162;3824.2351529694174;3833.3100041992707;3908.042529580271;2891.6530016398165;2958.5710072039865;2969.435807196626;2971.4205729882897;2974.509205981032;516.042740715974;516.3983958688086;520.1651349583939;525.4692760312113;529.5895680847374;428.07322147550826;519.6359556165066;532.1273112096166;539.4551502981938;551.6000899348021;6973.407260382823;7097.290270972861;7195.496315257882;7199.388052015533;7347;518.3494714133737;521.3457111325263;534.8823258883117;537.8063896997078;542.9864253393697;3350.9329813404083;3529.717622590238;3580.8925732228076;3642.6357364263363;3689.741718079709;49608;50303.74848125736;50477;50821.49178508241;51390.74304628453;44353.77823110928;44960.3255951161;45359.77320113379;45568;46047.76976115098;42694;42714;42981.57018429838;43460.56539434628;43627.56372436298;6888.311168883071;6891.345322194384;7005.754798582026;7009.1939426966555;7044.189918159477;28950;29049.273768155967;29249;29697.406051879272;29825;35188.47217291692;36305.63694363023;36777.26445471022;37077.443838341904;37226.627733722315;8933.597988090421;8945.37382383227;9008.144226298491;9037.09629037091;9172.357934944757;9532.332736708364;9560;9732.46471444049;9821.214302855611;10014.229280476022;8811.074837142009;8997.820043599222;9033.59348829291;9057.139571740674;9113.681021164228;8995.100489950952;9112.316576256675;9206.585703643486;9224.077592240723;9240.399374040666;8604.225619694258;8754.51850148248;8802.075782042793;8812.64749410042;8884.86672699923;8012.919870801451;8040.276375126266;8150.83698326042;8216.507009579444;8328.250457458858;7618.733344332922;7785.104712958082;7910.68357265726;7912.28789408933;7941.920580794118 08:41:04 INFO - PROCESS | 1546 | __end_tp_report 08:41:04 INFO - PROCESS | 1546 | __start_cc_report 08:41:04 INFO - PROCESS | 1546 | _x_x_mozilla_cycle_collect,362 08:41:04 INFO - PROCESS | 1546 | __end_cc_report 08:41:04 INFO - PROCESS | 1546 | __startTimestamp1461339664880__endTimestamp 08:41:04 INFO - PROCESS | 1546 | 08:41:04 INFO - PROCESS | 1546 | ------- Summary: start ------- 08:41:04 INFO - PROCESS | 1546 | Number of tests: 6 08:41:04 INFO - PROCESS | 1546 | 08:41:04 INFO - PROCESS | 1546 | [#0] dojo.html Cycles:165 Average:4773.54 Median:4873.83 stddev:493.58 (10.1%) stddev-sans-first:465.74 08:41:04 INFO - PROCESS | 1546 | Values: 2635.9 2699.4 2729.6 2730.1 2737.4 4713.4 4724.9 4759.2 4766.9 4787.5 4675.6 4787.3 4867.7 4903.6 4918.0 4473.2 4486.2 4541.7 4547.3 4582.2 4446.9 4452.0 4476.6 4483.8 4496.3 4371.6 4402.6 4409.5 4424.2 4457.2 4358.8 4382.6 4412.0 4421.3 4464.7 4432.6 4451.1 4451.4 4458.4 4487.0 4713.8 4763.7 4764.8 4799.4 4812.3 5109.2 5110.3 5150.8 5154.9 5176.8 5043.1 5167.1 5187.6 5190.5 5195.2 4821.1 4830.8 4846.6 4868.3 4892.4 5291.1 5328.2 5328.6 5349.5 5385.6 4934.5 5046.9 5116.1 5129.8 5135.6 5103.5 5116.7 5119.0 5121.7 5124.7 5033.4 5069.9 5070.2 5089.5 5123.2 5155.2 5163.4 5183.2 5186.6 5220.3 4268.9 4411.2 4425.5 4448.0 4489.2 3865.4 3887.2 3890.4 3908.3 3931.9 4443.8 4449.4 4457.6 4469.9 4503.2 5081.2 5255.4 5263.3 5303.1 5323.7 4420.1 4456.5 4459.3 4466.9 4486.2 4673.7 4688.0 4691.7 4694.7 4741.9 4722.6 4803.4 4813.3 4835.3 4867.5 5225.8 5250.1 5256.8 5267.3 5273.3 4836.6 4859.8 4873.8 4878.0 4929.2 5004.5 5099.7 5120.7 5154.8 5168.3 5149.2 5149.5 5166.2 5171.4 5189.9 5002.5 5067.0 5071.5 5087.4 5102.0 4914.7 4967.0 5010.6 5030.8 5053.7 4744.6 4924.0 4928.4 4932.5 4985.4 4963.8 5015.0 5043.2 5054.2 5054.6 4847.4 4847.9 4885.1 4904.7 4941.1 08:41:04 INFO - PROCESS | 1546 | 08:41:04 INFO - PROCESS | 1546 | [#1] ext.html Cycles:180 Average:44172.98 Median:3576.28 stddev:80520.70 (2251.5%) stddev-sans-first:80680.02 08:41:04 INFO - PROCESS | 1546 | Values: 568.2 595.9 597.1 623.1 645.5 34657.3 35598.1 35889.3 36101.1 36143.8 38885.4 39790.8 39930.2 40061.8 40099.6 7650.5 7865.1 7903.5 7906.3 7911.6 7688.5 7705.7 7780.3 7783.9 7804.0 7783.8 7783.9 7797.7 7808.6 7815.9 7681.2 7705.4 7761.1 7791.6 7798.0 7781.1 7862.4 7896.9 7899.8 7904.9 35357.8 35675.6 35819.8 35860.6 35895.8 2926.6 2994.5 3044.6 3059.4 3281.3 27259.0 28607.3 28634.6 28832.1 29014.9 3348.3 3442.2 3571.9 3580.7 3624.2 210681.0 212942.0 213721.0 214186.0 214720.0 32812.0 52578.7 52808.0 52843.5 53112.5 31810.2 32048.0 32113.4 32162.0 32226.0 12484.8 12763.9 12769.9 12771.2 12821.0 9638.2 9687.3 9697.9 9702.7 9730.1 7941.3 7950.8 8078.4 8127.9 8187.5 3200.9 3219.6 3221.3 3233.6 3302.3 935.6 938.4 939.6 992.6 1062.5 27937.4 28342.1 29379.7 29498.0 29756.4 929.7 934.4 955.2 957.4 971.0 13344.2 14178.7 14386.8 14404.8 14736.8 355050.0 361549.0 362827.0 363723.0 364306.0 48236.8 48695.8 48963.0 48990.8 49131.3 1217.8 1243.6 1267.7 1267.9 1364.0 26363.7 27384.3 27486.0 27786.4 27937.6 43243.8 43429.0 43959.8 44110.8 44136.7 316134.0 322330.0 322866.0 323076.0 323462.0 25361.5 25371.9 25761.2 25852.5 25943.6 40787.6 41748.6 41884.0 42153.6 42496.2 35164.0 35188.5 35295.0 35511.6 35850.5 34703.3 34909.7 35107.3 35213.8 35387.8 31275.5 34962.3 35958.3 36726.0 36782.0 28721.9 29526.4 30076.8 30105.5 30266.4 23761.3 24090.4 24489.3 24517.3 24679.4 08:41:04 INFO - PROCESS | 1546 | 08:41:04 INFO - PROCESS | 1546 | [#2] jquery.html Cycles:180 Average:24037.15 Median:26804.66 stddev:65659.38 (245.0%) stddev-sans-first:65819.55 08:41:04 INFO - PROCESS | 1546 | Values: 383.9 385.5 386.5 391.5 396.2 14843.1 16526.0 16743.1 16849.9 16880.7 12734.3 14466.9 15352.8 15364.8 15476.6 4633.5 4793.7 4840.5 4841.0 4846.8 3564.2 5853.9 6199.1 6204.4 6215.6 5216.6 6116.4 6135.4 6139.8 6147.2 5511.2 5520.1 5558.7 5558.9 5561.9 5179.5 5344.9 5393.1 5416.8 5423.3 12384.4 12502.1 12548.2 12612.9 12737.5 2000.4 2013.9 2024.3 2027.7 2411.6 9811.4 9913.2 10309.4 10797.9 13543.1 1699.9 1740.5 1769.7 1799.5 1804.7 66099.0 68130.0 68763.3 68876.7 69649.0 10028.6 10104.0 10179.5 10211.1 10318.2 13828.2 13837.4 13933.7 13957.9 14024.5 7114.4 7208.8 7233.0 7327.2 7367.7 6890.5 6922.5 6970.4 7058.4 7092.6 4087.9 4108.6 4142.0 4335.6 4371.7 1670.7 1701.5 1726.3 1737.1 1844.9 856.7 935.9 940.1 994.0 1013.1 15529.8 16047.6 16273.3 16500.7 17122.0 873.8 886.6 898.8 902.2 934.7 9075.4 9149.7 9254.6 9284.4 9482.6 394421.0 395779.0 397991.0 399759.0 402082.0 74251.0 76693.6 76839.2 78525.0 79226.0 909.7 917.3 917.9 919.5 919.6 14332.6 14411.2 14643.0 14671.5 14680.3 33094.5 33575.8 34022.8 34181.7 34880.0 48762.5 49149.3 49358.0 49412.8 49555.8 7667.7 7863.5 7926.4 7956.8 8012.7 8330.6 9470.8 10955.4 11080.5 11203.3 9728.7 9872.5 9972.9 9999.3 10170.3 9759.6 9801.2 9933.0 10027.1 10165.6 9990.4 10034.2 10155.7 10182.1 10227.7 7713.1 7757.2 7786.1 7850.7 7852.8 9400.6 9649.8 9766.6 9870.7 10008.4 08:41:04 INFO - PROCESS | 1546 | 08:41:04 INFO - PROCESS | 1546 | [#3] mootools.html Cycles:180 Average:5158.59 Median:4853.26 stddev:2894.92 (59.6%) stddev-sans-first:2889.02 08:41:04 INFO - PROCESS | 1546 | Values: 1366.3 1428.1 1501.6 1708.9 1769.4 7018.4 7693.4 7719.4 7950.1 7965.6 7756.6 7772.9 7794.3 7820.1 7825.4 2258.3 2299.7 2303.9 2311.7 2312.5 2236.9 2239.7 2276.5 2307.4 2314.5 2286.9 2296.1 2314.1 2315.6 2316.2 2233.3 2239.0 2244.7 2245.9 2260.5 2239.0 2250.1 2250.2 2255.3 2255.4 7943.8 7955.6 7958.6 8017.9 8045.4 4681.2 4852.1 4884.0 4886.9 4887.9 2864.6 2872.3 3041.4 3056.3 3074.7 941.2 949.7 958.7 964.7 983.8 10888.5 10911.7 10970.2 10990.1 11012.0 4225.5 4325.6 4444.8 4496.8 4532.8 9062.2 9078.7 9080.3 9082.3 9136.0 4803.2 4813.5 4826.5 4829.3 4854.4 3776.6 4288.7 4324.9 4326.7 4404.8 3675.5 3736.5 3752.5 3814.7 3818.5 1228.3 1252.3 1257.9 1268.3 1268.9 679.2 747.5 764.0 781.6 791.0 5119.8 5140.0 5155.7 5181.0 5216.4 424.4 427.0 432.5 435.5 438.3 3509.8 3625.2 3651.1 3663.9 3667.7 9596.1 10043.8 10045.6 10084.5 10097.4 9331.7 9888.9 9939.2 9968.5 10003.9 7196.8 7343.3 7348.9 7358.1 7362.9 4966.7 5094.1 5183.6 5199.2 5222.4 8503.9 8530.1 8567.9 8579.8 8596.7 8589.9 8735.2 9068.9 9089.3 9118.1 6090.1 6595.2 6761.4 6840.2 6854.8 7398.4 7438.9 7455.3 7490.5 7499.4 6510.6 6724.2 6738.3 6765.3 6842.2 6495.0 6502.7 6540.6 6627.3 6670.8 6120.3 6127.2 6179.0 6186.1 6195.0 4330.3 4439.2 4489.1 4506.0 4516.0 4267.2 4299.7 4339.3 4403.2 4465.3 08:41:04 INFO - PROCESS | 1546 | 08:41:04 INFO - PROCESS | 1546 | [#4] prototype.html Cycles:180 Average:4680.57 Median:5359.19 stddev:1362.28 (25.4%) stddev-sans-first:1326.11 08:41:04 INFO - PROCESS | 1546 | Values: 315.2 318.2 320.2 321.8 324.7 5356.8 5434.1 5434.8 5466.3 5466.5 5337.3 5354.2 5361.5 5366.8 5368.0 3940.1 4034.9 4201.1 4207.6 4210.0 4200.8 4203.3 4213.0 4213.8 4234.6 4175.2 4176.4 4180.3 4180.3 4193.5 4074.7 4137.2 4155.3 4163.3 4167.0 3640.7 3651.9 3658.5 3662.4 3677.3 5108.7 5115.2 5132.3 5145.0 5148.1 4739.6 4782.0 4812.1 4815.9 4818.3 5630.6 5648.6 5678.1 5678.3 5690.6 4002.0 4047.0 4047.3 4051.9 4057.6 5673.2 5958.8 5973.9 5985.4 6009.3 4090.4 4109.1 4112.1 4118.4 4124.7 4161.4 4169.9 4175.2 4201.9 4203.2 4660.8 4758.4 4766.2 4768.3 4786.4 5651.4 5660.9 5674.6 5676.1 5678.7 1455.6 1487.4 1489.5 1491.1 1495.3 896.7 971.8 987.7 1007.5 1013.8 4773.9 4781.2 4827.6 4831.4 4850.7 5804.7 5806.4 5825.2 5832.3 5835.3 4758.8 4837.1 4843.2 4851.2 4879.9 3119.5 3156.2 3163.6 3165.2 3178.8 5419.9 5421.1 5431.1 5431.8 5438.6 5757.3 5955.9 5961.4 5997.3 6006.9 5321.7 5380.8 5394.1 5410.5 5416.5 5586.0 5799.7 5825.9 5842.6 5852.5 5683.3 5690.7 5699.1 5714.5 5727.4 5380.7 5383.9 5400.0 5414.8 5416.1 3772.8 4033.8 4051.8 4151.7 4163.6 5868.5 5871.3 5896.7 5919.9 5951.8 5655.4 5730.3 5732.9 5744.7 5747.2 5500.9 5626.8 5663.3 5663.5 5665.4 5377.6 5551.9 5576.6 5587.3 5597.9 5553.5 5724.1 5771.7 5778.1 5787.6 5532.2 5561.4 5568.5 5569.2 5573.9 08:41:04 INFO - PROCESS | 1546 | 08:41:04 INFO - PROCESS | 1546 | [#5] yui.html Cycles:180 Average:12222.21 Median:541.22 stddev:14290.88 (2640.5%) stddev-sans-first:14304.78 08:41:04 INFO - PROCESS | 1546 | Values: 699.5 731.6 744.1 744.7 755.4 11867.8 12153.2 12207.9 12222.9 12223.2 11193.1 13066.9 13579.2 13606.3 13617.5 789.9 794.7 798.4 799.0 799.7 635.4 779.3 795.6 798.9 805.8 813.5 820.4 820.9 822.7 824.2 812.6 815.0 816.6 821.7 824.4 603.2 603.3 604.5 604.8 604.9 13195.7 13303.5 13315.5 13391.5 13430.9 11919.2 12060.3 12098.2 12106.7 12235.4 8912.6 8913.4 9073.0 9107.3 9199.8 3249.1 3297.3 3320.9 3330.3 3343.5 43873.1 47076.3 47600.0 47809.8 47875.5 9593.8 9874.6 9953.7 10012.3 10088.5 16034.4 16530.0 16690.0 16695.7 16728.7 6738.5 6800.4 6801.5 6860.1 6888.6 3791.0 3805.0 3824.2 3833.3 3908.0 2891.7 2958.6 2969.4 2971.4 2974.5 516.0 516.4 520.2 525.5 529.6 428.1 519.6 532.1 539.5 551.6 6973.4 7097.3 7195.5 7199.4 7347.0 518.3 521.3 534.9 537.8 543.0 3350.9 3529.7 3580.9 3642.6 3689.7 49608.0 50303.7 50477.0 50821.5 51390.7 44353.8 44960.3 45359.8 45568.0 46047.8 42694.0 42714.0 42981.6 43460.6 43627.6 6888.3 6891.3 7005.8 7009.2 7044.2 28950.0 29049.3 29249.0 29697.4 29825.0 35188.5 36305.6 36777.3 37077.4 37226.6 8933.6 8945.4 9008.1 9037.1 9172.4 9532.3 9560.0 9732.5 9821.2 10014.2 8811.1 8997.8 9033.6 9057.1 9113.7 8995.1 9112.3 9206.6 9224.1 9240.4 8604.2 8754.5 8802.1 8812.6 8884.9 8012.9 8040.3 8150.8 8216.5 8328.3 7618.7 7785.1 7910.7 7912.3 7941.9 08:41:04 INFO - PROCESS | 1546 | -------- Summary: end -------- 08:41:04 INFO - PROCESS | 1546 | 08:41:05 INFO - TEST-INFO | 1546: exit 0 08:41:05 INFO - TEST-OK | dromaeo_css | took 1115228ms 08:41:05 INFO - TEST-START | kraken 08:41:05 INFO - operating with platform_type : linux_ 08:41:05 INFO - Initialising browser for kraken test... 08:41:05 INFO - TEST-INFO | started process 1780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDy76dZ/profile http://localhost:60332/getInfo.html) 08:41:09 INFO - PROCESS | 1780 | 08:41:09 INFO - PROCESS | 1780 | (process:1845): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:41:10 INFO - PROCESS | 1780 | __metrics Screen width/height:1600/1200 08:41:10 INFO - PROCESS | 1780 | colorDepth:24 08:41:10 INFO - PROCESS | 1780 | Browser inner width/height: 1024/697 08:41:10 INFO - PROCESS | 1780 | __metrics 08:41:11 ERROR - PROCESS | 1780 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:41:12 INFO - TEST-INFO | 1780: exit 0 08:41:12 INFO - Browser initialized. 08:41:12 INFO - Running cycle 1/1 for kraken test... 08:41:12 INFO - TEST-INFO | started process 1896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDy76dZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:14 INFO - PROCESS | 1896 | 08:41:14 INFO - PROCESS | 1896 | (process:1956): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:41:24 INFO - PROCESS | 1896 | RSS: Main: 164843520 08:41:24 INFO - PROCESS | 1896 | 08:41:26 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:60332/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60332/tests/kraken/driver.html?testName=audio-beat-detection) 08:41:27 INFO - PROCESS | 1896 | RSS: Main: 169426944 08:41:27 INFO - PROCESS | 1896 | 08:41:30 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:60332/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60332/tests/kraken/driver.html?testName=audio-dft) 08:41:31 INFO - PROCESS | 1896 | RSS: Main: 173158400 08:41:31 INFO - PROCESS | 1896 | 08:41:34 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:60332/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60332/tests/kraken/driver.html?testName=audio-fft) 08:41:34 INFO - PROCESS | 1896 | RSS: Main: 163237888 08:41:34 INFO - PROCESS | 1896 | 08:41:36 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:60332/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60332/tests/kraken/driver.html?testName=audio-oscillator) 08:41:37 INFO - PROCESS | 1896 | RSS: Main: 163790848 08:41:37 INFO - PROCESS | 1896 | 08:41:39 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:60332/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60332/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:41:40 INFO - PROCESS | 1896 | RSS: Main: 165253120 08:41:40 INFO - PROCESS | 1896 | 08:41:43 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:60332/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60332/tests/kraken/driver.html?testName=imaging-darkroom) 08:41:44 INFO - PROCESS | 1896 | RSS: Main: 165052416 08:41:44 INFO - PROCESS | 1896 | 08:41:47 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:60332/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60332/tests/kraken/driver.html?testName=imaging-desaturate) 08:41:48 INFO - PROCESS | 1896 | RSS: Main: 165044224 08:41:48 INFO - PROCESS | 1896 | 08:41:51 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:60332/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60332/tests/kraken/driver.html?testName=json-parse-financial) 08:41:51 INFO - PROCESS | 1896 | RSS: Main: 165310464 08:41:51 INFO - PROCESS | 1896 | 08:41:53 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:60332/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60332/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:41:54 INFO - PROCESS | 1896 | RSS: Main: 165408768 08:41:54 INFO - PROCESS | 1896 | 08:41:56 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:60332/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60332/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:41:56 INFO - PROCESS | 1896 | RSS: Main: 165498880 08:41:56 INFO - PROCESS | 1896 | 08:41:58 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:60332/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60332/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:41:59 INFO - PROCESS | 1896 | RSS: Main: 166113280 08:41:59 INFO - PROCESS | 1896 | 08:42:02 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:60332/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:42:03 INFO - PROCESS | 1896 | RSS: Main: 166838272 08:42:03 INFO - PROCESS | 1896 | 08:42:05 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:60332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:42:06 INFO - PROCESS | 1896 | RSS: Main: 166825984 08:42:06 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:60332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60332/tests/kraken/driver.html?testName=ai-astar) 08:42:08 INFO - PROCESS | 1896 | RSS: Main: 167735296 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | __start_tp_report 08:42:08 INFO - PROCESS | 1896 | _x_x_mozilla_page_load 08:42:08 INFO - PROCESS | 1896 | _x_x_mozilla_page_load_details 08:42:08 INFO - PROCESS | 1896 | |i|pagename|runs| 08:42:08 INFO - PROCESS | 1896 | |0;ai-astar;114;107;113;112;114;125;116;114;114;112 08:42:08 INFO - PROCESS | 1896 | |1;audio-beat-detection;159;134;154;184;137;156;165;138;191;132 08:42:08 INFO - PROCESS | 1896 | |2;audio-dft;162;164;164;171;167;165;162;162;166;162 08:42:08 INFO - PROCESS | 1896 | |3;audio-fft;74;74;73;146;78;74;78;73;162;77 08:42:08 INFO - PROCESS | 1896 | |4;audio-oscillator;93;94;156;94;92;93;146;94;93;140 08:42:08 INFO - PROCESS | 1896 | |5;imaging-gaussian-blur;117;118;118;117;117;117;119;117;118;117 08:42:08 INFO - PROCESS | 1896 | |6;imaging-darkroom;147;148;147;148;147;147;148;148;148;147 08:42:08 INFO - PROCESS | 1896 | |7;imaging-desaturate;96;97;95;95;96;96;95;97;96;96 08:42:08 INFO - PROCESS | 1896 | |8;json-parse-financial;65;65;69;64;66;65;65;64;65;65 08:42:08 INFO - PROCESS | 1896 | |9;json-stringify-tinderbox;64;64;64;64;64;64;64;64;63;64 08:42:08 INFO - PROCESS | 1896 | |10;stanford-crypto-aes;81;79;83;80;82;84;80;81;107;81 08:42:08 INFO - PROCESS | 1896 | |11;stanford-crypto-ccm;144;144;134;140;133;132;138;145;142;135 08:42:08 INFO - PROCESS | 1896 | |12;stanford-crypto-pbkdf2;180;179;178;186;180;180;176;177;176;175 08:42:08 INFO - PROCESS | 1896 | |13;stanford-crypto-sha256-iterative;74;73;72;73;75;73;72;75;72;71 08:42:08 INFO - PROCESS | 1896 | __end_tp_report 08:42:08 INFO - PROCESS | 1896 | __start_cc_report 08:42:08 INFO - PROCESS | 1896 | _x_x_mozilla_cycle_collect,928 08:42:08 INFO - PROCESS | 1896 | __end_cc_report 08:42:08 INFO - PROCESS | 1896 | __startTimestamp1461339728720__endTimestamp 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | ------- Summary: start ------- 08:42:08 INFO - PROCESS | 1896 | Number of tests: 14 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:4.51 (4.0%) stddev-sans-first:4.78 08:42:08 INFO - PROCESS | 1896 | Values: 114.0 107.0 113.0 112.0 114.0 125.0 116.0 114.0 114.0 112.0 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:157.50 stddev:20.65 (13.1%) stddev-sans-first:21.85 08:42:08 INFO - PROCESS | 1896 | Values: 159.0 134.0 154.0 184.0 137.0 156.0 165.0 138.0 191.0 132.0 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:2.92 (1.8%) stddev-sans-first:2.95 08:42:08 INFO - PROCESS | 1896 | Values: 162.0 164.0 164.0 171.0 167.0 165.0 162.0 162.0 166.0 162.0 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | [#3] audio-fft Cycles:10 Average:90.90 Median:74.00 stddev:33.52 (45.3%) stddev-sans-first:35.00 08:42:08 INFO - PROCESS | 1896 | Values: 74.0 74.0 73.0 146.0 78.0 74.0 78.0 73.0 162.0 77.0 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:93.00 stddev:26.39 (28.4%) stddev-sans-first:27.31 08:42:08 INFO - PROCESS | 1896 | Values: 93.0 94.0 156.0 94.0 92.0 93.0 146.0 94.0 93.0 140.0 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 08:42:08 INFO - PROCESS | 1896 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 119.0 117.0 118.0 117.0 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:42:08 INFO - PROCESS | 1896 | Values: 147.0 148.0 147.0 148.0 147.0 147.0 148.0 148.0 148.0 147.0 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 08:42:08 INFO - PROCESS | 1896 | Values: 96.0 97.0 95.0 95.0 96.0 96.0 95.0 97.0 96.0 96.0 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:1.42 (2.2%) stddev-sans-first:1.50 08:42:08 INFO - PROCESS | 1896 | Values: 65.0 65.0 69.0 64.0 66.0 65.0 65.0 64.0 65.0 65.0 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 08:42:08 INFO - PROCESS | 1896 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 63.0 64.0 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:81.00 stddev:8.28 (10.2%) stddev-sans-first:8.72 08:42:08 INFO - PROCESS | 1896 | Values: 81.0 79.0 83.0 80.0 82.0 84.0 80.0 81.0 107.0 81.0 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:141.00 stddev:4.97 (3.5%) stddev-sans-first:4.88 08:42:08 INFO - PROCESS | 1896 | Values: 144.0 144.0 134.0 140.0 133.0 132.0 138.0 145.0 142.0 135.0 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:179.50 stddev:3.16 (1.8%) stddev-sans-first:3.32 08:42:08 INFO - PROCESS | 1896 | Values: 180.0 179.0 178.0 186.0 180.0 180.0 176.0 177.0 176.0 175.0 08:42:08 INFO - PROCESS | 1896 | 08:42:08 INFO - PROCESS | 1896 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:73.00 stddev:1.33 (1.8%) stddev-sans-first:1.36 08:42:08 INFO - PROCESS | 1896 | Values: 74.0 73.0 72.0 73.0 75.0 73.0 72.0 75.0 72.0 71.0 08:42:08 INFO - PROCESS | 1896 | -------- Summary: end -------- 08:42:08 INFO - PROCESS | 1896 | 08:42:09 INFO - TEST-INFO | 1896: exit 0 08:42:09 INFO - TEST-OK | kraken | took 64200ms 08:42:09 INFO - SUITE-END | took 1179s 08:42:09 INFO - Completed test suite (00:19:39) 08:42:09 INFO - javascript benchmark 08:42:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2635.9341016474586, 2699.406130651257, 2729.5632698768177, 2730.140005898142, 2737.425140720449, 4713.363695901053, 4724.90550188996, 4759.167145749489, 4766.904661906764, 4787.473377928433, 4675.602573781232, 4787.305840653104, 4867.732274724889, 4903.60771138309, 4918.04098200851, 4473.194824931511, 4486.214912390335, 4541.65937554683, 4547.340635607851, 4582.221022426195, 4446.866594002185, 4451.955480445203, 4476.597106260436, 4483.798229079699, 4496.2581174106235, 4371.606555410029, 4402.559744025604, 4409.5149533551285, 4424.159409712144, 4457.175422546807, 4358.825646974149, 4382.627476664487, 4411.955880441219, 4421.292593185075, 4464.6874718769695, 4432.623227025707, 4451.087527056946, 4451.443569553806, 4458.353538736865, 4487.0352874131895, 4713.835015774432, 4763.737994410306, 4764.809407623691, 4799.3760811094335, 4812.302216178669, 5109.20807274873, 5110.310108135392, 5150.819721309736, 5154.917467331865, 5176.818811341623, 5043.117454445457, 5167.09575824233, 5187.559057480119, 5190.455002224788, 5195.246689230041, 4821.132196204681, 4830.782614782343, 4846.5638092571835, 4868.31843541908, 4892.437369702458, 5291.100512912814, 5328.227407025959, 5328.626996110235, 5349.491798279158, 5385.5960802939935, 4934.481879402611, 5046.873828154252, 5116.130257856174, 5129.8204562840865, 5135.563477104488, 5103.515166059218, 5116.718580478109, 5118.97440512795, 5121.718305493234, 5124.743762811844, 5033.421156567042, 5069.949300507022, 5070.239464080344, 5089.491050894955, 5123.180291153398, 5155.226715992556, 5163.40620828602, 5183.170692689152, 5186.5850731941355, 5220.269162317279, 4268.87193384199, 4411.20598292304, 4425.468943726709, 4447.977760111244, 4489.214387482243, 3865.40086286626, 3887.2419878123496, 3890.4164375343357, 3908.257431088084, 3931.8623848165175, 4443.800028998703, 4449.377087207794, 4457.598816106566, 4469.865904022885, 4503.234450143418, 5081.161608334583, 5255.421903590602, 5263.289455923478, 5303.124984377535, 5323.680579165262, 4420.115976804652, 4456.509783923766, 4459.331100334911, 4466.932996005063, 4486.237339652202, 4673.719576825401, 4687.9765601171775, 4691.671582989158, 4694.718316900929, 4741.905161896742, 4722.5513576210205, 4803.3995750531185, 4813.302071199586, 4835.323054772335, 4867.464578896389, 5225.817096401608, 5250.133727934848, 5256.816011439581, 5267.288915996444, 5273.261743355856, 4836.588889944394, 4859.805607775649, 4873.829415970424, 4878.048780487771, 4929.211326187793, 5004.47453017428, 5099.668521546236, 5120.743962801919, 5154.845354639367, 5168.328117344721, 5149.201873709581, 5149.459306772735, 5166.199239117943, 5171.405288391733, 5189.896202076013, 5002.499750024968, 5066.986602679405, 5071.518205770446, 5087.440381557952, 5101.974490127525, 4914.70511769295, 4966.950330496648, 5010.649254552292, 5030.84907452777, 5053.69677819332, 4744.620430365493, 4923.975380123076, 4928.383952005999, 4932.506749325039, 4985.351904252424, 4963.751812409293, 5015.0, 5043.167877300204, 5054.16606259963, 5054.570361519312, 4847.418309802846, 4847.854564363075, 4885.071836351224, 4904.681195722266, 4941.061198372297], "value": 4742.471125175776, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.1960026562415, 595.8927393069246, 597.1222303214275, 623.0529595015576, 645.464264660332, 34657.30685386291, 35598.11004724877, 35889.282214355764, 36101.09747256317, 36143.819280903626, 38885.41671874917, 39790.801045994805, 39930.201395972064, 40061.79969100158, 40099.59900400995, 7650.540967541951, 7865.095514015876, 7903.525788452683, 7906.2884340409355, 7911.56486393251, 7688.500247483924, 7705.73029943952, 7780.338671212954, 7783.922160778405, 7803.960980195091, 7783.766487005399, 7783.883241751379, 7797.727079552188, 7808.648610812499, 7815.882761758578, 7681.193474685161, 7705.383569314441, 7761.107472640662, 7791.649375778104, 7797.961010194913, 7781.144074151839, 7862.410319226081, 7896.921030789734, 7899.8025049373655, 7904.881426778603, 35357.82321088404, 35675.643243567494, 35819.82090089533, 35860.64139358599, 35895.82052089749, 2926.6488021437563, 2994.5208766597457, 3044.588980487628, 3059.434004709136, 3281.3109247058146, 27259.0, 28607.28481787972, 28634.570481442795, 28832.135035948955, 29014.85492572545, 3348.263382055968, 3442.225499262671, 3571.8928432146818, 3580.6598373154507, 3624.2026754114054, 210681.0, 212942.0, 213721.0, 214186.0, 214720.0, 32812.0, 52578.73710631422, 52808.0, 52843.47156528462, 53112.468875311526, 31810.204744881565, 32048.0, 32113.357732845212, 32162.0, 32226.0, 12484.75030499385, 12763.936180319039, 12769.872301277053, 12771.169873958348, 12821.0, 9638.228941684649, 9687.273454490942, 9697.9030209697, 9702.660406885725, 9730.075642813921, 7941.324987376138, 7950.840983180419, 8078.434509584273, 8127.878081828777, 8187.508749474931, 3200.855961481739, 3219.597550306212, 3221.275213077039, 3233.5958005249345, 3302.339532093591, 935.6351023100996, 938.432248489654, 939.618068197117, 992.593036854886, 1062.516554967488, 27937.441251174863, 28342.149735507966, 29379.706202937698, 29498.0, 29756.40487190244, 929.702495201529, 934.3693007220099, 955.1880901233895, 957.3920560444029, 970.9514524273758, 13344.199348039148, 14178.716425671635, 14386.784198237036, 14404.783928241084, 14736.778948315783, 355050.0, 361549.0, 362827.0, 363723.0, 364306.0, 48236.7588162064, 48695.75652121717, 48963.0, 48990.755046225255, 49131.263031054565, 1217.7990631545695, 1243.570968016033, 1267.7211013576998, 1267.9366031698378, 1364.0451683821366, 26363.736362636897, 27384.31539211456, 27486.0, 27786.44427111487, 27937.58093628638, 43243.78378108215, 43429.0, 43959.78020109879, 44110.77944610256, 44136.67589972306, 316134.0, 322330.0, 322866.0, 323076.0, 323462.0, 25361.49277014486, 25371.87314063418, 25761.227163185133, 25852.482950340513, 25943.61084583695, 40787.592124079565, 41748.58251417447, 41884.0, 42153.57846421497, 42496.15007699891, 35164.0, 35188.47217291794, 35295.0, 35511.644883550834, 35850.46224306586, 34703.30593388169, 34909.65090349064, 35107.29785404226, 35213.82393088018, 35387.82306088556, 31275.53086703747, 34962.300753985284, 35958.28083438369, 36726.0, 36782.0, 28721.85639071875, 29526.40947181087, 30076.84961575178, 30105.548416773327, 30266.394672106875, 23761.287161385186, 24090.39774005664, 24489.265322040366, 24517.264482065566, 24679.38301542404], "value": 16170.967771435598, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.854135428537, 385.5335044596039, 386.48404380152493, 391.49301654357606, 396.2293339454762, 14843.109413435188, 16526.0, 16743.07913064781, 16849.91575042123, 16880.746788798162, 12734.299613521276, 14466.927665361685, 15352.846471535282, 15364.769528457055, 15476.613084672861, 4633.467151277604, 4793.712377257359, 4840.467548569654, 4840.983393487354, 4846.806127754886, 3564.1624218308675, 5853.853653658672, 6199.101130336098, 6204.410580994799, 6215.627062376272, 5216.556592689626, 6116.357782432848, 6135.447809697126, 6139.7851075212375, 6147.170132032164, 5511.200875872996, 5520.089185284423, 5558.749856256478, 5558.8610284743, 5561.944380556203, 5179.482051794828, 5344.866378340534, 5393.083175860113, 5416.756245968941, 5423.322084739408, 12384.380780960915, 12502.124851260416, 12548.24710517372, 12612.936935315265, 12737.490500379974, 2000.3698834867116, 2013.8791672499697, 2024.251027119975, 2027.7465316835396, 2411.626197939322, 9811.43017117265, 9913.206943444507, 10309.381437113721, 10797.892021079768, 13543.051986360959, 1699.8810083294175, 1740.477856643002, 1769.716845304758, 1799.5321216483678, 1804.6932021556368, 66099.0, 68130.0, 68763.3123668762, 68876.6556167221, 69649.0, 10028.648997285205, 10104.0, 10179.452198551808, 10211.132053775513, 10318.1745460363, 13828.23944683032, 13837.446502139801, 13933.721325573635, 13957.930210348883, 14024.509142179975, 7114.359707626339, 7208.819779505554, 7232.963835180791, 7327.157376901618, 7367.668454919542, 6890.517663763589, 6922.480813938974, 6970.407515361251, 7058.364747172779, 7092.645367731593, 4087.8773636790943, 4108.589141085868, 4142.047329114321, 4335.631471324973, 4371.650267978554, 1670.7159782836948, 1701.4640388277653, 1726.2577091850624, 1737.148797089417, 1844.9354272600394, 856.6958729651009, 935.9204467620328, 940.1209868772582, 994.0109590957044, 1013.0679774607379, 15529.767053494206, 16047.598810029842, 16273.349066037463, 16500.669986600442, 17122.0, 873.8296032273772, 886.6409104312763, 898.8022635020285, 902.2195800632405, 934.6775362499926, 9075.410098343587, 9149.725508234764, 9254.583543740548, 9284.396514226553, 9482.620695172116, 394421.0, 395779.0, 397991.0, 399759.0, 402082.0, 74251.0, 76693.6165319181, 76839.2316076832, 78525.0, 79226.0, 909.7452713240303, 917.2799352508249, 917.8623206519076, 919.4621146629297, 919.5953780336764, 14332.641683957985, 14411.207383594003, 14643.0, 14671.486497972519, 14680.3393847275, 33094.5035824458, 33575.83212083924, 34022.82988585041, 34181.65818341785, 34880.0, 48762.5123748758, 49149.262761059326, 49358.0, 49412.75293623509, 49555.75222123866, 7667.731629392944, 7863.488873223222, 7926.405519586169, 7956.84086318282, 8012.679492820455, 8330.625121869409, 9470.816147981503, 10955.397453140155, 11080.501377438195, 11203.327800332007, 9728.659496917573, 9872.506374681381, 9972.900270997487, 9999.250056245664, 10170.338927969658, 9759.609615615296, 9801.215902727907, 9932.950335248277, 10027.097561219525, 10165.644202452879, 9990.400575965465, 10034.247431442525, 10155.7461063474, 10182.134518566005, 10227.693169204937, 7713.112992005991, 7757.224277572198, 7786.143524212219, 7850.685972561262, 7852.764417067498, 9400.623975040922, 9649.758756031155, 9766.56050477716, 9870.654527091518, 10008.44953527563], "value": 8063.849520802031, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.2622184020627, 1428.086024944036, 1501.5645462815785, 1708.9230984605692, 1769.4249368955084, 7018.403435707971, 7693.3845292376545, 7719.382449404048, 7950.125486196521, 7965.641546130423, 7756.573388463632, 7772.922270777304, 7794.259545343198, 7820.06159260888, 7825.373970082394, 2258.322503249027, 2299.666548350488, 2303.873286969216, 2311.711036120485, 2312.537492501498, 2236.944076398087, 2239.6528538076623, 2276.4764104256033, 2307.40007598024, 2314.537092581482, 2286.9199578014773, 2296.0586159674535, 2314.085936055257, 2315.617923042696, 2316.2124877541632, 2233.2853486884205, 2238.9664155037685, 2244.6633005049293, 2245.8764767937837, 2260.547890421922, 2238.9664155037526, 2250.0662225176534, 2250.223672832886, 2255.267038212571, 2255.379770563092, 7943.841123177504, 7955.562444065574, 7958.60206989654, 8017.919820801776, 8045.436819422643, 4681.204195286809, 4852.126617208901, 4883.975580122112, 4886.853394398174, 4887.8513549315885, 2864.570314452828, 2872.339361946743, 3041.422129795332, 3056.327607926275, 3074.6617872034058, 941.204682043672, 949.6818565780471, 958.6740508227166, 964.6671898195111, 983.8278301297245, 10888.510017049251, 10911.672649820519, 10970.232083754061, 10990.120790336754, 11012.0, 4225.471816022997, 4325.567443255649, 4444.8444304449185, 4496.775161241991, 4532.79602417892, 9062.229710474683, 9078.682246121354, 9080.31897607682, 9082.273418126533, 9136.040715724886, 4803.159447096814, 4813.542713442217, 4826.493218212037, 4829.275608658659, 4854.393200849894, 3776.6034566370686, 4288.742675439421, 4324.891877703019, 4326.697131200785, 4404.779761011937, 3675.5221821163614, 3736.4955730976512, 3752.45589389537, 3814.6757525610633, 3818.5035945327486, 1228.336698182989, 1252.267423557211, 1257.9182353147198, 1268.289757735671, 1268.9111762176558, 679.2053297641771, 747.5253214209016, 763.9809004774925, 781.5545139270561, 790.9644066017044, 5119.795208191631, 5140.049090918192, 5155.74221288934, 5180.974095129575, 5216.40011398694, 424.3613361890335, 426.97738915297685, 432.5479873532166, 435.4926510615098, 438.3424862705941, 3509.771864828778, 3625.220577575834, 3651.1054791576234, 3663.9084022899106, 3667.651573100551, 9596.136347728738, 10043.799124017478, 10045.598176073021, 10084.49577521121, 10097.394156350643, 9331.72004839856, 9888.901110988942, 9939.204863611038, 9968.451735154636, 10003.949980250052, 7196.820079498055, 7343.265673432614, 7348.926510734825, 7358.080239970004, 7362.926370736332, 4966.726830024239, 5094.133997220407, 5183.637145399785, 5199.220116982332, 5222.42553319127, 8503.914960850312, 8530.10433904431, 8567.914320856711, 8579.785505362415, 8596.65613375483, 8589.914100858912, 8735.213830755263, 9068.90931090707, 9089.31830112731, 9118.088191181094, 6090.116933044772, 6595.175603049619, 6761.425278851353, 6840.179178498612, 6854.828629284308, 7398.445116616168, 7438.925610743823, 7455.329020388191, 7490.5131166474, 7499.362554182955, 6510.6093634380195, 6724.226713927961, 6738.292479289604, 6765.289644587444, 6842.213145488333, 6495.0, 6502.707378167899, 6540.574862633914, 6627.3372662733345, 6670.799876003728, 6120.296165940974, 6127.234095738033, 6178.969105154445, 6186.133941248138, 6194.969025154845, 4330.328799036154, 4439.240695530917, 4489.124620699063, 4506.0, 4516.0, 4267.16790225903, 4299.69902106862, 4339.284018136972, 4403.163398954189, 4465.263231566885], "value": 4102.9664565031135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.161669957912, 318.19179284617076, 320.1739512058888, 321.7844044490191, 324.7337183509522, 5356.839294821157, 5434.1305391137375, 5434.83695489135, 5466.316710411199, 5466.508014278714, 5337.306150200468, 5354.170103633934, 5361.544268737152, 5366.812161574346, 5368.0, 3940.113474468243, 4034.9193016139807, 4201.096764195698, 4207.558206388331, 4210.010647497836, 4200.781773285744, 4203.327467605184, 4213.0087637777215, 4213.7893105344765, 4234.597713217255, 4175.185838761443, 4176.415301857743, 4180.289350810354, 4180.331147016478, 4193.4693836749675, 4074.694397920153, 4137.172565486914, 4155.31437312843, 4163.333866581347, 4167.0, 3640.672339489459, 3651.8904432867057, 3658.5426821647293, 3662.3773958426864, 3677.2829298286847, 5108.667936584147, 5115.181570948667, 5132.307138536325, 5145.048166089286, 5148.073346797575, 4739.573438390527, 4782.043591281723, 4812.061647978646, 4815.9036819263765, 4818.301346304801, 5630.634008789457, 5648.632838865502, 5678.148277758328, 5678.290213723285, 5690.60165788395, 4001.97999010006, 4047.028713108862, 4047.291723948297, 4051.8581849635416, 4057.5739547347694, 5673.23411339468, 5958.791442299499, 5973.8805223895715, 5985.401459854023, 6009.308929473123, 4090.406891000788, 4109.116539943867, 4112.136451345191, 4118.4440100586635, 4124.711270211116, 4161.4382058421725, 4169.874903752892, 4175.248455278079, 4201.894952626209, 4203.180379825904, 4660.766961651904, 4758.381410416624, 4766.165920963817, 4768.332433459318, 4786.401699787527, 5651.378348381757, 5660.915086273627, 5674.602777805597, 5676.0918253080135, 5678.68767217807, 1455.5706066710345, 1487.360435012955, 1489.508462207469, 1491.075533169442, 1495.3271028037427, 896.6996056321206, 971.7862070344513, 987.7135630667026, 1007.4861820471613, 1013.8428543575758, 4773.880652983703, 4781.187198176319, 4827.565519103297, 4831.396075490564, 4850.733209673432, 5804.709764511757, 5806.390329015477, 5825.213596164548, 5832.270966129234, 5835.328937172195, 4758.833440829554, 4837.105135549864, 4843.225083986616, 4851.248056551241, 4879.853604391874, 3119.5008798592116, 3156.2425017995515, 3163.557102005721, 3165.1770539659856, 3178.825164615922, 5419.891602167934, 5421.1055175895535, 5431.103867861838, 5431.809886654027, 5438.619296649196, 5757.337906140848, 5955.851103722355, 5961.433663801932, 5997.280326360865, 6006.879862402728, 5321.733913304397, 5380.78476860929, 5394.056040192951, 5410.540104091197, 5416.51251387377, 5585.9720701397855, 5799.652020878761, 5825.883482330414, 5842.561807864512, 5852.473277405054, 5683.277453268116, 5690.743916523684, 5699.116636921284, 5714.485696287354, 5727.427257274239, 5380.677159370451, 5383.865403364947, 5400.0, 5414.75633596497, 5416.079266524622, 3772.830222639933, 4033.838646454109, 4051.8176682049966, 4151.709380343347, 4163.646090082377, 5868.501177399798, 5871.324797648154, 5896.70516474166, 5919.91120133207, 5951.7619295227705, 5655.406182350794, 5730.341010783646, 5732.942670573408, 5744.712764361681, 5747.166660834239, 5500.9174862377895, 5626.774929002794, 5663.32040155184, 5663.490285874291, 5665.376808550974, 5377.569794416516, 5551.916721249266, 5576.5817563683695, 5587.3015873015875, 5597.916031259616, 5553.472420120243, 5724.112762521816, 5771.68255745938, 5778.104393818965, 5787.623804452697, 5532.2254884315425, 5561.443855614568, 5568.470995255444, 5569.248151499658, 5573.916391254215], "value": 4247.08505043065, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.5313140196068, 731.645152101231, 744.13680131048, 744.650014493188, 755.4409736794767, 11867.7626447471, 12153.210041347305, 12207.938960305197, 12222.877771222285, 12223.205491643037, 11193.10455163587, 13066.869331306683, 13579.185248885075, 13606.319684015785, 13617.523386681469, 789.8617741895174, 794.7496538590354, 798.3972101063689, 798.9520628762264, 799.7200979657132, 635.3963734452266, 779.298631231893, 795.6340083561569, 798.9360851131925, 805.8025783682976, 813.4590497319275, 820.3601191070974, 820.8809722590221, 822.7367242482408, 824.1881746479743, 812.6261919517059, 814.9975530097983, 816.5753808019826, 821.6836517940636, 824.381713714714, 603.1826874584962, 603.3061978724502, 604.4892066204051, 604.8246008657484, 604.8760004199173, 13195.73608527824, 13303.53437629688, 13315.467381304834, 13391.531296404677, 13430.932845335808, 11919.225250358699, 12060.336681482515, 12098.213616114925, 12106.697332566668, 12235.449404776806, 8912.55437228136, 8913.420627659247, 9073.047330030384, 9107.271418286522, 9199.816003679956, 3249.138978170763, 3297.3240485700376, 3320.9169770755925, 3330.2673411849355, 3343.4650455927176, 43873.12253754907, 47076.293855592536, 47600.0, 47809.76095119502, 47875.52124478745, 9593.760155996157, 9874.555644995993, 9953.651622193333, 10012.299139060342, 10088.546015429323, 16034.358625654842, 16530.0, 16690.0, 16695.74956375655, 16728.749068763736, 6738.528303018742, 6800.353966373186, 6801.4558835293055, 6860.108185935796, 6888.586684798928, 3790.981045094757, 3804.980975095162, 3824.2351529694174, 3833.3100041992707, 3908.042529580271, 2891.6530016398165, 2958.5710072039865, 2969.435807196626, 2971.4205729882897, 2974.509205981032, 516.042740715974, 516.3983958688086, 520.1651349583939, 525.4692760312113, 529.5895680847374, 428.07322147550826, 519.6359556165066, 532.1273112096166, 539.4551502981938, 551.6000899348021, 6973.407260382823, 7097.290270972861, 7195.496315257882, 7199.388052015533, 7347.0, 518.3494714133737, 521.3457111325263, 534.8823258883117, 537.8063896997078, 542.9864253393697, 3350.9329813404083, 3529.717622590238, 3580.8925732228076, 3642.6357364263363, 3689.741718079709, 49608.0, 50303.74848125736, 50477.0, 50821.49178508241, 51390.74304628453, 44353.77823110928, 44960.3255951161, 45359.77320113379, 45568.0, 46047.76976115098, 42694.0, 42714.0, 42981.57018429838, 43460.56539434628, 43627.56372436298, 6888.311168883071, 6891.345322194384, 7005.754798582026, 7009.1939426966555, 7044.189918159477, 28950.0, 29049.273768155967, 29249.0, 29697.406051879272, 29825.0, 35188.47217291692, 36305.63694363023, 36777.26445471022, 37077.443838341904, 37226.627733722315, 8933.597988090421, 8945.37382383227, 9008.144226298491, 9037.09629037091, 9172.357934944757, 9532.332736708364, 9560.0, 9732.46471444049, 9821.214302855611, 10014.229280476022, 8811.074837142009, 8997.820043599222, 9033.59348829291, 9057.139571740674, 9113.681021164228, 8995.100489950952, 9112.316576256675, 9206.585703643486, 9224.077592240723, 9240.399374040666, 8604.225619694258, 8754.51850148248, 8802.075782042793, 8812.64749410042, 8884.86672699923, 8012.919870801451, 8040.276375126266, 8150.83698326042, 8216.507009579444, 8328.250457458858, 7618.733344332922, 7785.104712958082, 7910.68357265726, 7912.28789408933, 7941.920580794118], "value": 5605.569088673502, "unit": "score"}], "name": "dromaeo_css", "value": 6264.055608197119, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 113.0, 112.0, 114.0, 125.0, 116.0, 114.0, 114.0, 112.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 134.0, 154.0, 184.0, 137.0, 156.0, 165.0, 138.0, 191.0, 132.0], "value": 155.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 171.0, 167.0, 165.0, 162.0, 162.0, 166.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 146.0, 78.0, 74.0, 78.0, 73.0, 162.0, 77.0], "value": 90.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 156.0, 94.0, 92.0, 93.0, 146.0, 94.0, 93.0, 140.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 119.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 69.0, 64.0, 66.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 83.0, 80.0, 82.0, 84.0, 80.0, 81.0, 107.0, 81.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 144.0, 134.0, 140.0, 133.0, 132.0, 138.0, 145.0, 142.0, 135.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 179.0, 178.0, 186.0, 180.0, 180.0, 176.0, 177.0, 176.0, 175.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 73.0, 75.0, 73.0, 72.0, 75.0, 72.0, 71.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1598.3000000000002, "alertThreshold": 2.0}]} 08:42:09 INFO - Return code: 0 08:42:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:42:10 ERROR - # TBPL SUCCESS # 08:42:10 INFO - Running post-action listener: _resource_record_post_action 08:42:10 INFO - Running post-run listener: _resource_record_post_run 08:42:11 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 519843840; Read time: 0; Write time: 588744 08:42:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240635904; Read time: 0; Write time: 300332 08:42:11 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 279207936; Read time: 0; Write time: 288412 08:42:11 INFO - Running post-run listener: _upload_blobber_files 08:42:11 INFO - Blob upload gear active. 08:42:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:42:11 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 08:42:11 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:42:11 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:42:11 INFO - (blobuploader) - INFO - Open directory for files ... 08:42:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:42:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:42:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:12 INFO - (blobuploader) - INFO - Done attempting. 08:42:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:42:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:42:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:13 INFO - (blobuploader) - INFO - Done attempting. 08:42:13 INFO - (blobuploader) - INFO - Iteration through files over. 08:42:13 INFO - Return code: 0 08:42:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:42:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:42:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b44a03cba9f25a7e9bf49719ff5f0b72248dca790eebfce19bab9f0f1a0e79b2f28d914ff690ea6184d91962192c22277b1ab44b8e2d56b67510e78b24d1591c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e4b980c9a0710f198e9297ae1c5556664a5cc62cd98bfc99d24b0762727c5f9a57dafeb595069695541f25647df22aacc9ded0d1a04bba26e87f0c25461ed0e"} 08:42:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:42:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:42:13 INFO - Contents: 08:42:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b44a03cba9f25a7e9bf49719ff5f0b72248dca790eebfce19bab9f0f1a0e79b2f28d914ff690ea6184d91962192c22277b1ab44b8e2d56b67510e78b24d1591c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e4b980c9a0710f198e9297ae1c5556664a5cc62cd98bfc99d24b0762727c5f9a57dafeb595069695541f25647df22aacc9ded0d1a04bba26e87f0c25461ed0e"} 08:42:13 INFO - Running post-run listener: copy_logs_to_upload_dir 08:42:13 INFO - Copying logs to upload dir... 08:42:13 INFO - mkdir: /builds/slave/test/build/upload/logs 08:42:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.802764 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-22 08:42:12.776701) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 08:42:12.780245) ========= 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=62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b44a03cba9f25a7e9bf49719ff5f0b72248dca790eebfce19bab9f0f1a0e79b2f28d914ff690ea6184d91962192c22277b1ab44b8e2d56b67510e78b24d1591c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e4b980c9a0710f198e9297ae1c5556664a5cc62cd98bfc99d24b0762727c5f9a57dafeb595069695541f25647df22aacc9ded0d1a04bba26e87f0c25461ed0e"} build_url:https://queue.taskcluster.net/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/YZFjO4VVTIuAVutokaHFWA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b44a03cba9f25a7e9bf49719ff5f0b72248dca790eebfce19bab9f0f1a0e79b2f28d914ff690ea6184d91962192c22277b1ab44b8e2d56b67510e78b24d1591c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e4b980c9a0710f198e9297ae1c5556664a5cc62cd98bfc99d24b0762727c5f9a57dafeb595069695541f25647df22aacc9ded0d1a04bba26e87f0c25461ed0e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 08:42:12.804807) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:42:12.805128) ========= 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=62c568580acbfdaac3eec7be000001dc-1461338490.455278-363593730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004654 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:42:12.889208) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 08:42:12.889516) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 08:42:12.889817) ========= ========= Total master_lag: 0.20 =========