builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1460764337.47 results: success (0) buildid: 20160415153714 builduid: 8dd1ab3258b44474a708a3e013254633 revision: f5a97eb5c89a2b5133ff8bba915acba6344fa7cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 16:52:17.467214) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 16:52:17.467691) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 16:52:17.467998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 16:52:17.484750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 16:52:17.485059) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 16:52:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.0M=0s 2016-04-15 16:52:17 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110603 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 16:52:17.609166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 16:52:17.609490) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019875 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 16:52:17.659062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 16:52:17.659397) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f5a97eb5c89a2b5133ff8bba915acba6344fa7cc --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 f5a97eb5c89a2b5133ff8bba915acba6344fa7cc --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=8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 16:52:17,815 truncating revision to first 12 chars 2016-04-15 16:52:17,815 Setting DEBUG logging. 2016-04-15 16:52:17,815 attempt 1/10 2016-04-15 16:52:17,815 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f5a97eb5c89a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 16:52:18,089 unpacking tar archive at: mozilla-central-f5a97eb5c89a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571920 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 16:52:18.244702) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 16:52:18.245043) ========= script_repo_revision: f5a97eb5c89a2b5133ff8bba915acba6344fa7cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 16:52:18.245459) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 16:52:18.245746) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 16:52:18.264355) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-15 16:52:18.264750) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:52:18 INFO - MultiFileLogger online at 20160415 16:52:18 in /builds/slave/test 16:52:18 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 16:52:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:52:18 INFO - {'append_to_log': False, 16:52:18 INFO - 'base_work_dir': '/builds/slave/test', 16:52:18 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:52:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:52:18 INFO - 'branch': 'Firefox-Non-PGO', 16:52:18 INFO - 'buildbot_json_path': 'buildprops.json', 16:52:18 INFO - 'config_files': ('talos/linux_config.py',), 16:52:18 INFO - 'default_actions': ('clobber', 16:52:18 INFO - 'read-buildbot-config', 16:52:18 INFO - 'download-and-extract', 16:52:18 INFO - 'populate-webroot', 16:52:18 INFO - 'create-virtualenv', 16:52:18 INFO - 'install', 16:52:18 INFO - 'run-tests'), 16:52:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:52:18 INFO - 'download_minidump_stackwalk': True, 16:52:18 INFO - 'download_symbols': 'ondemand', 16:52:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:52:18 INFO - 'tooltool.py': '/tools/tooltool.py', 16:52:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:52:18 INFO - '/tools/misc-python/virtualenv.py')}, 16:52:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:52:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:52:18 INFO - 'installer_path': 'installer.exe', 16:52:18 INFO - 'log_level': 'info', 16:52:18 INFO - 'log_name': 'talos', 16:52:18 INFO - 'log_to_console': True, 16:52:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:52:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:52:18 INFO - 'opt_config_files': (), 16:52:18 INFO - 'pip_index': False, 16:52:18 INFO - 'sps_profile': False, 16:52:18 INFO - 'sps_profile_interval': 0, 16:52:18 INFO - 'suite': 'dromaeojs-e10s', 16:52:18 INFO - 'system_bits': '32', 16:52:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:52:18 INFO - 'title': 'talos-linux64-ix-041', 16:52:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:52:18 INFO - 'use_talos_json': True, 16:52:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:52:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:52:18 INFO - 'work_dir': 'build'} 16:52:18 INFO - ##### 16:52:18 INFO - ##### Running clobber step. 16:52:18 INFO - ##### 16:52:18 INFO - Running pre-action listener: _resource_record_pre_action 16:52:18 INFO - Running main action method: clobber 16:52:18 INFO - rmtree: /builds/slave/test/build 16:52:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:52:18 INFO - Running post-action listener: _resource_record_post_action 16:52:18 INFO - ##### 16:52:18 INFO - ##### Running read-buildbot-config step. 16:52:18 INFO - ##### 16:52:18 INFO - Running pre-action listener: _resource_record_pre_action 16:52:18 INFO - Running main action method: read_buildbot_config 16:52:18 INFO - Using buildbot properties: 16:52:18 INFO - { 16:52:18 INFO - "project": "", 16:52:18 INFO - "product": "firefox", 16:52:18 INFO - "script_repo_revision": "production", 16:52:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:52:18 INFO - "repository": "", 16:52:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:52:18 INFO - "buildid": "20160415153714", 16:52:18 INFO - "pgo_build": "False", 16:52:18 INFO - "basedir": "/builds/slave/test", 16:52:18 INFO - "buildnumber": 29, 16:52:18 INFO - "slavename": "talos-linux64-ix-041", 16:52:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:52:18 INFO - "platform": "ubuntu64_hw", 16:52:18 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:52:18 INFO - "branch": "mozilla-central", 16:52:18 INFO - "repo_path": "mozilla-central", 16:52:18 INFO - "revision": "f5a97eb5c89a2b5133ff8bba915acba6344fa7cc", 16:52:18 INFO - "stage_platform": "linux64", 16:52:18 INFO - "builduid": "8dd1ab3258b44474a708a3e013254633", 16:52:18 INFO - "slavebuilddir": "test" 16:52:18 INFO - } 16:52:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:52:18 INFO - Running post-action listener: _resource_record_post_action 16:52:18 INFO - ##### 16:52:18 INFO - ##### Running download-and-extract step. 16:52:18 INFO - ##### 16:52:18 INFO - Running pre-action listener: _resource_record_pre_action 16:52:18 INFO - Running main action method: download_and_extract 16:52:18 INFO - mkdir: /builds/slave/test/build/tests 16:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:18 INFO - https://queue.taskcluster.net/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:52:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:52:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:52:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/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 16:52:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/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 16:52:32 INFO - Downloaded 1361 bytes. 16:52:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:52:32 INFO - Using the following test package requirements: 16:52:32 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:52:32 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:52:32 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:52:32 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:32 INFO - u'jsshell-linux-x86_64.zip'], 16:52:32 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:52:32 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:52:32 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:52:32 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:52:32 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:52:32 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:52:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:32 INFO - https://queue.taskcluster.net/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:52:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:52:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:52:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/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 16:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/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 16:52:40 INFO - Downloaded 22203458 bytes. 16:52: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'] 16:52: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 16:52:42 INFO - Return code: 0 16:52:42 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 16:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:42 INFO - https://queue.taskcluster.net/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:52:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:52:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:52:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/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 16:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/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 16:52:43 INFO - Downloaded 22203458 bytes. 16:52:43 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'] 16:52:43 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 16:52:44 INFO - Return code: 0 16:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:44 INFO - https://queue.taskcluster.net/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:52:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:52:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:52:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/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 16:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/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 16:52:45 INFO - Downloaded 10841076 bytes. 16:52:45 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'] 16:52:45 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 16:52:45 INFO - Return code: 0 16:52: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')]} 16:52:45 INFO - https://queue.taskcluster.net/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:52:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:52:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:52:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/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 16:52:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IZWQ7IczQbeBYx5FeLXV_g/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 16:52:47 INFO - Downloaded 54456917 bytes. 16:52:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:52:47 INFO - mkdir: /builds/slave/test/properties 16:52:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:52:47 INFO - Writing to file /builds/slave/test/properties/build_url 16:52:47 INFO - Contents: 16:52:47 INFO - build_url:https://queue.taskcluster.net/v1/task/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:52:47 INFO - Running post-action listener: _resource_record_post_action 16:52:47 INFO - Running post-action listener: set_extra_try_arguments 16:52:47 INFO - ##### 16:52:47 INFO - ##### Running populate-webroot step. 16:52:47 INFO - ##### 16:52:47 INFO - Running pre-action listener: _resource_record_pre_action 16:52:47 INFO - Running main action method: populate_webroot 16:52:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:52:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:52:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:52:47 INFO - '--tppagecycles', 16:52:47 INFO - '7'], 16:52:47 INFO - 'tests': ['tsvgm']}}, 16:52:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:52:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:52:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:52:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:52:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:52:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:52:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:47 INFO - 'talos_options': ['--disable-e10s'], 16:52:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:47 INFO - 'talos_options': ['--disable-e10s'], 16:52:47 INFO - 'tests': ['damp', 'tps']}, 16:52:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:47 INFO - 'tests': ['damp', 'tps']}, 16:52:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:52:47 INFO - 'tests': ['dromaeo_dom']}, 16:52:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:52:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:52:47 INFO - 'tests': ['a11yr', 16:52:47 INFO - 'ts_paint', 16:52:47 INFO - 'tpaint', 16:52:47 INFO - 'sessionrestore', 16:52:47 INFO - 'sessionrestore_no_auto_restore', 16:52:47 INFO - 'tabpaint']}, 16:52:47 INFO - 'other-e10s': {'tests': ['a11yr', 16:52:47 INFO - 'ts_paint', 16:52:47 INFO - 'tpaint', 16:52:47 INFO - 'sessionrestore', 16:52:47 INFO - 'sessionrestore_no_auto_restore', 16:52:47 INFO - 'tabpaint']}, 16:52:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:52:47 INFO - 'ts_paint', 16:52:47 INFO - 'tpaint', 16:52:47 INFO - 'sessionrestore', 16:52:47 INFO - 'sessionrestore_no_auto_restore', 16:52:47 INFO - 'tabpaint']}, 16:52:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:52:47 INFO - 'ts_paint', 16:52:47 INFO - 'tpaint', 16:52:47 INFO - 'sessionrestore', 16:52:47 INFO - 'sessionrestore_no_auto_restore', 16:52:47 INFO - 'tabpaint']}, 16:52:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:52:47 INFO - 'tests': ['a11yr', 16:52:47 INFO - 'ts_paint', 16:52:47 INFO - 'tpaint', 16:52:47 INFO - 'sessionrestore', 16:52:47 INFO - 'sessionrestore_no_auto_restore', 16:52:47 INFO - 'tabpaint']}, 16:52:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:52:47 INFO - 'tests': ['a11yr', 16:52:47 INFO - 'ts_paint', 16:52:47 INFO - 'tpaint', 16:52:47 INFO - 'sessionrestore', 16:52:47 INFO - 'sessionrestore_no_auto_restore', 16:52:47 INFO - 'tabpaint']}, 16:52:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:52:47 INFO - 'tests': ['tsvgx', 16:52:47 INFO - 'tsvgr_opacity', 16:52:47 INFO - 'tart', 16:52:47 INFO - 'tscrollx', 16:52:47 INFO - 'cart']}, 16:52:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:52:47 INFO - 'tsvgr_opacity', 16:52:47 INFO - 'tart', 16:52:47 INFO - 'tscrollx', 16:52:47 INFO - 'cart']}, 16:52:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:47 INFO - 'talos_options': ['--disable-e10s'], 16:52:47 INFO - 'tests': ['tp5o']}, 16:52:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:47 INFO - 'tests': ['tp5o']}, 16:52:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:47 INFO - 'talos_options': ['--disable-e10s', 16:52:47 INFO - '--xperf_path', 16:52:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:47 INFO - 'tests': ['tp5n']}, 16:52:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:47 INFO - 'talos_options': ['--xperf_path', 16:52:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:47 INFO - 'tests': ['tp5n']}}, 16:52:47 INFO - 'talos.zip': {'path': '', 16:52:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:52:47 INFO - Running post-action listener: _resource_record_post_action 16:52:47 INFO - ##### 16:52:47 INFO - ##### Running create-virtualenv step. 16:52:47 INFO - ##### 16:52:47 INFO - Running pre-action listener: _resource_record_pre_action 16:52:47 INFO - Running main action method: create_virtualenv 16:52:47 INFO - Creating virtualenv /builds/slave/test/build/venv 16:52:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:52:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:52:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:52:48 INFO - Using real prefix '/usr' 16:52:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:52:48 INFO - Installing distribute.............................................................................................................................................................................................done. 16:52:50 INFO - Installing pip.................done. 16:52:50 INFO - Return code: 0 16:52:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:50 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 0x7fc22add3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ae410>, '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 0x26af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26af7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:52:50 INFO - Using env: {'DISPLAY': ':0', 16:52:50 INFO - 'HOME': '/home/cltbld', 16:52:50 INFO - 'LANG': 'en_US.UTF-8', 16:52:50 INFO - 'LANGUAGE': 'en_US:en', 16:52:50 INFO - 'LOGNAME': 'cltbld', 16:52:50 INFO - 'MAIL': '/var/mail/cltbld', 16:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:50 INFO - 'MOZ_NO_REMOTE': '1', 16:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:50 INFO - 'NO_EM_RESTART': '1', 16:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:50 INFO - 'PWD': '/builds/slave/test', 16:52:50 INFO - 'SHELL': '/bin/bash', 16:52:50 INFO - 'SHLVL': '1', 16:52:50 INFO - 'TERM': 'linux', 16:52:50 INFO - 'TMOUT': '86400', 16:52:50 INFO - 'USER': 'cltbld', 16:52:50 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 16:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:50 INFO - '_': '/tools/buildbot/bin/python'} 16:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:52:50 INFO - Cleaning up... 16:52:50 INFO - Return code: 0 16:52:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:50 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 0x7fc22add3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ae410>, '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 0x26af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26af7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:52:50 INFO - Using env: {'DISPLAY': ':0', 16:52:50 INFO - 'HOME': '/home/cltbld', 16:52:50 INFO - 'LANG': 'en_US.UTF-8', 16:52:50 INFO - 'LANGUAGE': 'en_US:en', 16:52:50 INFO - 'LOGNAME': 'cltbld', 16:52:50 INFO - 'MAIL': '/var/mail/cltbld', 16:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:50 INFO - 'MOZ_NO_REMOTE': '1', 16:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:50 INFO - 'NO_EM_RESTART': '1', 16:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:50 INFO - 'PWD': '/builds/slave/test', 16:52:50 INFO - 'SHELL': '/bin/bash', 16:52:50 INFO - 'SHLVL': '1', 16:52:50 INFO - 'TERM': 'linux', 16:52:50 INFO - 'TMOUT': '86400', 16:52:50 INFO - 'USER': 'cltbld', 16:52:50 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 16:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:50 INFO - '_': '/tools/buildbot/bin/python'} 16:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:51 INFO - Downloading/unpacking psutil>=0.7.1 16:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:52:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:53 INFO - Installing collected packages: psutil 16:52:53 INFO - Running setup.py install for psutil 16:52:53 INFO - building 'psutil._psutil_linux' extension 16:52:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:52:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:52:53 INFO - building 'psutil._psutil_posix' extension 16:52:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:52:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:52:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:54 INFO - Successfully installed psutil 16:52:54 INFO - Cleaning up... 16:52:54 INFO - Return code: 0 16:52:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:52: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')]} 16:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52: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')]} 16:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52: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 0x7fc22add3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ae410>, '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 0x26af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26af7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:52: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 16:52: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 16:52:54 INFO - Using env: {'DISPLAY': ':0', 16:52:54 INFO - 'HOME': '/home/cltbld', 16:52:54 INFO - 'LANG': 'en_US.UTF-8', 16:52:54 INFO - 'LANGUAGE': 'en_US:en', 16:52:54 INFO - 'LOGNAME': 'cltbld', 16:52:54 INFO - 'MAIL': '/var/mail/cltbld', 16:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:54 INFO - 'MOZ_NO_REMOTE': '1', 16:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:54 INFO - 'NO_EM_RESTART': '1', 16:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:54 INFO - 'PWD': '/builds/slave/test', 16:52:54 INFO - 'SHELL': '/bin/bash', 16:52:54 INFO - 'SHLVL': '1', 16:52:54 INFO - 'TERM': 'linux', 16:52:54 INFO - 'TMOUT': '86400', 16:52:54 INFO - 'USER': 'cltbld', 16:52:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 16:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:54 INFO - '_': '/tools/buildbot/bin/python'} 16:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:52: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) 16:52:56 INFO - Installing collected packages: mozsystemmonitor 16:52:56 INFO - Running setup.py install for mozsystemmonitor 16:52:56 INFO - Successfully installed mozsystemmonitor 16:52:56 INFO - Cleaning up... 16:52:56 INFO - Return code: 0 16:52:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:52: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')]} 16:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52: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')]} 16:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52: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 0x7fc22add3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ae410>, '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 0x26af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26af7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:52: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 16:52: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 16:52:56 INFO - Using env: {'DISPLAY': ':0', 16:52:56 INFO - 'HOME': '/home/cltbld', 16:52:56 INFO - 'LANG': 'en_US.UTF-8', 16:52:56 INFO - 'LANGUAGE': 'en_US:en', 16:52:56 INFO - 'LOGNAME': 'cltbld', 16:52:56 INFO - 'MAIL': '/var/mail/cltbld', 16:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:56 INFO - 'MOZ_NO_REMOTE': '1', 16:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:56 INFO - 'NO_EM_RESTART': '1', 16:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:56 INFO - 'PWD': '/builds/slave/test', 16:52:56 INFO - 'SHELL': '/bin/bash', 16:52:56 INFO - 'SHLVL': '1', 16:52:56 INFO - 'TERM': 'linux', 16:52:56 INFO - 'TMOUT': '86400', 16:52:56 INFO - 'USER': 'cltbld', 16:52:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 16:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:56 INFO - '_': '/tools/buildbot/bin/python'} 16:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:56 INFO - Downloading/unpacking blobuploader==1.2.4 16:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:58 INFO - Downloading blobuploader-1.2.4.tar.gz 16:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:52:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:52:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52:59 INFO - Downloading docopt-0.6.1.tar.gz 16:52:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:52:59 INFO - Installing collected packages: blobuploader, requests, docopt 16:52:59 INFO - Running setup.py install for blobuploader 16:52:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:52:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:52:59 INFO - Running setup.py install for requests 16:52:59 INFO - Running setup.py install for docopt 16:53:00 INFO - Successfully installed blobuploader requests docopt 16:53:00 INFO - Cleaning up... 16:53:00 INFO - Return code: 0 16:53:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53: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')]} 16:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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')]} 16:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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 0x7fc22add3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ae410>, '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 0x26af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26af7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:53: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 16:53: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 16:53:00 INFO - Using env: {'DISPLAY': ':0', 16:53:00 INFO - 'HOME': '/home/cltbld', 16:53:00 INFO - 'LANG': 'en_US.UTF-8', 16:53:00 INFO - 'LANGUAGE': 'en_US:en', 16:53:00 INFO - 'LOGNAME': 'cltbld', 16:53:00 INFO - 'MAIL': '/var/mail/cltbld', 16:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:00 INFO - 'MOZ_NO_REMOTE': '1', 16:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:00 INFO - 'NO_EM_RESTART': '1', 16:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:00 INFO - 'PWD': '/builds/slave/test', 16:53:00 INFO - 'SHELL': '/bin/bash', 16:53:00 INFO - 'SHLVL': '1', 16:53:00 INFO - 'TERM': 'linux', 16:53:00 INFO - 'TMOUT': '86400', 16:53:00 INFO - 'USER': 'cltbld', 16:53:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 16:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:00 INFO - '_': '/tools/buildbot/bin/python'} 16:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:00 INFO - Running setup.py (path:/tmp/pip-_pA3Hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:00 INFO - Running setup.py (path:/tmp/pip-MjEnnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:00 INFO - Running setup.py (path:/tmp/pip-iXQPff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:00 INFO - Running setup.py (path:/tmp/pip-KMrKKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:00 INFO - Running setup.py (path:/tmp/pip-Nw6uAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:00 INFO - Running setup.py (path:/tmp/pip-gP0LPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:00 INFO - Running setup.py (path:/tmp/pip-05LChX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:00 INFO - Running setup.py (path:/tmp/pip-OgTYVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:00 INFO - Running setup.py (path:/tmp/pip-Sx8LZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:00 INFO - Running setup.py (path:/tmp/pip-hp8PGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:01 INFO - Running setup.py (path:/tmp/pip-ZFcdU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:01 INFO - Running setup.py (path:/tmp/pip-umvKkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:01 INFO - Running setup.py (path:/tmp/pip-E9nZFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:01 INFO - Running setup.py (path:/tmp/pip-kpW34e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:01 INFO - Running setup.py (path:/tmp/pip-ImFxQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:01 INFO - Running setup.py (path:/tmp/pip-q_3iW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:01 INFO - Running setup.py (path:/tmp/pip-3G2v_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:53:01 INFO - Running setup.py install for manifestparser 16:53:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:53:01 INFO - Running setup.py install for mozcrash 16:53:01 INFO - Running setup.py install for mozdebug 16:53:01 INFO - Running setup.py install for mozdevice 16:53:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:53:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:53:01 INFO - Running setup.py install for mozfile 16:53:02 INFO - Running setup.py install for mozhttpd 16:53:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:53:02 INFO - Running setup.py install for mozinfo 16:53:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:53:02 INFO - Running setup.py install for mozInstall 16:53:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:53:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:53:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:53:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:53:02 INFO - Running setup.py install for mozleak 16:53:02 INFO - Running setup.py install for mozlog 16:53:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:53:02 INFO - Running setup.py install for moznetwork 16:53:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:53:02 INFO - Running setup.py install for mozprocess 16:53:02 INFO - Running setup.py install for mozprofile 16:53:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:53:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:53:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:53:02 INFO - Running setup.py install for mozrunner 16:53:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:53:03 INFO - Running setup.py install for mozscreenshot 16:53:03 INFO - Running setup.py install for moztest 16:53:03 INFO - Running setup.py install for mozversion 16:53:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:53:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:53:03 INFO - Cleaning up... 16:53:03 INFO - Return code: 0 16:53:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53: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')]} 16:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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')]} 16:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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 0x7fc22add3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ae410>, '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 0x26af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26af7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:53: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 16:53: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 16:53:03 INFO - Using env: {'DISPLAY': ':0', 16:53:03 INFO - 'HOME': '/home/cltbld', 16:53:03 INFO - 'LANG': 'en_US.UTF-8', 16:53:03 INFO - 'LANGUAGE': 'en_US:en', 16:53:03 INFO - 'LOGNAME': 'cltbld', 16:53:03 INFO - 'MAIL': '/var/mail/cltbld', 16:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:03 INFO - 'MOZ_NO_REMOTE': '1', 16:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:03 INFO - 'NO_EM_RESTART': '1', 16:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:03 INFO - 'PWD': '/builds/slave/test', 16:53:03 INFO - 'SHELL': '/bin/bash', 16:53:03 INFO - 'SHLVL': '1', 16:53:03 INFO - 'TERM': 'linux', 16:53:03 INFO - 'TMOUT': '86400', 16:53:03 INFO - 'USER': 'cltbld', 16:53:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 16:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:03 INFO - '_': '/tools/buildbot/bin/python'} 16:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:03 INFO - Running setup.py (path:/tmp/pip-GuuxRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53: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)) 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:03 INFO - Running setup.py (path:/tmp/pip-t_54Ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53: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)) 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:03 INFO - Running setup.py (path:/tmp/pip-UH_Uws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53: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)) 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:03 INFO - Running setup.py (path:/tmp/pip-C9TNXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53: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)) 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:03 INFO - Running setup.py (path:/tmp/pip-IPK2DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53: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)) 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:03 INFO - Running setup.py (path:/tmp/pip-ZdME14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:03 INFO - Running setup.py (path:/tmp/pip-QcKl_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53: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)) 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:04 INFO - Running setup.py (path:/tmp/pip-RtI12c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53: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)) 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:04 INFO - Running setup.py (path:/tmp/pip-8CCiH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53: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)) 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:04 INFO - Running setup.py (path:/tmp/pip-CgLZgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53: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)) 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:04 INFO - Running setup.py (path:/tmp/pip-KmxWF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53: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)) 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:04 INFO - Running setup.py (path:/tmp/pip-_XvijW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53: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)) 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:04 INFO - Running setup.py (path:/tmp/pip-Rhj5VK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53: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)) 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:04 INFO - Running setup.py (path:/tmp/pip-CuV0Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53: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)) 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:04 INFO - Running setup.py (path:/tmp/pip-rghBko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53: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)) 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:04 INFO - Running setup.py (path:/tmp/pip-2uDe6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53: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)) 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:04 INFO - Running setup.py (path:/tmp/pip-gT3xIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53: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)) 16:53: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)) 16:53: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)) 16:53: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)) 16:53: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)) 16:53: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)) 16:53:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53:06 INFO - Downloading blessings-1.6.tar.gz 16:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:53:06 INFO - Installing collected packages: blessings 16:53:06 INFO - Running setup.py install for blessings 16:53:06 INFO - Successfully installed blessings 16:53:06 INFO - Cleaning up... 16:53:06 INFO - Return code: 0 16:53:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:53:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:07 INFO - Reading from file tmpfile_stdout 16:53:07 INFO - Current package versions: 16:53:07 INFO - argparse == 1.2.1 16:53:07 INFO - blessings == 1.6 16:53:07 INFO - blobuploader == 1.2.4 16:53:07 INFO - docopt == 0.6.1 16:53:07 INFO - manifestparser == 1.1 16:53:07 INFO - mozInstall == 1.12 16:53:07 INFO - mozcrash == 0.17 16:53:07 INFO - mozdebug == 0.1 16:53:07 INFO - mozdevice == 0.48 16:53:07 INFO - mozfile == 1.2 16:53:07 INFO - mozhttpd == 0.7 16:53:07 INFO - mozinfo == 0.9 16:53:07 INFO - mozleak == 0.1 16:53:07 INFO - mozlog == 3.1 16:53:07 INFO - moznetwork == 0.27 16:53:07 INFO - mozprocess == 0.22 16:53:07 INFO - mozprofile == 0.28 16:53:07 INFO - mozrunner == 6.11 16:53:07 INFO - mozscreenshot == 0.1 16:53:07 INFO - mozsystemmonitor == 0.0 16:53:07 INFO - moztest == 0.7 16:53:07 INFO - mozversion == 1.4 16:53:07 INFO - psutil == 3.1.1 16:53:07 INFO - requests == 1.2.3 16:53:07 INFO - wsgiref == 0.1.2 16:53:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53: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')]} 16:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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')]} 16:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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 0x7fc22add3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ae410>, '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 0x26af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26af7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:53: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 16:53: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 16:53:07 INFO - Using env: {'DISPLAY': ':0', 16:53:07 INFO - 'HOME': '/home/cltbld', 16:53:07 INFO - 'LANG': 'en_US.UTF-8', 16:53:07 INFO - 'LANGUAGE': 'en_US:en', 16:53:07 INFO - 'LOGNAME': 'cltbld', 16:53:07 INFO - 'MAIL': '/var/mail/cltbld', 16:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:07 INFO - 'MOZ_NO_REMOTE': '1', 16:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:07 INFO - 'NO_EM_RESTART': '1', 16:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:07 INFO - 'PWD': '/builds/slave/test', 16:53:07 INFO - 'SHELL': '/bin/bash', 16:53:07 INFO - 'SHLVL': '1', 16:53:07 INFO - 'TERM': 'linux', 16:53:07 INFO - 'TMOUT': '86400', 16:53:07 INFO - 'USER': 'cltbld', 16:53:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 16:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:07 INFO - '_': '/tools/buildbot/bin/python'} 16:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53: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)) 16:53: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)) 16:53: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)) 16:53: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)) 16:53: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)) 16:53: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)) 16:53: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)) 16:53: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)) 16:53: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)) 16:53: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)) 16:53: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)) 16:53:07 INFO - Cleaning up... 16:53:07 INFO - Return code: 0 16:53:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:53: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')]} 16:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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')]} 16:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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 0x7fc22add3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ae410>, '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 0x26af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26af7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:53: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 16:53: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 16:53:07 INFO - Using env: {'DISPLAY': ':0', 16:53:07 INFO - 'HOME': '/home/cltbld', 16:53:07 INFO - 'LANG': 'en_US.UTF-8', 16:53:07 INFO - 'LANGUAGE': 'en_US:en', 16:53:07 INFO - 'LOGNAME': 'cltbld', 16:53:07 INFO - 'MAIL': '/var/mail/cltbld', 16:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:07 INFO - 'MOZ_NO_REMOTE': '1', 16:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:07 INFO - 'NO_EM_RESTART': '1', 16:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:07 INFO - 'PWD': '/builds/slave/test', 16:53:07 INFO - 'SHELL': '/bin/bash', 16:53:07 INFO - 'SHLVL': '1', 16:53:07 INFO - 'TERM': 'linux', 16:53:07 INFO - 'TMOUT': '86400', 16:53:07 INFO - 'USER': 'cltbld', 16:53:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 16:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:07 INFO - '_': '/tools/buildbot/bin/python'} 16:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:07 INFO - Downloading/unpacking jsonschema 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:53:09 INFO - Downloading/unpacking functools32 (from jsonschema) 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53:09 INFO - Downloading functools32-3.2.3-2.tar.gz 16:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:53:09 INFO - warning: no files found matching '*.txt' 16:53:09 INFO - no previously-included directories found matching 'build' 16:53:09 INFO - no previously-included directories found matching 'dist' 16:53:09 INFO - no previously-included directories found matching '.git*' 16:53:09 INFO - Installing collected packages: jsonschema, functools32 16:53:09 INFO - Running setup.py install for functools32 16:53:09 INFO - warning: no files found matching '*.txt' 16:53:09 INFO - no previously-included directories found matching 'build' 16:53:09 INFO - no previously-included directories found matching 'dist' 16:53:09 INFO - no previously-included directories found matching '.git*' 16:53:09 INFO - Successfully installed jsonschema functools32 16:53:09 INFO - Cleaning up... 16:53:09 INFO - Return code: 0 16:53:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:53: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')]} 16:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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')]} 16:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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 0x7fc22add3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ae410>, '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 0x26af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26af7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:53: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 16:53: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 16:53:09 INFO - Using env: {'DISPLAY': ':0', 16:53:09 INFO - 'HOME': '/home/cltbld', 16:53:09 INFO - 'LANG': 'en_US.UTF-8', 16:53:09 INFO - 'LANGUAGE': 'en_US:en', 16:53:09 INFO - 'LOGNAME': 'cltbld', 16:53:09 INFO - 'MAIL': '/var/mail/cltbld', 16:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:09 INFO - 'MOZ_NO_REMOTE': '1', 16:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:09 INFO - 'NO_EM_RESTART': '1', 16:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:09 INFO - 'PWD': '/builds/slave/test', 16:53:09 INFO - 'SHELL': '/bin/bash', 16:53:09 INFO - 'SHLVL': '1', 16:53:09 INFO - 'TERM': 'linux', 16:53:09 INFO - 'TMOUT': '86400', 16:53:09 INFO - 'USER': 'cltbld', 16:53:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 16:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:09 INFO - '_': '/tools/buildbot/bin/python'} 16:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:10 INFO - Downloading/unpacking flake8 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:53:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:53:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:53:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:12 INFO - no previously-included directories found matching 'docs/_build' 16:53:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:53:12 INFO - Running setup.py install for pep8 16:53:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:12 INFO - no previously-included directories found matching 'docs/_build' 16:53:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:53:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:53:12 INFO - Cleaning up... 16:53:12 INFO - Return code: 0 16:53:12 INFO - Running post-action listener: _resource_record_post_action 16:53:12 INFO - Running post-action listener: _start_resource_monitoring 16:53:12 INFO - Starting resource monitoring. 16:53:12 INFO - ##### 16:53:12 INFO - ##### Running install step. 16:53:12 INFO - ##### 16:53:12 INFO - Running pre-action listener: _resource_record_pre_action 16:53:12 INFO - Running main action method: install 16:53:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:13 INFO - Reading from file tmpfile_stdout 16:53:13 INFO - Detecting whether we're running mozinstall >=1.0... 16:53:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:53:13 INFO - Reading from file tmpfile_stdout 16:53:13 INFO - Output received: 16:53:13 INFO - Usage: mozinstall [options] installer 16:53:13 INFO - Options: 16:53:13 INFO - -h, --help show this help message and exit 16:53:13 INFO - -d DEST, --destination=DEST 16:53:13 INFO - Directory to install application into. [default: 16:53:13 INFO - "/builds/slave/test"] 16:53:13 INFO - --app=APP Application being installed. [default: firefox] 16:53:13 INFO - mkdir: /builds/slave/test/build/application 16:53: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'] 16:53: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 16:53:28 INFO - Reading from file tmpfile_stdout 16:53:28 INFO - Output received: 16:53:28 INFO - /builds/slave/test/build/application/firefox/firefox 16:53:28 INFO - Running post-action listener: _resource_record_post_action 16:53:28 INFO - ##### 16:53:28 INFO - ##### Running run-tests step. 16:53:28 INFO - ##### 16:53:28 INFO - Running pre-action listener: _resource_record_pre_action 16:53:28 INFO - Running main action method: run_tests 16:53:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:53:28 INFO - Python 2.7.3 16:53:28 INFO - Return code: 0 16:53:28 INFO - grabbing minidump binary from tooltool 16:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:28 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 0x26ae410>, '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 0x26af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26af7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:53:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:53:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:53:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:53:28 INFO - Return code: 0 16:53:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:53:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:53:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:53:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:53:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:53:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:53:29 INFO - Return code: 0 16:53:29 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/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 16:53:29 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/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 16:53:29 INFO - Using env: {'DISPLAY': ':0', 16:53:29 INFO - 'HOME': '/home/cltbld', 16:53:29 INFO - 'LANG': 'en_US.UTF-8', 16:53:29 INFO - 'LANGUAGE': 'en_US:en', 16:53:29 INFO - 'LOGNAME': 'cltbld', 16:53:29 INFO - 'MAIL': '/var/mail/cltbld', 16:53:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:53:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:29 INFO - 'MOZ_NO_REMOTE': '1', 16:53:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:29 INFO - 'NO_EM_RESTART': '1', 16:53:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:29 INFO - 'PWD': '/builds/slave/test', 16:53:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:53:29 INFO - 'SHELL': '/bin/bash', 16:53:29 INFO - 'SHLVL': '1', 16:53:29 INFO - 'TERM': 'linux', 16:53:29 INFO - 'TMOUT': '86400', 16:53:29 INFO - 'USER': 'cltbld', 16:53:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433', 16:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:29 INFO - '_': '/tools/buildbot/bin/python'} 16:53:29 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/IZWQ7IczQbeBYx5FeLXV_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 16:53:30 INFO - mozversion application_buildid: 20160415153714 16:53:30 INFO - mozversion application_changeset: f5a97eb5c89a2b5133ff8bba915acba6344fa7cc 16:53:30 INFO - mozversion application_display_name: Nightly 16:53:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:53:30 INFO - mozversion application_name: Firefox 16:53:30 INFO - mozversion application_remotingname: firefox 16:53:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:53:30 INFO - mozversion application_vendor: Mozilla 16:53:30 INFO - mozversion application_version: 48.0a1 16:53:30 INFO - mozversion platform_buildid: 20160415153714 16:53:30 INFO - mozversion platform_changeset: f5a97eb5c89a2b5133ff8bba915acba6344fa7cc 16:53:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:53:30 INFO - mozversion platform_version: 48.0a1 16:53:30 INFO - using testdate: 1460764410 16:53:30 INFO - actual date: 1460764410 16:53:30 INFO - starting webserver on 'localhost:52585' 16:53:30 INFO - SUITE-START | Running 2 tests 16:53:30 INFO - TEST-START | dromaeo_css 16:53:30 INFO - operating with platform_type : linux_ 16:53:30 INFO - Initialising browser for dromaeo_css test... 16:53:30 INFO - TEST-INFO | started process 4003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJwChTI/profile http://localhost:52585/getInfo.html) 16:53:34 INFO - PROCESS | 4003 | 16:53:34 INFO - PROCESS | 4003 | (process:4071): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:53:34 INFO - PROCESS | 4003 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 16:53:35 INFO - PROCESS | 4003 | __metrics Screen width/height:1600/1200 16:53:35 INFO - PROCESS | 4003 | colorDepth:24 16:53:35 INFO - PROCESS | 4003 | Browser inner width/height: 1024/697 16:53:35 INFO - PROCESS | 4003 | __metrics 16:53:36 ERROR - PROCESS | 4003 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:53:36 INFO - TEST-INFO | 4003: exit 0 16:53:36 INFO - Browser initialized. 16:53:36 INFO - Running cycle 1/1 for dromaeo_css test... 16:53:36 INFO - TEST-INFO | started process 4122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJwChTI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:53:38 INFO - PROCESS | 4122 | 16:53:38 INFO - PROCESS | 4122 | (process:4180): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:53:48 INFO - PROCESS | 4122 | RSS: Main: 164855808 16:53:48 INFO - PROCESS | 4122 | 16:54:38 INFO - PROCESS | 4122 | 1460764478507 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:56:50 INFO - PROCESS | 4122 | Cycle 1(1): loaded http://localhost:52585/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52585/tests/dromaeo/cssquery-ext.html) 16:56:50 INFO - PROCESS | 4122 | RSS: Main: 168501248 16:56:50 INFO - PROCESS | 4122 | 16:59:52 INFO - PROCESS | 4122 | Cycle 1(1): loaded http://localhost:52585/tests/dromaeo/cssquery-ext.html (next: http://localhost:52585/tests/dromaeo/cssquery-jquery.html) 16:59:53 INFO - PROCESS | 4122 | RSS: Main: 165384192 16:59:53 INFO - PROCESS | 4122 | 17:02:55 INFO - PROCESS | 4122 | Cycle 1(1): loaded http://localhost:52585/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52585/tests/dromaeo/cssquery-mootools.html) 17:02:56 INFO - PROCESS | 4122 | RSS: Main: 166998016 17:02:56 INFO - PROCESS | 4122 | 17:05:57 INFO - PROCESS | 4122 | Cycle 1(1): loaded http://localhost:52585/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52585/tests/dromaeo/cssquery-prototype.html) 17:05:58 INFO - PROCESS | 4122 | RSS: Main: 164655104 17:05:58 INFO - PROCESS | 4122 | 17:09:01 INFO - PROCESS | 4122 | Cycle 1(1): loaded http://localhost:52585/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52585/tests/dromaeo/cssquery-yui.html) 17:09:01 INFO - PROCESS | 4122 | RSS: Main: 166248448 17:09:01 INFO - PROCESS | 4122 | 17:12:04 INFO - PROCESS | 4122 | Cycle 1(1): loaded http://localhost:52585/tests/dromaeo/cssquery-yui.html (next: http://localhost:52585/tests/dromaeo/cssquery-dojo.html) 17:12:04 INFO - PROCESS | 4122 | RSS: Main: 168116224 17:12:04 INFO - PROCESS | 4122 | 17:12:04 INFO - PROCESS | 4122 | __start_tp_report 17:12:04 INFO - PROCESS | 4122 | _x_x_mozilla_page_load 17:12:04 INFO - PROCESS | 4122 | _x_x_mozilla_page_load_details 17:12:04 INFO - PROCESS | 4122 | |i|pagename|runs| 17:12:04 INFO - PROCESS | 4122 | |0;dojo.html;2602.7006894207166;2669.2526092694047;2706.688730795959;2710;2721.374083960689;4696.483386827451;4704.247320428732;4705.576498115169;4712.835050773219;4742.715437073778;4612.146752850725;4710.458297295812;4722.05558888222;4769.141554520185;4769.165396055694;4271.466066741649;4312.97843510782;4355.273545139043;4402.449693788277;4423.358613001113;4340.327249276367;4348.717333373321;4397.406350142722;4402.25161722508;4447.4218351614245;4212.304969679999;4295.484541854998;4334.978325108385;4340;4366.279563871989;4308.719933204332;4348.391225228471;4357.607815296638;4364.083542456088;4380.452443444569;4317.654587632982;4329.177456283296;4336.674749393776;4344.9348259776125;4373.584509471595;4407.581279778416;4581.816727330903;4653.418322709661;4655.138799322102;4673.649476289258;5024.598032157419;5027.572656324217;5028.974855125737;5049.318342023853;5102.183650615883;5079.74601269935;5080.695158290478;5090.2364645303505;5096.79612815487;5102.897942041175;4705.12955103307;4729.763511824463;4730.787114579852;4771.0934922364295;4791.353167322437;5188.299579556711;5201.375834899761;5206.088934436534;5208.427073021964;5266.368035835648;4914.852554423373;4970.44840680533;4987.401511818605;4995.600351971833;5018.121828679967;4793.712377257376;5030.245463180552;5033.949660503348;5045.949540504548;5081.060003899291;5006.549410553068;5018.673786203885;5020.171671674133;5021.121303771825;5066.03745288394;4840.104580652591;4978.651494395358;4991.226359914219;5004;5043.117454445457;4252.4046633471335;4255.489341279066;4256.9574304257185;4296.699231053859;4301.333293339538;3718.758280711745;3720.7729900915215;3722.050877026341;3758.229562939591;3762.9247415051545;4366.432363792686;4394.055278115156;4470.374147619336;4472.396226509444;4477.238869392211;5087.058894104603;5093.414257360377;5093.414257360377;5096.362954630671;5113.488651134857;4438.511763705989;4445.110977804387;4445.110977804452;4470.329450582439;4493.258612328929;4383.7808109595035;4465.598096171295;4519.728816271035;4533.138703646297;4538.387317712067;4822.71063736177;4837.927431088537;4848.981713840062;4851.36932198819;4856.757162141949;5118.334616499831;5123.846284611468;5156.716380599103;5179.093658609803;5180.844574662766;4625.352450656978;4749.382580264543;4808.447028591757;4812.590929771009;4864.173090574682;5001.64988450805;5008.724520151427;5010.749462526786;5013.724245166551;5068.239764035424;4869.707817530818;5089.262057001788;5096.23556466533;5109.310243117132;5137.563307118937;4721.881952951204;4884.535969082932;4886.706797592155;4997.250412438163;5016.698998060128;4919.557239848431;4940.407151141886;4951.678140920829;4954.405471343462;4989.052080104769;4597.586217240464;4865.197242454955;4868.367112275523;4871.098846713369;4926.778294976663;4969;5013.699178049329;5020.598352131748;5032.245163225545;5068.29043933857;4860.222364421676;4882.487338829514;4907.705537667752;4911.115999120049;4927.679700819435 17:12:04 INFO - PROCESS | 4122 | |1;ext.html;578.3031447106238;592.8636413624866;597.4324391827764;611.3275397063229;633.183193680153;33958.32083358335;34037.319253614914;34319.65680343196;34521.654783452155;34642.65357346426;36227.456588151195;36998.81500592493;37140.44289335662;37288.81355593225;37344.43983340252;7573.24267573241;7722.073351197864;7791.376689864797;7814.023247094114;7816.726414575491;7663.386929045663;7732.536047837119;7744.612769361537;7775.222477752208;7795.5712435816;7783.883241751379;7802.687892484294;7821.335186509154;7844.529328240295;7870.488418252824;7738.574378409186;7739.187385324544;7747.8450430991625;7795.33739632132;7803.570803605771;7790.259925307087;7889.500994810967;7891.763247102596;7893.842123157562;7908.130105688369;37345.62654373476;37563.24873502515;37796;38031.42952855709;38222.808885955674;3127.5465057566753;3196.744260459158;3326.168457885529;3692.1138926657677;3934.3311637021775;28352.291192720142;28734.856325718447;28986;29372.559411608843;29563.26091847721;3532.947005794915;3574.338747331752;3576.356255873942;3607.4047782115917;3609.4501607557813;226311;226481;227066;227971;228087;52448;52544.21183682248;52955;53011.46988530143;53067;55711;56088;58291.879352668206;59591;59958.40041599528;15439.228038598025;15503.922480387751;15572.766408503881;15701.764473532907;15710.528684139494;11973;12084.093692973061;12169.148159628741;12187;12224.877751222373;17928.372506962194;18017.459476215736;18096.547586310448;18114.728279075825;18316.63366732658;7027.648617569101;7099;7173.318534739192;7237.552489502121;7343.48595598303;948.7628092976756;974.1232890398697;975.0493269062607;998.5257002923698;1036.5387402605768;27932.720672793417;28350.291242719097;28878.133655990354;28923.710762892522;29096.418071638447;1022.0494939706144;1038.3302769713644;1081.605214096849;1084.4415126210008;1097.6871591596357;14197.290135493184;14202.786958195635;14266.215358155401;14391;14622.26888655563;329838;332332;334217;336053;337477;45847.31229031567;46078;46287.30569041467;46484.302735458994;46562.5343746565;1238.7274799544086;1244.807054906491;1264.4942023190613;1271.9364031798373;1275.515304184404;24909.501809963338;26794.59808102919;26824.731752683005;26894.32764180911;27060.052898149257;40490.39264410977;46574.30138547857;48606.513934860195;48608;48611;309867;314162;316264;317940;318469;38290.23419531538;38439.23121537497;38463;38660.6133938657;38914.22171556496;42748;42919.35620965625;43240.135197296506;43565.56434435615;43922.78038609787;36450;37140.6285937148;37583;37585.24829503449;37782;35898.8205058973;36582.26835463329;37160.6283937168;37282.62717372792;37306.81346593249;31643.683563164075;36346;36930.63069369272;37230.25539489249;37688.62311376851;29105.12684619465;32756.34487310288;35977.82011089928;36349.63650363568;36732.632673673994;24956;25204;25613;25641.358966026;25780.09769658053 17:12:04 INFO - PROCESS | 4122 | |2;jquery.html;385.7454080306996;386.3123639920941;388.54928283191504;394.5344493497673;406.68075560684866;15239.466618668348;16196.155997762342;16649.417270395537;16653.916730416346;16681;15152.545423637308;15688.215589220521;16076.196190190472;16131.596710082255;16132.516024519284;4996.850094497171;5111.488851114896;5162.1224391853475;5164.6384753067305;5188.844334669966;3638.890833275006;5511.366192887809;5845.85385365365;5845.970770146143;5850.0932355484965;5568.610197286192;5739.684317362543;5785;5795.4784069433745;5805.390434004432;5696.11710184922;5736.311642602873;5768.105943578731;5771.682557459338;5777.740001699934;4912.631552633567;5120.667156634807;5137.152369858969;5137.717425541594;5211.0359583477175;11025.503852326665;11756.588519401865;19881.80118198814;20056.29802956904;20131.798682013137;1796.4790210838842;1827.8354948054605;1890.3194849854042;2099.9475013124643;2146.399008277685;8947.731568052968;9049.2308153807;9232.8615070774;9418.19945304643;9463.432194068379;1703.9318427262895;1761.3130878957218;1801.8288262615163;1813.8004819469847;1844.2807305151002;64186;67117;67591;68616.6569167156;68774;10160.847587286196;10213.438260895573;10217.438040907673;10237.23220758446;10342.431166285776;14193.574192774027;14294.428222870969;14313.28433578317;14314.141151530941;14336.713265734836;7098.751543695946;7555.622218889143;7576.7348142814735;7613.695452181962;7732.226777322223;7205.4595905307315;7233.132024157135;7393.927880457411;7399.926000740032;7432.777016689508;4320.135972805451;4358.694891357574;4423.270160423558;4488.483824360175;4502.57225563571;1707.3597400974634;1760.2079064421062;1838.9540261493569;1884.8963307018246;1887.4620733091003;867.089555966233;896.6771962093771;900.4507250577143;939.8825146856643;960.9381633295109;16256.349746010264;16473.505794826175;16495.83504164967;16564.917175414044;16850.241739121768;878.3149143667949;897.8473659477904;917.2295271971576;939.4598106089027;959.1607343574373;8705.12948705137;8947.460376887559;9240.8613870792;9392.906070939203;9402.576884040234;332736;336688;337220;391294;394463;78117;79318.6034069826;80489.19510804935;81519.59240203879;81582.59208703919;1015.1777060580953;1025.1183981775666;1033.7312298802215;1051.2536099369534;1053.015430572402;13967.371468283749;14423.711525769217;14674.853251467348;14990.700185996437;15083.773743393638;31361.52957705682;31730;34301.912827844615;35123.29753404867;37104;44142.558574413844;46043.539564603925;46063.309050364944;46177.30734038925;46236.53763462457;7178.389836863925;7348.265173482609;7365.079365079365;7392.4825262231125;7463.477556571205;9567.808643826946;10771.19216058783;10805;10839.458027098772;10918.890811091787;8829;9190.678326258549;9230.953845230732;9337.159655631025;9468.195203407788;8777.824443510966;9118.133777291147;9260.351775375659;9418.858717119112;9478.336516444058;9544.33189676716;9597.616095356387;9628.18160456369;9827.262955278526;10139.7465063374;6189.257289125154;6708;6791.049253104668;6905.274946130584;6940.201876784033;8047.678092876454;9053.728388148365;9255.76860578491;9305.976342602444;9396.060393960823 17:12:04 INFO - PROCESS | 4122 | |3;mootools.html;1418.3192067807452;1472.9410823567057;1618.1342981504897;1746.9563260918483;1807.755952946352;6943.722251109963;7304.415646748261;7566.924330756691;7576.090869095702;7591.430642701799;7697.076350837908;7715.884261736079;7732.729354472594;7796.649150788214;7812.882806757889;2238.1383167480476;2257.9435514112197;2272.1820144747876;2273.943151421219;2275.283285764987;2220.544788318391;2222.055626358799;2238.541099074694;2245.079517397867;2246.696695946051;2104.6632538793797;2108.8312934965243;2127.064091799611;2146.1415433826514;2183.727034120735;2131.7761635028332;2133.829293656504;2140.464883779055;2145.9463513412134;2153.8061574458375;2098.7586427560873;2110.0610228448345;2119.5442979759273;2131.5630295789483;2134.17834133858;7917.485363451357;7927.048754149481;7942.444028917978;8008.158123631597;8021.879671804928;4622.6070783983405;4765.237561990065;4773.236282194832;4791.401074865642;4797.18447863864;2974.3902499987453;2982.6569944456446;3098.148009297439;3116.781825272232;3140.811551306906;898.806756547339;919.8022425178552;937.9906200937971;939.0327962198946;942.1567696911226;10565.154787616972;10661.200409969284;10673.412962287071;10679.519421626046;10700.143988480902;4074.5314288856566;4162.958370416257;4315.6763242756915;4345.283028300295;4379.562043795595;9154.359194856295;9178.586963586655;9189.724308270763;9191.908080919238;9203.40177888435;4761.285807128958;4766.022965292107;4767.427908650984;4780.282957556325;4782.808687652525;3758.830852611639;4145.440365550612;4272.316429371285;4279.144171165779;4318.352247162888;3612.692921101683;3686.447032945026;3693.575238847513;3711;3752.5309336332957;1191.386435985468;1214.8481439820023;1217.075022982522;1230.8153776933532;1231.6305108467425;694.5971336624847;755.199488542147;842.839860426517;852.8507511185642;866.5710473315623;5176.327077479904;5182.792688292426;5234.0840352938085;5308.654937429054;5356.517913387814;849.3417601358997;915.4507295622573;929.9628014879464;953.6709835106877;964.2093483343591;3510.008387887645;3791.6777073949024;3801.6008319126645;3816.3893776995546;3823.9808800956375;9522.809543809224;9865.852012219822;9929.65246216379;9979.600815967426;9995.400275983318;9656.903430965742;9725.221982241404;9731;9877.901220987842;9887.950560247296;7144.499885008104;7265.346118849223;7276.126864776154;7333.706651733871;7425.1461081975185;5303.946960530346;5393.460653934575;5410.080286351408;5445.83662490126;5567.526760225426;8791.252743516872;8853.203211710977;8955.910440895508;8991.685291015045;9105.135012173832;8477.788055298666;8819.250363719155;8833;8863.290936725176;8967.417117887577;6195.969020155051;6589.6375699336995;6795.422389096784;6853.93763966586;6981.057557229912;7521.699132034657;7542.962285188759;7565.583892885724;7613.733519326797;7621.580813055335;6554.639494827639;6763.222229443677;6810.897836532356;6882.483813714091;7009.719611215494;6846.726130954706;6896.172459304916;6897.7240910365035;6951.304869513008;7057.082579264663;6003.7898673546215;6062.454379105901;6072.180255665606;6109.419605137505;6218.036204388327;4680.7893644786745;4697.271922851964;4704.835330763407;4718.882027949328;4753.714777113384;4400.625946794558;4442.42248507692;4478.753668548261;4554.339620754906;4556.544345565417 17:12:04 INFO - PROCESS | 4122 | |4;prototype.html;310.8476846345292;318.0728177362987;323.49534725827704;327.98360081995895;328.6220846027067;5134.537891589756;5278.524932756051;5315.707636080014;5317.946820531798;5379.865503362413;5358.276632654591;5360.437154098822;5371.274877891484;5385.892282154355;5387.865303367418;4174.561671024537;4190.287651099306;4190.664746820263;4190.685698572604;4207.221663992156;3928.7249892507534;4154.896127596804;4200.369944508333;4220.388043733657;4233.576642335757;4097.955021469521;4098.159877225162;4103.8974025649295;4107.445494858201;4108.5275193352845;4070.5522392536795;4092.406601042847;4092.774897380643;4102.302608556538;4118.876433706963;3591.3535563598543;3592.6586974237407;3596.8741094061584;3597.712183025352;3624.52881125452;5040.571551418134;5090.490950904917;5101.540861322499;5111.309973153614;5122.615803814729;4678.976605116953;4686;4697.4832768395445;4702.835400760991;4725.716457012556;5510.6969116698565;5551.916721249185;5557.1108622620595;5558.888822223574;5587;3772.1512659651635;3921.3333733265413;3921.960780392188;3922.0979174789672;3933.4296527003426;5828.825135245907;5902.734376953047;5915.792947246826;5929.199558059693;5931;4024.879253622396;4029.7985100744845;4041.837616874958;4050.959490405058;4053.635172834459;4015.377616469452;4064.1262128641893;4095.692823038284;4107.034846810997;4116.9826784875195;4665.790039448233;4683.180443422388;4694.460137084211;4695.741734204583;4724.740139292303;5318.73406329682;5490.505854473116;5565.582581306418;5565.916511252334;5621.775128994795;1359.6872719274425;1400.2718586335252;1406.4514839212716;1406.8100806391005;1410.9506167284096;921.1019256225127;924.7734305095295;944.3389627260945;949.1742184299703;958.4584709639032;4846.95153048465;4865.513448655106;4898.681585696918;4903.8528844134735;4930.605551555867;5691.658500489983;5713.171590119409;5727.541796656257;5748.281464816898;5749.741261643152;4736;4886.047220791983;4888.315635810989;4895.216765317532;4914.336564563738;3053.328267781085;3058.4189004089153;3071.0479751277176;3081.0910781319117;3094.98452507736;5381.7578208980685;5406.324209473816;5407.972960135174;5409.972950135224;5411.107167317348;5675.460831221028;5918.822435326861;6023.668698221552;6032.733126043492;6040.667763272974;5509.614326997072;5513.641613295204;5525.099322855453;5567.359753628384;5570.248016517799;5719.3136823581435;5817.331006934257;5847.210626565529;5865.912011319919;5874.324452687824;5735.598508104393;5744.655320680772;5745.6552606843725;5749.741261643152;5763.97118014424;5474.644148130359;5500.4499550044675;5502.9174562380795;5508.44915508446;5544.584156188222;3963;3994.380870965005;3997.2205419942834;4037.535683396447;4050.1899620075515;5535.5848311376;5614.494695477263;5835.56233282497;5847.707614619337;5883;5618.943810561842;5634.859128521656;5647.463490968352;5662.631928924607;5672.9505041567445;5610.971945140248;5622.550195984393;5638.23883775685;5638.661680299195;5641.379448260606;5235.141524758656;5539.446055394428;5563.805266815642;5582.637128586629;5603;5613.158026296088;5634.830955071355;5646.85882852932;5648.293963254593;5674.120511320752;5245.921311180259;5546.861328466821;5548.306461692288;5549;5573.972130139324 17:12:04 INFO - PROCESS | 4122 | |5;yui.html;657.8980258059996;775.4959276470294;790.9367250619947;796.486266358199;803.2810634482134;11433.142514311417;11589;11762.059035277178;11777.528898844057;11788.115891308144;13398.12912160709;13885;13949.58151255464;13957.302134893265;13986.650333741662;648.4650163615013;807.3581502705349;827.437342607027;830.6884918155691;834.0866750907746;800.2797482265978;821.3880658909121;822.979425514361;826.4751882554561;827.3918669777709;840.0213750980131;848.7835601921502;852.0159216105408;854.2781349759443;856.6145234644404;847.1570787066877;849.4945507423073;850.8808766772656;852.7313896122702;855.8459477294084;628.0422355907232;629.3769168523174;632.1245075570322;633.0693879996398;633.1800318587441;12284.447199876027;12298.20061695987;12309.138360314782;12354.25874447536;12393;11231.719207019809;11795.35125568102;11877.524899004029;12205.816912746315;12263.386830658521;10789.568417263301;10931.945340273327;10968.506417211165;11019.779604407948;11267.098632109411;3262.0703099616494;3281.4913688378338;3323.418401779703;3327.7005069543616;3335.3662804067394;47978.28032579514;48168;48177.518224818006;48337.75831120822;48847.755761220964;9656.130948214695;9747.171490423252;9750;9761.804763904682;9768.120869121813;15690.215489225722;15848.128352940468;15874.920625396799;15891.205439727968;16004.279807408695;6410.647414392253;6440.130582371414;6510.869782604416;6539.11721917535;6597.340265973365;3532.452469867175;3577.83899724513;3598.2803439312243;3646.288973650113;3664.790619095692;2901.5792710057344;2979.7616190704694;2983.8358890261243;2985.1790757541416;2987.626546681665;493.755590982466;528.6510902804131;549.7059073395714;551.9116941289454;560.6692051689441;601.485729701108;643.9871202575922;655.5509476008949;661.8444665503603;668.2615709640874;7520.774376768706;7561.2060733623275;7983.20167983197;8157.06193787722;8199.549024803573;651.9152510173647;653.121551513214;654.2802916791586;659.1826135591832;659.4691273524762;3654.4152935530187;3752.6810221130963;3758.774473531597;3843.7117216208335;3874.41883717439;53844.461555384725;54028.72985635047;54246.728766356704;54812.72593637086;55028;22772;22995.425114372276;23011.654825177637;47359;48342.27486587704;37505;38457.42313865294;40936;45112.3233151503;45306.32040519395;7953.5227886327;8062.234087761653;8064.637091331021;8099.473534220257;8298.917010829815;26494.470110597296;26718.59922101131;27122.864385678735;27169;27302.590461143496;32454;36422.635773642985;37591.43612845864;37823;38648.22703545857;10307.94846025765;10566.947165264432;10618.946905265424;10628.096611788085;10680.465976700978;11360.43414403432;11367.147463940073;11499.195056345976;11619;11635.127365447455;11213.66359009231;11242.831357529807;11546.787587303548;11786.705332366759;11935.641930742091;11338.206325557132;11525;11781.234219775688;11966.22219555726;12032.15774895784;10206.744831379276;10419.322744021614;10462.895371046496;10591.205659575717;10740.248182627141;9500.95249523748;9530.523473826419;9558.808823823623;9621.230301575717;9625.663101791404;9729.659461918798;9896.703098907044;9902.950485247527;10015.599376024877;10032.899671003197 17:12:04 INFO - PROCESS | 4122 | __end_tp_report 17:12:04 INFO - PROCESS | 4122 | __start_cc_report 17:12:04 INFO - PROCESS | 4122 | _x_x_mozilla_cycle_collect,372 17:12:04 INFO - PROCESS | 4122 | __end_cc_report 17:12:04 INFO - PROCESS | 4122 | __startTimestamp1460765524496__endTimestamp 17:12:04 INFO - PROCESS | 4122 | 17:12:04 INFO - PROCESS | 4122 | ------- Summary: start ------- 17:12:04 INFO - PROCESS | 4122 | Number of tests: 6 17:12:04 INFO - PROCESS | 4122 | 17:12:04 INFO - PROCESS | 4122 | [#0] dojo.html Cycles:165 Average:4680.30 Median:4822.71 stddev:488.77 (10.1%) stddev-sans-first:462.29 17:12:04 INFO - PROCESS | 4122 | Values: 2602.7 2669.3 2706.7 2710.0 2721.4 4696.5 4704.2 4705.6 4712.8 4742.7 4612.1 4710.5 4722.1 4769.1 4769.2 4271.5 4313.0 4355.3 4402.4 4423.4 4340.3 4348.7 4397.4 4402.3 4447.4 4212.3 4295.5 4335.0 4340.0 4366.3 4308.7 4348.4 4357.6 4364.1 4380.5 4317.7 4329.2 4336.7 4344.9 4373.6 4407.6 4581.8 4653.4 4655.1 4673.6 5024.6 5027.6 5029.0 5049.3 5102.2 5079.7 5080.7 5090.2 5096.8 5102.9 4705.1 4729.8 4730.8 4771.1 4791.4 5188.3 5201.4 5206.1 5208.4 5266.4 4914.9 4970.4 4987.4 4995.6 5018.1 4793.7 5030.2 5033.9 5045.9 5081.1 5006.5 5018.7 5020.2 5021.1 5066.0 4840.1 4978.7 4991.2 5004.0 5043.1 4252.4 4255.5 4257.0 4296.7 4301.3 3718.8 3720.8 3722.1 3758.2 3762.9 4366.4 4394.1 4470.4 4472.4 4477.2 5087.1 5093.4 5093.4 5096.4 5113.5 4438.5 4445.1 4445.1 4470.3 4493.3 4383.8 4465.6 4519.7 4533.1 4538.4 4822.7 4837.9 4849.0 4851.4 4856.8 5118.3 5123.8 5156.7 5179.1 5180.8 4625.4 4749.4 4808.4 4812.6 4864.2 5001.6 5008.7 5010.7 5013.7 5068.2 4869.7 5089.3 5096.2 5109.3 5137.6 4721.9 4884.5 4886.7 4997.3 5016.7 4919.6 4940.4 4951.7 4954.4 4989.1 4597.6 4865.2 4868.4 4871.1 4926.8 4969.0 5013.7 5020.6 5032.2 5068.3 4860.2 4882.5 4907.7 4911.1 4927.7 17:12:04 INFO - PROCESS | 4122 | 17:12:04 INFO - PROCESS | 4122 | [#1] ext.html Cycles:180 Average:45613.59 Median:20311.37 stddev:77505.80 (381.6%) stddev-sans-first:77649.47 17:12:04 INFO - PROCESS | 4122 | Values: 578.3 592.9 597.4 611.3 633.2 33958.3 34037.3 34319.7 34521.7 34642.7 36227.5 36998.8 37140.4 37288.8 37344.4 7573.2 7722.1 7791.4 7814.0 7816.7 7663.4 7732.5 7744.6 7775.2 7795.6 7783.9 7802.7 7821.3 7844.5 7870.5 7738.6 7739.2 7747.8 7795.3 7803.6 7790.3 7889.5 7891.8 7893.8 7908.1 37345.6 37563.2 37796.0 38031.4 38222.8 3127.5 3196.7 3326.2 3692.1 3934.3 28352.3 28734.9 28986.0 29372.6 29563.3 3532.9 3574.3 3576.4 3607.4 3609.5 226311.0 226481.0 227066.0 227971.0 228087.0 52448.0 52544.2 52955.0 53011.5 53067.0 55711.0 56088.0 58291.9 59591.0 59958.4 15439.2 15503.9 15572.8 15701.8 15710.5 11973.0 12084.1 12169.1 12187.0 12224.9 17928.4 18017.5 18096.5 18114.7 18316.6 7027.6 7099.0 7173.3 7237.6 7343.5 948.8 974.1 975.0 998.5 1036.5 27932.7 28350.3 28878.1 28923.7 29096.4 1022.0 1038.3 1081.6 1084.4 1097.7 14197.3 14202.8 14266.2 14391.0 14622.3 329838.0 332332.0 334217.0 336053.0 337477.0 45847.3 46078.0 46287.3 46484.3 46562.5 1238.7 1244.8 1264.5 1271.9 1275.5 24909.5 26794.6 26824.7 26894.3 27060.1 40490.4 46574.3 48606.5 48608.0 48611.0 309867.0 314162.0 316264.0 317940.0 318469.0 38290.2 38439.2 38463.0 38660.6 38914.2 42748.0 42919.4 43240.1 43565.6 43922.8 36450.0 37140.6 37583.0 37585.2 37782.0 35898.8 36582.3 37160.6 37282.6 37306.8 31643.7 36346.0 36930.6 37230.3 37688.6 29105.1 32756.3 35977.8 36349.6 36732.6 24956.0 25204.0 25613.0 25641.4 25780.1 17:12:04 INFO - PROCESS | 4122 | 17:12:04 INFO - PROCESS | 4122 | [#2] jquery.html Cycles:180 Average:22924.56 Median:5137.43 stddev:59610.38 (1160.3%) stddev-sans-first:59753.58 17:12:04 INFO - PROCESS | 4122 | Values: 385.7 386.3 388.5 394.5 406.7 15239.5 16196.2 16649.4 16653.9 16681.0 15152.5 15688.2 16076.2 16131.6 16132.5 4996.9 5111.5 5162.1 5164.6 5188.8 3638.9 5511.4 5845.9 5846.0 5850.1 5568.6 5739.7 5785.0 5795.5 5805.4 5696.1 5736.3 5768.1 5771.7 5777.7 4912.6 5120.7 5137.2 5137.7 5211.0 11025.5 11756.6 19881.8 20056.3 20131.8 1796.5 1827.8 1890.3 2099.9 2146.4 8947.7 9049.2 9232.9 9418.2 9463.4 1703.9 1761.3 1801.8 1813.8 1844.3 64186.0 67117.0 67591.0 68616.7 68774.0 10160.8 10213.4 10217.4 10237.2 10342.4 14193.6 14294.4 14313.3 14314.1 14336.7 7098.8 7555.6 7576.7 7613.7 7732.2 7205.5 7233.1 7393.9 7399.9 7432.8 4320.1 4358.7 4423.3 4488.5 4502.6 1707.4 1760.2 1839.0 1884.9 1887.5 867.1 896.7 900.5 939.9 960.9 16256.3 16473.5 16495.8 16564.9 16850.2 878.3 897.8 917.2 939.5 959.2 8705.1 8947.5 9240.9 9392.9 9402.6 332736.0 336688.0 337220.0 391294.0 394463.0 78117.0 79318.6 80489.2 81519.6 81582.6 1015.2 1025.1 1033.7 1051.3 1053.0 13967.4 14423.7 14674.9 14990.7 15083.8 31361.5 31730.0 34301.9 35123.3 37104.0 44142.6 46043.5 46063.3 46177.3 46236.5 7178.4 7348.3 7365.1 7392.5 7463.5 9567.8 10771.2 10805.0 10839.5 10918.9 8829.0 9190.7 9231.0 9337.2 9468.2 8777.8 9118.1 9260.4 9418.9 9478.3 9544.3 9597.6 9628.2 9827.3 10139.7 6189.3 6708.0 6791.0 6905.3 6940.2 8047.7 9053.7 9255.8 9306.0 9396.1 17:12:04 INFO - PROCESS | 4122 | 17:12:04 INFO - PROCESS | 4122 | [#3] mootools.html Cycles:180 Average:5176.99 Median:5374.99 stddev:2872.89 (53.4%) stddev-sans-first:2867.07 17:12:04 INFO - PROCESS | 4122 | Values: 1418.3 1472.9 1618.1 1747.0 1807.8 6943.7 7304.4 7566.9 7576.1 7591.4 7697.1 7715.9 7732.7 7796.6 7812.9 2238.1 2257.9 2272.2 2273.9 2275.3 2220.5 2222.1 2238.5 2245.1 2246.7 2104.7 2108.8 2127.1 2146.1 2183.7 2131.8 2133.8 2140.5 2145.9 2153.8 2098.8 2110.1 2119.5 2131.6 2134.2 7917.5 7927.0 7942.4 8008.2 8021.9 4622.6 4765.2 4773.2 4791.4 4797.2 2974.4 2982.7 3098.1 3116.8 3140.8 898.8 919.8 938.0 939.0 942.2 10565.2 10661.2 10673.4 10679.5 10700.1 4074.5 4163.0 4315.7 4345.3 4379.6 9154.4 9178.6 9189.7 9191.9 9203.4 4761.3 4766.0 4767.4 4780.3 4782.8 3758.8 4145.4 4272.3 4279.1 4318.4 3612.7 3686.4 3693.6 3711.0 3752.5 1191.4 1214.8 1217.1 1230.8 1231.6 694.6 755.2 842.8 852.9 866.6 5176.3 5182.8 5234.1 5308.7 5356.5 849.3 915.5 930.0 953.7 964.2 3510.0 3791.7 3801.6 3816.4 3824.0 9522.8 9865.9 9929.7 9979.6 9995.4 9656.9 9725.2 9731.0 9877.9 9888.0 7144.5 7265.3 7276.1 7333.7 7425.1 5303.9 5393.5 5410.1 5445.8 5567.5 8791.3 8853.2 8955.9 8991.7 9105.1 8477.8 8819.3 8833.0 8863.3 8967.4 6196.0 6589.6 6795.4 6853.9 6981.1 7521.7 7543.0 7565.6 7613.7 7621.6 6554.6 6763.2 6810.9 6882.5 7009.7 6846.7 6896.2 6897.7 6951.3 7057.1 6003.8 6062.5 6072.2 6109.4 6218.0 4680.8 4697.3 4704.8 4718.9 4753.7 4400.6 4442.4 4478.8 4554.3 4556.5 17:12:04 INFO - PROCESS | 4122 | 17:12:04 INFO - PROCESS | 4122 | [#4] prototype.html Cycles:180 Average:4641.63 Median:5318.34 stddev:1367.77 (25.7%) stddev-sans-first:1332.42 17:12:04 INFO - PROCESS | 4122 | Values: 310.8 318.1 323.5 328.0 328.6 5134.5 5278.5 5315.7 5317.9 5379.9 5358.3 5360.4 5371.3 5385.9 5387.9 4174.6 4190.3 4190.7 4190.7 4207.2 3928.7 4154.9 4200.4 4220.4 4233.6 4098.0 4098.2 4103.9 4107.4 4108.5 4070.6 4092.4 4092.8 4102.3 4118.9 3591.4 3592.7 3596.9 3597.7 3624.5 5040.6 5090.5 5101.5 5111.3 5122.6 4679.0 4686.0 4697.5 4702.8 4725.7 5510.7 5551.9 5557.1 5558.9 5587.0 3772.2 3921.3 3922.0 3922.1 3933.4 5828.8 5902.7 5915.8 5929.2 5931.0 4024.9 4029.8 4041.8 4051.0 4053.6 4015.4 4064.1 4095.7 4107.0 4117.0 4665.8 4683.2 4694.5 4695.7 4724.7 5318.7 5490.5 5565.6 5565.9 5621.8 1359.7 1400.3 1406.5 1406.8 1411.0 921.1 924.8 944.3 949.2 958.5 4847.0 4865.5 4898.7 4903.9 4930.6 5691.7 5713.2 5727.5 5748.3 5749.7 4736.0 4886.0 4888.3 4895.2 4914.3 3053.3 3058.4 3071.0 3081.1 3095.0 5381.8 5406.3 5408.0 5410.0 5411.1 5675.5 5918.8 6023.7 6032.7 6040.7 5509.6 5513.6 5525.1 5567.4 5570.2 5719.3 5817.3 5847.2 5865.9 5874.3 5735.6 5744.7 5745.7 5749.7 5764.0 5474.6 5500.4 5502.9 5508.4 5544.6 3963.0 3994.4 3997.2 4037.5 4050.2 5535.6 5614.5 5835.6 5847.7 5883.0 5618.9 5634.9 5647.5 5662.6 5673.0 5611.0 5622.6 5638.2 5638.7 5641.4 5235.1 5539.4 5563.8 5582.6 5603.0 5613.2 5634.8 5646.9 5648.3 5674.1 5245.9 5546.9 5548.3 5549.0 5574.0 17:12:04 INFO - PROCESS | 4122 | 17:12:04 INFO - PROCESS | 4122 | [#5] yui.html Cycles:180 Average:12357.82 Median:21261.32 stddev:13933.53 (65.5%) stddev-sans-first:13944.91 17:12:04 INFO - PROCESS | 4122 | Values: 657.9 775.5 790.9 796.5 803.3 11433.1 11589.0 11762.1 11777.5 11788.1 13398.1 13885.0 13949.6 13957.3 13986.7 648.5 807.4 827.4 830.7 834.1 800.3 821.4 823.0 826.5 827.4 840.0 848.8 852.0 854.3 856.6 847.2 849.5 850.9 852.7 855.8 628.0 629.4 632.1 633.1 633.2 12284.4 12298.2 12309.1 12354.3 12393.0 11231.7 11795.4 11877.5 12205.8 12263.4 10789.6 10931.9 10968.5 11019.8 11267.1 3262.1 3281.5 3323.4 3327.7 3335.4 47978.3 48168.0 48177.5 48337.8 48847.8 9656.1 9747.2 9750.0 9761.8 9768.1 15690.2 15848.1 15874.9 15891.2 16004.3 6410.6 6440.1 6510.9 6539.1 6597.3 3532.5 3577.8 3598.3 3646.3 3664.8 2901.6 2979.8 2983.8 2985.2 2987.6 493.8 528.7 549.7 551.9 560.7 601.5 644.0 655.6 661.8 668.3 7520.8 7561.2 7983.2 8157.1 8199.5 651.9 653.1 654.3 659.2 659.5 3654.4 3752.7 3758.8 3843.7 3874.4 53844.5 54028.7 54246.7 54812.7 55028.0 22772.0 22995.4 23011.7 47359.0 48342.3 37505.0 38457.4 40936.0 45112.3 45306.3 7953.5 8062.2 8064.6 8099.5 8298.9 26494.5 26718.6 27122.9 27169.0 27302.6 32454.0 36422.6 37591.4 37823.0 38648.2 10307.9 10566.9 10618.9 10628.1 10680.5 11360.4 11367.1 11499.2 11619.0 11635.1 11213.7 11242.8 11546.8 11786.7 11935.6 11338.2 11525.0 11781.2 11966.2 12032.2 10206.7 10419.3 10462.9 10591.2 10740.2 9501.0 9530.5 9558.8 9621.2 9625.7 9729.7 9896.7 9903.0 10015.6 10032.9 17:12:04 INFO - PROCESS | 4122 | -------- Summary: end -------- 17:12:04 INFO - PROCESS | 4122 | 17:12:05 INFO - TEST-INFO | 4122: exit 0 17:12:05 INFO - TEST-OK | dromaeo_css | took 1115055ms 17:12:05 INFO - TEST-START | kraken 17:12:05 INFO - operating with platform_type : linux_ 17:12:05 INFO - Initialising browser for kraken test... 17:12:05 INFO - TEST-INFO | started process 4354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUFgHUw/profile http://localhost:52585/getInfo.html) 17:12:09 INFO - PROCESS | 4354 | 17:12:09 INFO - PROCESS | 4354 | (process:4422): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:12:09 INFO - PROCESS | 4354 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:12:10 INFO - PROCESS | 4354 | __metrics Screen width/height:1600/1200 17:12:10 INFO - PROCESS | 4354 | colorDepth:24 17:12:10 INFO - PROCESS | 4354 | Browser inner width/height: 1024/697 17:12:10 INFO - PROCESS | 4354 | __metrics 17:12:10 ERROR - PROCESS | 4354 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:12:11 INFO - TEST-INFO | 4354: exit 0 17:12:11 INFO - Browser initialized. 17:12:11 INFO - Running cycle 1/1 for kraken test... 17:12:11 INFO - TEST-INFO | started process 4473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUFgHUw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:13 INFO - PROCESS | 4473 | 17:12:13 INFO - PROCESS | 4473 | (process:4533): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:12:23 INFO - PROCESS | 4473 | RSS: Main: 164507648 17:12:23 INFO - PROCESS | 4473 | 17:12:26 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:52585/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52585/tests/kraken/driver.html?testName=audio-beat-detection) 17:12:27 INFO - PROCESS | 4473 | RSS: Main: 168648704 17:12:27 INFO - PROCESS | 4473 | 17:12:30 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:52585/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52585/tests/kraken/driver.html?testName=audio-dft) 17:12:30 INFO - PROCESS | 4473 | RSS: Main: 172224512 17:12:30 INFO - PROCESS | 4473 | 17:12:33 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:52585/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52585/tests/kraken/driver.html?testName=audio-fft) 17:12:34 INFO - PROCESS | 4473 | RSS: Main: 163254272 17:12:34 INFO - PROCESS | 4473 | 17:12:36 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:52585/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52585/tests/kraken/driver.html?testName=audio-oscillator) 17:12:37 INFO - PROCESS | 4473 | RSS: Main: 163651584 17:12:37 INFO - PROCESS | 4473 | 17:12:39 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:52585/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52585/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:12:40 INFO - PROCESS | 4473 | RSS: Main: 164020224 17:12:40 INFO - PROCESS | 4473 | 17:12:43 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:52585/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52585/tests/kraken/driver.html?testName=imaging-darkroom) 17:12:44 INFO - PROCESS | 4473 | RSS: Main: 164257792 17:12:44 INFO - PROCESS | 4473 | 17:12:47 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:52585/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52585/tests/kraken/driver.html?testName=imaging-desaturate) 17:12:48 INFO - PROCESS | 4473 | RSS: Main: 164036608 17:12:48 INFO - PROCESS | 4473 | 17:12:51 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:52585/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52585/tests/kraken/driver.html?testName=json-parse-financial) 17:12:51 INFO - PROCESS | 4473 | RSS: Main: 164626432 17:12:51 INFO - PROCESS | 4473 | 17:12:53 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:52585/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52585/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:12:54 INFO - PROCESS | 4473 | RSS: Main: 164626432 17:12:54 INFO - PROCESS | 4473 | 17:12:55 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:52585/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52585/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:12:56 INFO - PROCESS | 4473 | RSS: Main: 164888576 17:12:56 INFO - PROCESS | 4473 | 17:12:58 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:52585/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52585/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:12:59 INFO - PROCESS | 4473 | RSS: Main: 165097472 17:12:59 INFO - PROCESS | 4473 | 17:13:02 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:52585/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:13:02 INFO - PROCESS | 4473 | RSS: Main: 165081088 17:13:02 INFO - PROCESS | 4473 | 17:13:05 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:52585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:13:06 INFO - PROCESS | 4473 | RSS: Main: 165445632 17:13:06 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:52585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52585/tests/kraken/driver.html?testName=ai-astar) 17:13:08 INFO - PROCESS | 4473 | RSS: Main: 167002112 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | __start_tp_report 17:13:08 INFO - PROCESS | 4473 | _x_x_mozilla_page_load 17:13:08 INFO - PROCESS | 4473 | _x_x_mozilla_page_load_details 17:13:08 INFO - PROCESS | 4473 | |i|pagename|runs| 17:13:08 INFO - PROCESS | 4473 | |0;ai-astar;117;114;115;114;116;126;114;115;116;112 17:13:08 INFO - PROCESS | 4473 | |1;audio-beat-detection;157;137;152;196;133;164;161;139;191;138 17:13:08 INFO - PROCESS | 4473 | |2;audio-dft;163;165;166;177;165;162;164;164;167;162 17:13:08 INFO - PROCESS | 4473 | |3;audio-fft;77;74;72;162;75;75;74;77;155;75 17:13:08 INFO - PROCESS | 4473 | |4;audio-oscillator;94;94;140;95;94;94;150;95;94;144 17:13:08 INFO - PROCESS | 4473 | |5;imaging-gaussian-blur;117;117;117;118;118;118;117;117;118;118 17:13:08 INFO - PROCESS | 4473 | |6;imaging-darkroom;147;147;151;148;147;146;147;147;147;148 17:13:08 INFO - PROCESS | 4473 | |7;imaging-desaturate;95;96;95;96;96;95;95;96;96;95 17:13:08 INFO - PROCESS | 4473 | |8;json-parse-financial;69;68;67;65;74;67;71;88;69;65 17:13:08 INFO - PROCESS | 4473 | |9;json-stringify-tinderbox;65;65;66;65;64;65;64;67;65;64 17:13:08 INFO - PROCESS | 4473 | |10;stanford-crypto-aes;82;81;87;80;89;90;82;81;82;80 17:13:08 INFO - PROCESS | 4473 | |11;stanford-crypto-ccm;137;135;148;154;134;145;138;148;176;145 17:13:08 INFO - PROCESS | 4473 | |12;stanford-crypto-pbkdf2;186;174;175;183;179;175;180;179;178;181 17:13:08 INFO - PROCESS | 4473 | |13;stanford-crypto-sha256-iterative;73;73;76;83;78;76;73;74;73;75 17:13:08 INFO - PROCESS | 4473 | __end_tp_report 17:13:08 INFO - PROCESS | 4473 | __start_cc_report 17:13:08 INFO - PROCESS | 4473 | _x_x_mozilla_cycle_collect,918 17:13:08 INFO - PROCESS | 4473 | __end_cc_report 17:13:08 INFO - PROCESS | 4473 | __startTimestamp1460765588691__endTimestamp 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | ------- Summary: start ------- 17:13:08 INFO - PROCESS | 4473 | Number of tests: 14 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | [#0] ai-astar Cycles:10 Average:115.90 Median:115.50 stddev:3.81 (3.3%) stddev-sans-first:4.02 17:13:08 INFO - PROCESS | 4473 | Values: 117.0 114.0 115.0 114.0 116.0 126.0 114.0 115.0 116.0 112.0 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | [#1] audio-beat-detection Cycles:10 Average:156.80 Median:159.00 stddev:22.18 (13.9%) stddev-sans-first:23.53 17:13:08 INFO - PROCESS | 4473 | Values: 157.0 137.0 152.0 196.0 133.0 164.0 161.0 139.0 191.0 138.0 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:4.35 (2.6%) stddev-sans-first:4.52 17:13:08 INFO - PROCESS | 4473 | Values: 163.0 165.0 166.0 177.0 165.0 162.0 164.0 164.0 167.0 162.0 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | [#3] audio-fft Cycles:10 Average:91.60 Median:75.00 stddev:35.33 (47.1%) stddev-sans-first:37.07 17:13:08 INFO - PROCESS | 4473 | Values: 77.0 74.0 72.0 162.0 75.0 75.0 74.0 77.0 155.0 75.0 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:94.00 stddev:24.45 (26.0%) stddev-sans-first:25.30 17:13:08 INFO - PROCESS | 4473 | Values: 94.0 94.0 140.0 95.0 94.0 94.0 150.0 95.0 94.0 144.0 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:13:08 INFO - PROCESS | 4473 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 17:13:08 INFO - PROCESS | 4473 | Values: 147.0 147.0 151.0 148.0 147.0 146.0 147.0 147.0 147.0 148.0 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:13:08 INFO - PROCESS | 4473 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | [#8] json-parse-financial Cycles:10 Average:70.30 Median:69.00 stddev:6.78 (9.8%) stddev-sans-first:7.18 17:13:08 INFO - PROCESS | 4473 | Values: 69.0 68.0 67.0 65.0 74.0 67.0 71.0 88.0 69.0 65.0 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 17:13:08 INFO - PROCESS | 4473 | Values: 65.0 65.0 66.0 65.0 64.0 65.0 64.0 67.0 65.0 64.0 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.00 stddev:3.78 (4.6%) stddev-sans-first:3.97 17:13:08 INFO - PROCESS | 4473 | Values: 82.0 81.0 87.0 80.0 89.0 90.0 82.0 81.0 82.0 80.0 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:146.50 stddev:12.40 (8.5%) stddev-sans-first:12.72 17:13:08 INFO - PROCESS | 4473 | Values: 137.0 135.0 148.0 154.0 134.0 145.0 138.0 148.0 176.0 145.0 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:179.50 stddev:3.77 (2.1%) stddev-sans-first:3.03 17:13:08 INFO - PROCESS | 4473 | Values: 186.0 174.0 175.0 183.0 179.0 175.0 180.0 179.0 178.0 181.0 17:13:08 INFO - PROCESS | 4473 | 17:13:08 INFO - PROCESS | 4473 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:75.50 stddev:3.17 (4.2%) stddev-sans-first:3.24 17:13:08 INFO - PROCESS | 4473 | Values: 73.0 73.0 76.0 83.0 78.0 76.0 73.0 74.0 73.0 75.0 17:13:08 INFO - PROCESS | 4473 | -------- Summary: end -------- 17:13:08 INFO - PROCESS | 4473 | 17:13:09 INFO - TEST-INFO | 4473: exit 0 17:13:09 INFO - TEST-OK | kraken | took 64488ms 17:13:09 INFO - SUITE-END | took 1179s 17:13:09 INFO - Completed test suite (00:19:39) 17:13:09 INFO - javascript benchmark 17:13:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.7006894207166, 2669.2526092694047, 2706.688730795959, 2710.0, 2721.374083960689, 4696.483386827451, 4704.247320428732, 4705.576498115169, 4712.835050773219, 4742.715437073778, 4612.146752850725, 4710.458297295812, 4722.05558888222, 4769.141554520185, 4769.165396055694, 4271.466066741649, 4312.97843510782, 4355.273545139043, 4402.449693788277, 4423.358613001113, 4340.327249276367, 4348.717333373321, 4397.406350142722, 4402.25161722508, 4447.4218351614245, 4212.304969679999, 4295.484541854998, 4334.978325108385, 4340.0, 4366.279563871989, 4308.719933204332, 4348.391225228471, 4357.607815296638, 4364.083542456088, 4380.452443444569, 4317.654587632982, 4329.177456283296, 4336.674749393776, 4344.9348259776125, 4373.584509471595, 4407.581279778416, 4581.816727330903, 4653.418322709661, 4655.138799322102, 4673.649476289258, 5024.598032157419, 5027.572656324217, 5028.974855125737, 5049.318342023853, 5102.183650615883, 5079.74601269935, 5080.695158290478, 5090.2364645303505, 5096.79612815487, 5102.897942041175, 4705.12955103307, 4729.763511824463, 4730.787114579852, 4771.0934922364295, 4791.353167322437, 5188.299579556711, 5201.375834899761, 5206.088934436534, 5208.427073021964, 5266.368035835648, 4914.852554423373, 4970.44840680533, 4987.401511818605, 4995.600351971833, 5018.121828679967, 4793.712377257376, 5030.245463180552, 5033.949660503348, 5045.949540504548, 5081.060003899291, 5006.549410553068, 5018.673786203885, 5020.171671674133, 5021.121303771825, 5066.03745288394, 4840.104580652591, 4978.651494395358, 4991.226359914219, 5004.0, 5043.117454445457, 4252.4046633471335, 4255.489341279066, 4256.9574304257185, 4296.699231053859, 4301.333293339538, 3718.758280711745, 3720.7729900915215, 3722.050877026341, 3758.229562939591, 3762.9247415051545, 4366.432363792686, 4394.055278115156, 4470.374147619336, 4472.396226509444, 4477.238869392211, 5087.058894104603, 5093.414257360377, 5093.414257360377, 5096.362954630671, 5113.488651134857, 4438.511763705989, 4445.110977804387, 4445.110977804452, 4470.329450582439, 4493.258612328929, 4383.7808109595035, 4465.598096171295, 4519.728816271035, 4533.138703646297, 4538.387317712067, 4822.71063736177, 4837.927431088537, 4848.981713840062, 4851.36932198819, 4856.757162141949, 5118.334616499831, 5123.846284611468, 5156.716380599103, 5179.093658609803, 5180.844574662766, 4625.352450656978, 4749.382580264543, 4808.447028591757, 4812.590929771009, 4864.173090574682, 5001.64988450805, 5008.724520151427, 5010.749462526786, 5013.724245166551, 5068.239764035424, 4869.707817530818, 5089.262057001788, 5096.23556466533, 5109.310243117132, 5137.563307118937, 4721.881952951204, 4884.535969082932, 4886.706797592155, 4997.250412438163, 5016.698998060128, 4919.557239848431, 4940.407151141886, 4951.678140920829, 4954.405471343462, 4989.052080104769, 4597.586217240464, 4865.197242454955, 4868.367112275523, 4871.098846713369, 4926.778294976663, 4969.0, 5013.699178049329, 5020.598352131748, 5032.245163225545, 5068.29043933857, 4860.222364421676, 4882.487338829514, 4907.705537667752, 4911.115999120049, 4927.679700819435], "value": 4649.592914443383, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.3031447106238, 592.8636413624866, 597.4324391827764, 611.3275397063229, 633.183193680153, 33958.32083358335, 34037.319253614914, 34319.65680343196, 34521.654783452155, 34642.65357346426, 36227.456588151195, 36998.81500592493, 37140.44289335662, 37288.81355593225, 37344.43983340252, 7573.24267573241, 7722.073351197864, 7791.376689864797, 7814.023247094114, 7816.726414575491, 7663.386929045663, 7732.536047837119, 7744.612769361537, 7775.222477752208, 7795.5712435816, 7783.883241751379, 7802.687892484294, 7821.335186509154, 7844.529328240295, 7870.488418252824, 7738.574378409186, 7739.187385324544, 7747.8450430991625, 7795.33739632132, 7803.570803605771, 7790.259925307087, 7889.500994810967, 7891.763247102596, 7893.842123157562, 7908.130105688369, 37345.62654373476, 37563.24873502515, 37796.0, 38031.42952855709, 38222.808885955674, 3127.5465057566753, 3196.744260459158, 3326.168457885529, 3692.1138926657677, 3934.3311637021775, 28352.291192720142, 28734.856325718447, 28986.0, 29372.559411608843, 29563.26091847721, 3532.947005794915, 3574.338747331752, 3576.356255873942, 3607.4047782115917, 3609.4501607557813, 226311.0, 226481.0, 227066.0, 227971.0, 228087.0, 52448.0, 52544.21183682248, 52955.0, 53011.46988530143, 53067.0, 55711.0, 56088.0, 58291.879352668206, 59591.0, 59958.40041599528, 15439.228038598025, 15503.922480387751, 15572.766408503881, 15701.764473532907, 15710.528684139494, 11973.0, 12084.093692973061, 12169.148159628741, 12187.0, 12224.877751222373, 17928.372506962194, 18017.459476215736, 18096.547586310448, 18114.728279075825, 18316.63366732658, 7027.648617569101, 7099.0, 7173.318534739192, 7237.552489502121, 7343.48595598303, 948.7628092976756, 974.1232890398697, 975.0493269062607, 998.5257002923698, 1036.5387402605768, 27932.720672793417, 28350.291242719097, 28878.133655990354, 28923.710762892522, 29096.418071638447, 1022.0494939706144, 1038.3302769713644, 1081.605214096849, 1084.4415126210008, 1097.6871591596357, 14197.290135493184, 14202.786958195635, 14266.215358155401, 14391.0, 14622.26888655563, 329838.0, 332332.0, 334217.0, 336053.0, 337477.0, 45847.31229031567, 46078.0, 46287.30569041467, 46484.302735458994, 46562.5343746565, 1238.7274799544086, 1244.807054906491, 1264.4942023190613, 1271.9364031798373, 1275.515304184404, 24909.501809963338, 26794.59808102919, 26824.731752683005, 26894.32764180911, 27060.052898149257, 40490.39264410977, 46574.30138547857, 48606.513934860195, 48608.0, 48611.0, 309867.0, 314162.0, 316264.0, 317940.0, 318469.0, 38290.23419531538, 38439.23121537497, 38463.0, 38660.6133938657, 38914.22171556496, 42748.0, 42919.35620965625, 43240.135197296506, 43565.56434435615, 43922.78038609787, 36450.0, 37140.6285937148, 37583.0, 37585.24829503449, 37782.0, 35898.8205058973, 36582.26835463329, 37160.6283937168, 37282.62717372792, 37306.81346593249, 31643.683563164075, 36346.0, 36930.63069369272, 37230.25539489249, 37688.62311376851, 29105.12684619465, 32756.34487310288, 35977.82011089928, 36349.63650363568, 36732.632673673994, 24956.0, 25204.0, 25613.0, 25641.358966026, 25780.09769658053], "value": 17870.33983066369, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.7454080306996, 386.3123639920941, 388.54928283191504, 394.5344493497673, 406.68075560684866, 15239.466618668348, 16196.155997762342, 16649.417270395537, 16653.916730416346, 16681.0, 15152.545423637308, 15688.215589220521, 16076.196190190472, 16131.596710082255, 16132.516024519284, 4996.850094497171, 5111.488851114896, 5162.1224391853475, 5164.6384753067305, 5188.844334669966, 3638.890833275006, 5511.366192887809, 5845.85385365365, 5845.970770146143, 5850.0932355484965, 5568.610197286192, 5739.684317362543, 5785.0, 5795.4784069433745, 5805.390434004432, 5696.11710184922, 5736.311642602873, 5768.105943578731, 5771.682557459338, 5777.740001699934, 4912.631552633567, 5120.667156634807, 5137.152369858969, 5137.717425541594, 5211.0359583477175, 11025.503852326665, 11756.588519401865, 19881.80118198814, 20056.29802956904, 20131.798682013137, 1796.4790210838842, 1827.8354948054605, 1890.3194849854042, 2099.9475013124643, 2146.399008277685, 8947.731568052968, 9049.2308153807, 9232.8615070774, 9418.19945304643, 9463.432194068379, 1703.9318427262895, 1761.3130878957218, 1801.8288262615163, 1813.8004819469847, 1844.2807305151002, 64186.0, 67117.0, 67591.0, 68616.6569167156, 68774.0, 10160.847587286196, 10213.438260895573, 10217.438040907673, 10237.23220758446, 10342.431166285776, 14193.574192774027, 14294.428222870969, 14313.28433578317, 14314.141151530941, 14336.713265734836, 7098.751543695946, 7555.622218889143, 7576.7348142814735, 7613.695452181962, 7732.226777322223, 7205.4595905307315, 7233.132024157135, 7393.927880457411, 7399.926000740032, 7432.777016689508, 4320.135972805451, 4358.694891357574, 4423.270160423558, 4488.483824360175, 4502.57225563571, 1707.3597400974634, 1760.2079064421062, 1838.9540261493569, 1884.8963307018246, 1887.4620733091003, 867.089555966233, 896.6771962093771, 900.4507250577143, 939.8825146856643, 960.9381633295109, 16256.349746010264, 16473.505794826175, 16495.83504164967, 16564.917175414044, 16850.241739121768, 878.3149143667949, 897.8473659477904, 917.2295271971576, 939.4598106089027, 959.1607343574373, 8705.12948705137, 8947.460376887559, 9240.8613870792, 9392.906070939203, 9402.576884040234, 332736.0, 336688.0, 337220.0, 391294.0, 394463.0, 78117.0, 79318.6034069826, 80489.19510804935, 81519.59240203879, 81582.59208703919, 1015.1777060580953, 1025.1183981775666, 1033.7312298802215, 1051.2536099369534, 1053.015430572402, 13967.371468283749, 14423.711525769217, 14674.853251467348, 14990.700185996437, 15083.773743393638, 31361.52957705682, 31730.0, 34301.912827844615, 35123.29753404867, 37104.0, 44142.558574413844, 46043.539564603925, 46063.309050364944, 46177.30734038925, 46236.53763462457, 7178.389836863925, 7348.265173482609, 7365.079365079365, 7392.4825262231125, 7463.477556571205, 9567.808643826946, 10771.19216058783, 10805.0, 10839.458027098772, 10918.890811091787, 8829.0, 9190.678326258549, 9230.953845230732, 9337.159655631025, 9468.195203407788, 8777.824443510966, 9118.133777291147, 9260.351775375659, 9418.858717119112, 9478.336516444058, 9544.33189676716, 9597.616095356387, 9628.18160456369, 9827.262955278526, 10139.7465063374, 6189.257289125154, 6708.0, 6791.049253104668, 6905.274946130584, 6940.201876784033, 8047.678092876454, 9053.728388148365, 9255.76860578491, 9305.976342602444, 9396.060393960823], "value": 8023.888679548399, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.3192067807452, 1472.9410823567057, 1618.1342981504897, 1746.9563260918483, 1807.755952946352, 6943.722251109963, 7304.415646748261, 7566.924330756691, 7576.090869095702, 7591.430642701799, 7697.076350837908, 7715.884261736079, 7732.729354472594, 7796.649150788214, 7812.882806757889, 2238.1383167480476, 2257.9435514112197, 2272.1820144747876, 2273.943151421219, 2275.283285764987, 2220.544788318391, 2222.055626358799, 2238.541099074694, 2245.079517397867, 2246.696695946051, 2104.6632538793797, 2108.8312934965243, 2127.064091799611, 2146.1415433826514, 2183.727034120735, 2131.7761635028332, 2133.829293656504, 2140.464883779055, 2145.9463513412134, 2153.8061574458375, 2098.7586427560873, 2110.0610228448345, 2119.5442979759273, 2131.5630295789483, 2134.17834133858, 7917.485363451357, 7927.048754149481, 7942.444028917978, 8008.158123631597, 8021.879671804928, 4622.6070783983405, 4765.237561990065, 4773.236282194832, 4791.401074865642, 4797.18447863864, 2974.3902499987453, 2982.6569944456446, 3098.148009297439, 3116.781825272232, 3140.811551306906, 898.806756547339, 919.8022425178552, 937.9906200937971, 939.0327962198946, 942.1567696911226, 10565.154787616972, 10661.200409969284, 10673.412962287071, 10679.519421626046, 10700.143988480902, 4074.5314288856566, 4162.958370416257, 4315.6763242756915, 4345.283028300295, 4379.562043795595, 9154.359194856295, 9178.586963586655, 9189.724308270763, 9191.908080919238, 9203.40177888435, 4761.285807128958, 4766.022965292107, 4767.427908650984, 4780.282957556325, 4782.808687652525, 3758.830852611639, 4145.440365550612, 4272.316429371285, 4279.144171165779, 4318.352247162888, 3612.692921101683, 3686.447032945026, 3693.575238847513, 3711.0, 3752.5309336332957, 1191.386435985468, 1214.8481439820023, 1217.075022982522, 1230.8153776933532, 1231.6305108467425, 694.5971336624847, 755.199488542147, 842.839860426517, 852.8507511185642, 866.5710473315623, 5176.327077479904, 5182.792688292426, 5234.0840352938085, 5308.654937429054, 5356.517913387814, 849.3417601358997, 915.4507295622573, 929.9628014879464, 953.6709835106877, 964.2093483343591, 3510.008387887645, 3791.6777073949024, 3801.6008319126645, 3816.3893776995546, 3823.9808800956375, 9522.809543809224, 9865.852012219822, 9929.65246216379, 9979.600815967426, 9995.400275983318, 9656.903430965742, 9725.221982241404, 9731.0, 9877.901220987842, 9887.950560247296, 7144.499885008104, 7265.346118849223, 7276.126864776154, 7333.706651733871, 7425.1461081975185, 5303.946960530346, 5393.460653934575, 5410.080286351408, 5445.83662490126, 5567.526760225426, 8791.252743516872, 8853.203211710977, 8955.910440895508, 8991.685291015045, 9105.135012173832, 8477.788055298666, 8819.250363719155, 8833.0, 8863.290936725176, 8967.417117887577, 6195.969020155051, 6589.6375699336995, 6795.422389096784, 6853.93763966586, 6981.057557229912, 7521.699132034657, 7542.962285188759, 7565.583892885724, 7613.733519326797, 7621.580813055335, 6554.639494827639, 6763.222229443677, 6810.897836532356, 6882.483813714091, 7009.719611215494, 6846.726130954706, 6896.172459304916, 6897.7240910365035, 6951.304869513008, 7057.082579264663, 6003.7898673546215, 6062.454379105901, 6072.180255665606, 6109.419605137505, 6218.036204388327, 4680.7893644786745, 4697.271922851964, 4704.835330763407, 4718.882027949328, 4753.714777113384, 4400.625946794558, 4442.42248507692, 4478.753668548261, 4554.339620754906, 4556.544345565417], "value": 4186.137741902695, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.8476846345292, 318.0728177362987, 323.49534725827704, 327.98360081995895, 328.6220846027067, 5134.537891589756, 5278.524932756051, 5315.707636080014, 5317.946820531798, 5379.865503362413, 5358.276632654591, 5360.437154098822, 5371.274877891484, 5385.892282154355, 5387.865303367418, 4174.561671024537, 4190.287651099306, 4190.664746820263, 4190.685698572604, 4207.221663992156, 3928.7249892507534, 4154.896127596804, 4200.369944508333, 4220.388043733657, 4233.576642335757, 4097.955021469521, 4098.159877225162, 4103.8974025649295, 4107.445494858201, 4108.5275193352845, 4070.5522392536795, 4092.406601042847, 4092.774897380643, 4102.302608556538, 4118.876433706963, 3591.3535563598543, 3592.6586974237407, 3596.8741094061584, 3597.712183025352, 3624.52881125452, 5040.571551418134, 5090.490950904917, 5101.540861322499, 5111.309973153614, 5122.615803814729, 4678.976605116953, 4686.0, 4697.4832768395445, 4702.835400760991, 4725.716457012556, 5510.6969116698565, 5551.916721249185, 5557.1108622620595, 5558.888822223574, 5587.0, 3772.1512659651635, 3921.3333733265413, 3921.960780392188, 3922.0979174789672, 3933.4296527003426, 5828.825135245907, 5902.734376953047, 5915.792947246826, 5929.199558059693, 5931.0, 4024.879253622396, 4029.7985100744845, 4041.837616874958, 4050.959490405058, 4053.635172834459, 4015.377616469452, 4064.1262128641893, 4095.692823038284, 4107.034846810997, 4116.9826784875195, 4665.790039448233, 4683.180443422388, 4694.460137084211, 4695.741734204583, 4724.740139292303, 5318.73406329682, 5490.505854473116, 5565.582581306418, 5565.916511252334, 5621.775128994795, 1359.6872719274425, 1400.2718586335252, 1406.4514839212716, 1406.8100806391005, 1410.9506167284096, 921.1019256225127, 924.7734305095295, 944.3389627260945, 949.1742184299703, 958.4584709639032, 4846.95153048465, 4865.513448655106, 4898.681585696918, 4903.8528844134735, 4930.605551555867, 5691.658500489983, 5713.171590119409, 5727.541796656257, 5748.281464816898, 5749.741261643152, 4736.0, 4886.047220791983, 4888.315635810989, 4895.216765317532, 4914.336564563738, 3053.328267781085, 3058.4189004089153, 3071.0479751277176, 3081.0910781319117, 3094.98452507736, 5381.7578208980685, 5406.324209473816, 5407.972960135174, 5409.972950135224, 5411.107167317348, 5675.460831221028, 5918.822435326861, 6023.668698221552, 6032.733126043492, 6040.667763272974, 5509.614326997072, 5513.641613295204, 5525.099322855453, 5567.359753628384, 5570.248016517799, 5719.3136823581435, 5817.331006934257, 5847.210626565529, 5865.912011319919, 5874.324452687824, 5735.598508104393, 5744.655320680772, 5745.6552606843725, 5749.741261643152, 5763.97118014424, 5474.644148130359, 5500.4499550044675, 5502.9174562380795, 5508.44915508446, 5544.584156188222, 3963.0, 3994.380870965005, 3997.2205419942834, 4037.535683396447, 4050.1899620075515, 5535.5848311376, 5614.494695477263, 5835.56233282497, 5847.707614619337, 5883.0, 5618.943810561842, 5634.859128521656, 5647.463490968352, 5662.631928924607, 5672.9505041567445, 5610.971945140248, 5622.550195984393, 5638.23883775685, 5638.661680299195, 5641.379448260606, 5235.141524758656, 5539.446055394428, 5563.805266815642, 5582.637128586629, 5603.0, 5613.158026296088, 5634.830955071355, 5646.85882852932, 5648.293963254593, 5674.120511320752, 5245.921311180259, 5546.861328466821, 5548.306461692288, 5549.0, 5573.972130139324], "value": 4203.549664882635, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.8980258059996, 775.4959276470294, 790.9367250619947, 796.486266358199, 803.2810634482134, 11433.142514311417, 11589.0, 11762.059035277178, 11777.528898844057, 11788.115891308144, 13398.12912160709, 13885.0, 13949.58151255464, 13957.302134893265, 13986.650333741662, 648.4650163615013, 807.3581502705349, 827.437342607027, 830.6884918155691, 834.0866750907746, 800.2797482265978, 821.3880658909121, 822.979425514361, 826.4751882554561, 827.3918669777709, 840.0213750980131, 848.7835601921502, 852.0159216105408, 854.2781349759443, 856.6145234644404, 847.1570787066877, 849.4945507423073, 850.8808766772656, 852.7313896122702, 855.8459477294084, 628.0422355907232, 629.3769168523174, 632.1245075570322, 633.0693879996398, 633.1800318587441, 12284.447199876027, 12298.20061695987, 12309.138360314782, 12354.25874447536, 12393.0, 11231.719207019809, 11795.35125568102, 11877.524899004029, 12205.816912746315, 12263.386830658521, 10789.568417263301, 10931.945340273327, 10968.506417211165, 11019.779604407948, 11267.098632109411, 3262.0703099616494, 3281.4913688378338, 3323.418401779703, 3327.7005069543616, 3335.3662804067394, 47978.28032579514, 48168.0, 48177.518224818006, 48337.75831120822, 48847.755761220964, 9656.130948214695, 9747.171490423252, 9750.0, 9761.804763904682, 9768.120869121813, 15690.215489225722, 15848.128352940468, 15874.920625396799, 15891.205439727968, 16004.279807408695, 6410.647414392253, 6440.130582371414, 6510.869782604416, 6539.11721917535, 6597.340265973365, 3532.452469867175, 3577.83899724513, 3598.2803439312243, 3646.288973650113, 3664.790619095692, 2901.5792710057344, 2979.7616190704694, 2983.8358890261243, 2985.1790757541416, 2987.626546681665, 493.755590982466, 528.6510902804131, 549.7059073395714, 551.9116941289454, 560.6692051689441, 601.485729701108, 643.9871202575922, 655.5509476008949, 661.8444665503603, 668.2615709640874, 7520.774376768706, 7561.2060733623275, 7983.20167983197, 8157.06193787722, 8199.549024803573, 651.9152510173647, 653.121551513214, 654.2802916791586, 659.1826135591832, 659.4691273524762, 3654.4152935530187, 3752.6810221130963, 3758.774473531597, 3843.7117216208335, 3874.41883717439, 53844.461555384725, 54028.72985635047, 54246.728766356704, 54812.72593637086, 55028.0, 22772.0, 22995.425114372276, 23011.654825177637, 47359.0, 48342.27486587704, 37505.0, 38457.42313865294, 40936.0, 45112.3233151503, 45306.32040519395, 7953.5227886327, 8062.234087761653, 8064.637091331021, 8099.473534220257, 8298.917010829815, 26494.470110597296, 26718.59922101131, 27122.864385678735, 27169.0, 27302.590461143496, 32454.0, 36422.635773642985, 37591.43612845864, 37823.0, 38648.22703545857, 10307.94846025765, 10566.947165264432, 10618.946905265424, 10628.096611788085, 10680.465976700978, 11360.43414403432, 11367.147463940073, 11499.195056345976, 11619.0, 11635.127365447455, 11213.66359009231, 11242.831357529807, 11546.787587303548, 11786.705332366759, 11935.641930742091, 11338.206325557132, 11525.0, 11781.234219775688, 11966.22219555726, 12032.15774895784, 10206.744831379276, 10419.322744021614, 10462.895371046496, 10591.205659575717, 10740.248182627141, 9500.95249523748, 9530.523473826419, 9558.808823823623, 9621.230301575717, 9625.663101791404, 9729.659461918798, 9896.703098907044, 9902.950485247527, 10015.599376024877, 10032.899671003197], "value": 5927.916270261598, "unit": "score"}], "name": "dromaeo_css", "value": 6412.859141065585, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 115.0, 114.0, 116.0, 126.0, 114.0, 115.0, 116.0, 112.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 137.0, 152.0, 196.0, 133.0, 164.0, 161.0, 139.0, 191.0, 138.0], "value": 156.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 166.0, 177.0, 165.0, 162.0, 164.0, 164.0, 167.0, 162.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 72.0, 162.0, 75.0, 75.0, 74.0, 77.0, 155.0, 75.0], "value": 91.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 140.0, 95.0, 94.0, 94.0, 150.0, 95.0, 94.0, 144.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 151.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 65.0, 74.0, 67.0, 71.0, 88.0, 69.0, 65.0], "value": 70.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 64.0, 65.0, 64.0, 67.0, 65.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 87.0, 80.0, 89.0, 90.0, 82.0, 81.0, 82.0, 80.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 148.0, 154.0, 134.0, 145.0, 138.0, 148.0, 176.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 174.0, 175.0, 183.0, 179.0, 175.0, 180.0, 179.0, 178.0, 181.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 76.0, 83.0, 78.0, 76.0, 73.0, 74.0, 73.0, 75.0], "value": 75.4, "unit": "score"}], "name": "kraken", "value": 1618.8000000000002, "alertThreshold": 2.0}]} 17:13:09 INFO - Return code: 0 17:13:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:13:09 ERROR - # TBPL SUCCESS # 17:13:09 INFO - Running post-action listener: _resource_record_post_action 17:13:09 INFO - Running post-run listener: _resource_record_post_run 17:13:11 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 430080; Write bytes: 296275968; Read time: 124; Write time: 236360 17:13:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13897728; Read time: 0; Write time: 4164 17:13:11 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 430080; Write bytes: 282378240; Read time: 124; Write time: 232196 17:13:11 INFO - Running post-run listener: _upload_blobber_files 17:13:11 INFO - Blob upload gear active. 17:13:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:13: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 17:13: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'] 17:13: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 17:13:11 INFO - (blobuploader) - INFO - Open directory for files ... 17:13:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:13:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:13:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:12 INFO - (blobuploader) - INFO - Done attempting. 17:13:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:13:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:13:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:13 INFO - (blobuploader) - INFO - Done attempting. 17:13:13 INFO - (blobuploader) - INFO - Iteration through files over. 17:13:13 INFO - Return code: 0 17:13:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:13:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:13:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0df8e0bcd928a47ec8b7398bdbc61ec889d87a44f34cc5a6c6af031cebf54b47e10e0c6aa145539e014f4467f804e6410f17e3c8214066ba3341a8140c13db80", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e0193509aa52101f61f5508e40c7558a0297a292952902c4529d32157242839e9f669e20ddd4e6bbe78335c51b6025f5dad2cd268b11ee667dd4ef011d12ab2"} 17:13:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:13:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:13:13 INFO - Contents: 17:13:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0df8e0bcd928a47ec8b7398bdbc61ec889d87a44f34cc5a6c6af031cebf54b47e10e0c6aa145539e014f4467f804e6410f17e3c8214066ba3341a8140c13db80", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e0193509aa52101f61f5508e40c7558a0297a292952902c4529d32157242839e9f669e20ddd4e6bbe78335c51b6025f5dad2cd268b11ee667dd4ef011d12ab2"} 17:13:13 INFO - Running post-run listener: copy_logs_to_upload_dir 17:13:13 INFO - Copying logs to upload dir... 17:13:13 INFO - mkdir: /builds/slave/test/build/upload/logs 17:13:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.826206 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-15 17:13:13.106669) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:13.110386) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433 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/0df8e0bcd928a47ec8b7398bdbc61ec889d87a44f34cc5a6c6af031cebf54b47e10e0c6aa145539e014f4467f804e6410f17e3c8214066ba3341a8140c13db80", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e0193509aa52101f61f5508e40c7558a0297a292952902c4529d32157242839e9f669e20ddd4e6bbe78335c51b6025f5dad2cd268b11ee667dd4ef011d12ab2"} build_url:https://queue.taskcluster.net/v1/task/IZWQ7IczQbeBYx5FeLXV_g/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/IZWQ7IczQbeBYx5FeLXV_g/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/0df8e0bcd928a47ec8b7398bdbc61ec889d87a44f34cc5a6c6af031cebf54b47e10e0c6aa145539e014f4467f804e6410f17e3c8214066ba3341a8140c13db80", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e0193509aa52101f61f5508e40c7558a0297a292952902c4529d32157242839e9f669e20ddd4e6bbe78335c51b6025f5dad2cd268b11ee667dd4ef011d12ab2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:13.134861) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:13.135180) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1460761936.108920-2003617433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:13:13.218973) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 17:13:13.219318) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 17:13:13.219635) ========= ========= Total master_lag: 0.16 =========