builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-069 starttime: 1460549972.13 results: success (0) buildid: 20160413035653 builduid: 33c0a345ff5a4862843683474473ae82 revision: 61e7426512e5cdc825615fd0b8dcc2f14b580d20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:32.133992) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:32.134472) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:32.134869) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004262 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:32.163052) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:32.163366) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:32.183457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:32.183832) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004025 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:32.233637) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:32.234151) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:32.234735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:32.235136) ========= 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=1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 05:19:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 82.9M=0s 2016-04-13 05:19:32 (82.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194081 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:32.441854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:32.442192) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.040023 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:32.494068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:32.494448) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 61e7426512e5cdc825615fd0b8dcc2f14b580d20 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 61e7426512e5cdc825615fd0b8dcc2f14b580d20 --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=1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 05:19:32,555 truncating revision to first 12 chars 2016-04-13 05:19:32,555 Setting DEBUG logging. 2016-04-13 05:19:32,555 attempt 1/10 2016-04-13 05:19:32,555 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/61e7426512e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 05:19:32,819 unpacking tar archive at: fx-team-61e7426512e5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542240 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:33.049789) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:33.050265) ========= echo 61e7426512e5cdc825615fd0b8dcc2f14b580d20 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'61e7426512e5cdc825615fd0b8dcc2f14b580d20'] 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=1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 61e7426512e5cdc825615fd0b8dcc2f14b580d20 program finished with exit code 0 elapsedTime=0.003483 script_repo_revision: '61e7426512e5cdc825615fd0b8dcc2f14b580d20' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:33.097962) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:33.098293) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 05:19:33.108817) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-13 05:19:33.109147) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:19:33 INFO - MultiFileLogger online at 20160413 05:19:33 in /builds/slave/test 05:19:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:19:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:19:33 INFO - {'append_to_log': False, 05:19:33 INFO - 'base_work_dir': '/builds/slave/test', 05:19:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:19:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:19:33 INFO - 'branch': 'Fx-Team-Non-PGO', 05:19:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:19:33 INFO - 'config_files': ('talos/linux_config.py',), 05:19:33 INFO - 'default_actions': ('clobber', 05:19:33 INFO - 'read-buildbot-config', 05:19:33 INFO - 'download-and-extract', 05:19:33 INFO - 'populate-webroot', 05:19:33 INFO - 'create-virtualenv', 05:19:33 INFO - 'install', 05:19:33 INFO - 'run-tests'), 05:19:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:19:33 INFO - 'download_minidump_stackwalk': True, 05:19:33 INFO - 'download_symbols': 'ondemand', 05:19:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:19:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:19:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:19:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:19:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:19:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:19:33 INFO - 'installer_path': 'installer.exe', 05:19:33 INFO - 'log_level': 'info', 05:19:33 INFO - 'log_name': 'talos', 05:19:33 INFO - 'log_to_console': True, 05:19:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:19:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:19:33 INFO - 'opt_config_files': (), 05:19:33 INFO - 'pip_index': False, 05:19:33 INFO - 'sps_profile': False, 05:19:33 INFO - 'sps_profile_interval': 0, 05:19:33 INFO - 'suite': 'dromaeojs-e10s', 05:19:33 INFO - 'system_bits': '32', 05:19:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:19:33 INFO - 'title': 'talos-linux64-ix-069', 05:19:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:19:33 INFO - 'use_talos_json': True, 05:19:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:19:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:19:33 INFO - 'work_dir': 'build'} 05:19:33 INFO - ##### 05:19:33 INFO - ##### Running clobber step. 05:19:33 INFO - ##### 05:19:33 INFO - Running pre-action listener: _resource_record_pre_action 05:19:33 INFO - Running main action method: clobber 05:19:33 INFO - rmtree: /builds/slave/test/build 05:19:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:19:34 INFO - Running post-action listener: _resource_record_post_action 05:19:34 INFO - ##### 05:19:34 INFO - ##### Running read-buildbot-config step. 05:19:34 INFO - ##### 05:19:34 INFO - Running pre-action listener: _resource_record_pre_action 05:19:34 INFO - Running main action method: read_buildbot_config 05:19:34 INFO - Using buildbot properties: 05:19:34 INFO - { 05:19:34 INFO - "project": "", 05:19:34 INFO - "product": "firefox", 05:19:34 INFO - "script_repo_revision": "production", 05:19:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:19:34 INFO - "repository": "", 05:19:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:19:34 INFO - "buildid": "20160413035653", 05:19:34 INFO - "pgo_build": "False", 05:19:34 INFO - "basedir": "/builds/slave/test", 05:19:34 INFO - "buildnumber": 1400, 05:19:34 INFO - "slavename": "talos-linux64-ix-069", 05:19:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:19:34 INFO - "platform": "ubuntu64_hw", 05:19:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:19:34 INFO - "branch": "fx-team", 05:19:34 INFO - "repo_path": "integration/fx-team", 05:19:34 INFO - "revision": "61e7426512e5cdc825615fd0b8dcc2f14b580d20", 05:19:34 INFO - "stage_platform": "linux64", 05:19:34 INFO - "builduid": "33c0a345ff5a4862843683474473ae82", 05:19:34 INFO - "slavebuilddir": "test" 05:19:34 INFO - } 05:19:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:19:34 INFO - Running post-action listener: _resource_record_post_action 05:19:34 INFO - ##### 05:19:34 INFO - ##### Running download-and-extract step. 05:19:34 INFO - ##### 05:19:34 INFO - Running pre-action listener: _resource_record_pre_action 05:19:34 INFO - Running main action method: download_and_extract 05:19:34 INFO - mkdir: /builds/slave/test/build/tests 05:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:34 INFO - https://queue.taskcluster.net/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:19:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:19:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:19:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/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 05:19:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/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 05:19:34 INFO - Downloaded 1361 bytes. 05:19:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:19:34 INFO - Using the following test package requirements: 05:19:34 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:19:34 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:19:34 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:19:34 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:34 INFO - u'jsshell-linux-x86_64.zip'], 05:19:34 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:19:34 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:19:34 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:19:34 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:19:34 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:19:34 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:19:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:34 INFO - https://queue.taskcluster.net/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:19:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:19:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:19:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/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 05:19:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/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 05:19:39 INFO - Downloaded 22199056 bytes. 05:19:39 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'] 05:19:39 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 05:19:40 INFO - Return code: 0 05:19:40 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 05:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:40 INFO - https://queue.taskcluster.net/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:19:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:19:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:19:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/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 05:19:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/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 05:19:42 INFO - Downloaded 22199056 bytes. 05:19:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:19:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:19:44 INFO - Return code: 0 05:19: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')]} 05:19:44 INFO - https://queue.taskcluster.net/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:19:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/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 05:19:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/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 05:19:45 INFO - Downloaded 10841076 bytes. 05:19: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'] 05:19: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 05:19:45 INFO - Return code: 0 05:19: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')]} 05:19:45 INFO - https://queue.taskcluster.net/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:19:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:19:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:19:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/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 05:19:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/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 05:19:47 INFO - Downloaded 54159186 bytes. 05:19:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:19:47 INFO - mkdir: /builds/slave/test/properties 05:19:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:19:47 INFO - Writing to file /builds/slave/test/properties/build_url 05:19:47 INFO - Contents: 05:19:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:19:47 INFO - Running post-action listener: _resource_record_post_action 05:19:47 INFO - Running post-action listener: set_extra_try_arguments 05:19:47 INFO - ##### 05:19:47 INFO - ##### Running populate-webroot step. 05:19:47 INFO - ##### 05:19:47 INFO - Running pre-action listener: _resource_record_pre_action 05:19:47 INFO - Running main action method: populate_webroot 05:19:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:19:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:19:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:19:48 INFO - '--tppagecycles', 05:19:48 INFO - '7'], 05:19:48 INFO - 'tests': ['tsvgm']}}, 05:19:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:19:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:19:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:19:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:19:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:19:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:19:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:48 INFO - 'talos_options': ['--disable-e10s'], 05:19:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:48 INFO - 'talos_options': ['--disable-e10s'], 05:19:48 INFO - 'tests': ['damp', 'tps']}, 05:19:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:48 INFO - 'tests': ['damp', 'tps']}, 05:19:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:19:48 INFO - 'tests': ['dromaeo_dom']}, 05:19:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:19:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:19:48 INFO - 'tests': ['a11yr', 05:19:48 INFO - 'ts_paint', 05:19:48 INFO - 'tpaint', 05:19:48 INFO - 'sessionrestore', 05:19:48 INFO - 'sessionrestore_no_auto_restore', 05:19:48 INFO - 'tabpaint']}, 05:19:48 INFO - 'other-e10s': {'tests': ['a11yr', 05:19:48 INFO - 'ts_paint', 05:19:48 INFO - 'tpaint', 05:19:48 INFO - 'sessionrestore', 05:19:48 INFO - 'sessionrestore_no_auto_restore', 05:19:48 INFO - 'tabpaint']}, 05:19:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:19:48 INFO - 'ts_paint', 05:19:48 INFO - 'tpaint', 05:19:48 INFO - 'sessionrestore', 05:19:48 INFO - 'sessionrestore_no_auto_restore', 05:19:48 INFO - 'tabpaint']}, 05:19:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:19:48 INFO - 'ts_paint', 05:19:48 INFO - 'tpaint', 05:19:48 INFO - 'sessionrestore', 05:19:48 INFO - 'sessionrestore_no_auto_restore', 05:19:48 INFO - 'tabpaint']}, 05:19:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:19:48 INFO - 'tests': ['a11yr', 05:19:48 INFO - 'ts_paint', 05:19:48 INFO - 'tpaint', 05:19:48 INFO - 'sessionrestore', 05:19:48 INFO - 'sessionrestore_no_auto_restore', 05:19:48 INFO - 'tabpaint']}, 05:19:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:19:48 INFO - 'tests': ['a11yr', 05:19:48 INFO - 'ts_paint', 05:19:48 INFO - 'tpaint', 05:19:48 INFO - 'sessionrestore', 05:19:48 INFO - 'sessionrestore_no_auto_restore', 05:19:48 INFO - 'tabpaint']}, 05:19:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:19:48 INFO - 'tests': ['tsvgx', 05:19:48 INFO - 'tsvgr_opacity', 05:19:48 INFO - 'tart', 05:19:48 INFO - 'tscrollx', 05:19:48 INFO - 'cart']}, 05:19:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:19:48 INFO - 'tsvgr_opacity', 05:19:48 INFO - 'tart', 05:19:48 INFO - 'tscrollx', 05:19:48 INFO - 'cart']}, 05:19:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:48 INFO - 'talos_options': ['--disable-e10s'], 05:19:48 INFO - 'tests': ['tp5o']}, 05:19:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:48 INFO - 'tests': ['tp5o']}, 05:19:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:48 INFO - 'talos_options': ['--disable-e10s', 05:19:48 INFO - '--xperf_path', 05:19:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:48 INFO - 'tests': ['tp5n']}, 05:19:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:48 INFO - 'talos_options': ['--xperf_path', 05:19:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:48 INFO - 'tests': ['tp5n']}}, 05:19:48 INFO - 'talos.zip': {'path': '', 05:19:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:19:48 INFO - Running post-action listener: _resource_record_post_action 05:19:48 INFO - ##### 05:19:48 INFO - ##### Running create-virtualenv step. 05:19:48 INFO - ##### 05:19:48 INFO - Running pre-action listener: _resource_record_pre_action 05:19:48 INFO - Running main action method: create_virtualenv 05:19:48 INFO - Creating virtualenv /builds/slave/test/build/venv 05:19:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:19:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:19:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:19:48 INFO - Using real prefix '/usr' 05:19:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:19:49 INFO - Installing distribute.............................................................................................................................................................................................done. 05:19:52 INFO - Installing pip.................done. 05:19:52 INFO - Return code: 0 05:19:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:19:52 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')]} 05:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:52 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')]} 05:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:52 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 0x7f2daa99ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172410>, '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 0x1173310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11737a0>, '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': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', '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 05:19:52 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 05:19:52 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 05:19:52 INFO - Using env: {'DISPLAY': ':0', 05:19:52 INFO - 'HOME': '/home/cltbld', 05:19:52 INFO - 'LANG': 'en_US.UTF-8', 05:19:52 INFO - 'LANGUAGE': 'en_US:en', 05:19:52 INFO - 'LOGNAME': 'cltbld', 05:19:52 INFO - 'MAIL': '/var/mail/cltbld', 05:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:52 INFO - 'MOZ_NO_REMOTE': '1', 05:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:52 INFO - 'NO_EM_RESTART': '1', 05:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:52 INFO - 'PWD': '/builds/slave/test', 05:19:52 INFO - 'SHELL': '/bin/bash', 05:19:52 INFO - 'SHLVL': '1', 05:19:52 INFO - 'TERM': 'linux', 05:19:52 INFO - 'TMOUT': '86400', 05:19:52 INFO - 'USER': 'cltbld', 05:19:52 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', 05:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:52 INFO - '_': '/tools/buildbot/bin/python'} 05:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:56 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 05:19:56 INFO - Cleaning up... 05:19:56 INFO - Return code: 0 05:19:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:19: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')]} 05:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19: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')]} 05:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19: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', '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 0x7f2daa99ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172410>, '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 0x1173310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11737a0>, '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': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', '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 05:19: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', 'psutil>=0.7.1'] in /builds/slave/test/build 05:19: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 psutil>=0.7.1 05:19:56 INFO - Using env: {'DISPLAY': ':0', 05:19:56 INFO - 'HOME': '/home/cltbld', 05:19:56 INFO - 'LANG': 'en_US.UTF-8', 05:19:56 INFO - 'LANGUAGE': 'en_US:en', 05:19:56 INFO - 'LOGNAME': 'cltbld', 05:19:56 INFO - 'MAIL': '/var/mail/cltbld', 05:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:56 INFO - 'MOZ_NO_REMOTE': '1', 05:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:56 INFO - 'NO_EM_RESTART': '1', 05:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:56 INFO - 'PWD': '/builds/slave/test', 05:19:56 INFO - 'SHELL': '/bin/bash', 05:19:56 INFO - 'SHLVL': '1', 05:19:56 INFO - 'TERM': 'linux', 05:19:56 INFO - 'TMOUT': '86400', 05:19:56 INFO - 'USER': 'cltbld', 05:19:56 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', 05:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:56 INFO - '_': '/tools/buildbot/bin/python'} 05:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:56 INFO - Downloading/unpacking psutil>=0.7.1 05:19: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 05:19: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 05:19: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 05:19: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 05:19: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 05:19: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 05:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:19:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:19:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:19:58 INFO - Installing collected packages: psutil 05:19:58 INFO - Running setup.py install for psutil 05:19:58 INFO - building 'psutil._psutil_linux' extension 05:19:58 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 05:20:00 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 05:20:00 INFO - building 'psutil._psutil_posix' extension 05:20:00 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 05:20:00 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 05:20:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:00 INFO - Successfully installed psutil 05:20:00 INFO - Cleaning up... 05:20:00 INFO - Return code: 0 05:20:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:00 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 0x7f2daa99ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172410>, '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 0x1173310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11737a0>, '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': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', '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 05:20:00 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 05:20:00 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 05:20:00 INFO - Using env: {'DISPLAY': ':0', 05:20:00 INFO - 'HOME': '/home/cltbld', 05:20:00 INFO - 'LANG': 'en_US.UTF-8', 05:20:00 INFO - 'LANGUAGE': 'en_US:en', 05:20:00 INFO - 'LOGNAME': 'cltbld', 05:20:00 INFO - 'MAIL': '/var/mail/cltbld', 05:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:00 INFO - 'MOZ_NO_REMOTE': '1', 05:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:00 INFO - 'NO_EM_RESTART': '1', 05:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:00 INFO - 'PWD': '/builds/slave/test', 05:20:00 INFO - 'SHELL': '/bin/bash', 05:20:00 INFO - 'SHLVL': '1', 05:20:00 INFO - 'TERM': 'linux', 05:20:00 INFO - 'TMOUT': '86400', 05:20:00 INFO - 'USER': 'cltbld', 05:20:00 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', 05:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:00 INFO - '_': '/tools/buildbot/bin/python'} 05:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:20:00 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 05:20:00 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 05:20:00 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 05:20:00 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 05:20:00 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 05:20:00 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 05:20:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:20:02 INFO - Installing collected packages: mozsystemmonitor 05:20:02 INFO - Running setup.py install for mozsystemmonitor 05:20:02 INFO - Successfully installed mozsystemmonitor 05:20:02 INFO - Cleaning up... 05:20:02 INFO - Return code: 0 05:20:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:20:02 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')]} 05:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:02 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')]} 05:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:02 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 0x7f2daa99ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172410>, '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 0x1173310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11737a0>, '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': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', '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 05:20:02 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 05:20:02 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 05:20:02 INFO - Using env: {'DISPLAY': ':0', 05:20:02 INFO - 'HOME': '/home/cltbld', 05:20:02 INFO - 'LANG': 'en_US.UTF-8', 05:20:02 INFO - 'LANGUAGE': 'en_US:en', 05:20:02 INFO - 'LOGNAME': 'cltbld', 05:20:02 INFO - 'MAIL': '/var/mail/cltbld', 05:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:02 INFO - 'MOZ_NO_REMOTE': '1', 05:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:02 INFO - 'NO_EM_RESTART': '1', 05:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:02 INFO - 'PWD': '/builds/slave/test', 05:20:02 INFO - 'SHELL': '/bin/bash', 05:20:02 INFO - 'SHLVL': '1', 05:20:02 INFO - 'TERM': 'linux', 05:20:02 INFO - 'TMOUT': '86400', 05:20:02 INFO - 'USER': 'cltbld', 05:20:02 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', 05:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:02 INFO - '_': '/tools/buildbot/bin/python'} 05:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:20:03 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 05:20:03 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 05:20:03 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 05:20:03 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 05:20:03 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 05:20:03 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 05:20:04 INFO - Downloading blobuploader-1.2.4.tar.gz 05:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:20:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:20:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:20:05 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 05:20:05 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 05:20:05 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 05:20:05 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 05:20:05 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 05:20:05 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 05:20:05 INFO - Downloading docopt-0.6.1.tar.gz 05:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:20:05 INFO - Installing collected packages: blobuploader, requests, docopt 05:20:05 INFO - Running setup.py install for blobuploader 05:20:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:20:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:20:05 INFO - Running setup.py install for requests 05:20:06 INFO - Running setup.py install for docopt 05:20:06 INFO - Successfully installed blobuploader requests docopt 05:20:06 INFO - Cleaning up... 05:20:06 INFO - Return code: 0 05:20:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:06 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 0x7f2daa99ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172410>, '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 0x1173310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11737a0>, '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': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', '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 05:20:06 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 05:20:06 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 05:20:06 INFO - Using env: {'DISPLAY': ':0', 05:20:06 INFO - 'HOME': '/home/cltbld', 05:20:06 INFO - 'LANG': 'en_US.UTF-8', 05:20:06 INFO - 'LANGUAGE': 'en_US:en', 05:20:06 INFO - 'LOGNAME': 'cltbld', 05:20:06 INFO - 'MAIL': '/var/mail/cltbld', 05:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:06 INFO - 'MOZ_NO_REMOTE': '1', 05:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:06 INFO - 'NO_EM_RESTART': '1', 05:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:06 INFO - 'PWD': '/builds/slave/test', 05:20:06 INFO - 'SHELL': '/bin/bash', 05:20:06 INFO - 'SHLVL': '1', 05:20:06 INFO - 'TERM': 'linux', 05:20:06 INFO - 'TMOUT': '86400', 05:20:06 INFO - 'USER': 'cltbld', 05:20:06 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', 05:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:06 INFO - '_': '/tools/buildbot/bin/python'} 05:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:06 INFO - Running setup.py (path:/tmp/pip-FBuGdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:06 INFO - Running setup.py (path:/tmp/pip-4ym3m9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:06 INFO - Running setup.py (path:/tmp/pip-VYhUsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:06 INFO - Running setup.py (path:/tmp/pip-odTLSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:06 INFO - Running setup.py (path:/tmp/pip-F5sbzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:06 INFO - Running setup.py (path:/tmp/pip-Ml6mO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:06 INFO - Running setup.py (path:/tmp/pip-pUkTFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:06 INFO - Running setup.py (path:/tmp/pip-K4LBaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:07 INFO - Running setup.py (path:/tmp/pip-Gf3cwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:07 INFO - Running setup.py (path:/tmp/pip-3jOYY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:07 INFO - Running setup.py (path:/tmp/pip-PNb66Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:07 INFO - Running setup.py (path:/tmp/pip-MyXpD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:07 INFO - Running setup.py (path:/tmp/pip-WgFs3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:07 INFO - Running setup.py (path:/tmp/pip-HTQMa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:07 INFO - Running setup.py (path:/tmp/pip-1s_PlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:07 INFO - Running setup.py (path:/tmp/pip-SJIqlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:07 INFO - Running setup.py (path:/tmp/pip-sQu58c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:20:07 INFO - Running setup.py install for manifestparser 05:20:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:20:07 INFO - Running setup.py install for mozcrash 05:20:07 INFO - Running setup.py install for mozdebug 05:20:07 INFO - Running setup.py install for mozdevice 05:20:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:20:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:20:08 INFO - Running setup.py install for mozfile 05:20:08 INFO - Running setup.py install for mozhttpd 05:20:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:20:08 INFO - Running setup.py install for mozinfo 05:20:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:20:08 INFO - Running setup.py install for mozInstall 05:20:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:20:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:20:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:20:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:20:08 INFO - Running setup.py install for mozleak 05:20:08 INFO - Running setup.py install for mozlog 05:20:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:20:08 INFO - Running setup.py install for moznetwork 05:20:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:20:08 INFO - Running setup.py install for mozprocess 05:20:08 INFO - Running setup.py install for mozprofile 05:20:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:20:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:20:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:20:09 INFO - Running setup.py install for mozrunner 05:20:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:20:09 INFO - Running setup.py install for mozscreenshot 05:20:09 INFO - Running setup.py install for moztest 05:20:09 INFO - Running setup.py install for mozversion 05:20:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:20:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:20:09 INFO - Cleaning up... 05:20:09 INFO - Return code: 0 05:20:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:09 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 0x7f2daa99ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172410>, '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 0x1173310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11737a0>, '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': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', '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 05:20:09 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 05:20:09 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 05:20:09 INFO - Using env: {'DISPLAY': ':0', 05:20:09 INFO - 'HOME': '/home/cltbld', 05:20:09 INFO - 'LANG': 'en_US.UTF-8', 05:20:09 INFO - 'LANGUAGE': 'en_US:en', 05:20:09 INFO - 'LOGNAME': 'cltbld', 05:20:09 INFO - 'MAIL': '/var/mail/cltbld', 05:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:09 INFO - 'MOZ_NO_REMOTE': '1', 05:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:09 INFO - 'NO_EM_RESTART': '1', 05:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:09 INFO - 'PWD': '/builds/slave/test', 05:20:09 INFO - 'SHELL': '/bin/bash', 05:20:09 INFO - 'SHLVL': '1', 05:20:09 INFO - 'TERM': 'linux', 05:20:09 INFO - 'TMOUT': '86400', 05:20:09 INFO - 'USER': 'cltbld', 05:20:09 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', 05:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:09 INFO - '_': '/tools/buildbot/bin/python'} 05:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:09 INFO - Running setup.py (path:/tmp/pip-rcJmNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:09 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)) 05:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:09 INFO - Running setup.py (path:/tmp/pip-jtETTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:09 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)) 05:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:09 INFO - Running setup.py (path:/tmp/pip-SMAcAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:09 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)) 05:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:09 INFO - Running setup.py (path:/tmp/pip-7PzJOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:10 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)) 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:10 INFO - Running setup.py (path:/tmp/pip-ccyIpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:10 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)) 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:10 INFO - Running setup.py (path:/tmp/pip-9u18JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:10 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)) 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:10 INFO - Running setup.py (path:/tmp/pip-8_5n_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:10 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)) 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:10 INFO - Running setup.py (path:/tmp/pip-eZgZ16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:10 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)) 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:10 INFO - Running setup.py (path:/tmp/pip-wPxBhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:10 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)) 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:10 INFO - Running setup.py (path:/tmp/pip-T48bvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:10 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)) 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:10 INFO - Running setup.py (path:/tmp/pip-aBrTZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:10 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)) 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:10 INFO - Running setup.py (path:/tmp/pip-79nQnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:10 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)) 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:10 INFO - Running setup.py (path:/tmp/pip-zErwtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:10 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)) 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:10 INFO - Running setup.py (path:/tmp/pip-Qpwyfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:10 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)) 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:10 INFO - Running setup.py (path:/tmp/pip-UpqJ5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:10 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)) 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:10 INFO - Running setup.py (path:/tmp/pip-owBvtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:10 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)) 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:10 INFO - Running setup.py (path:/tmp/pip-RaTbh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:10 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)) 05:20:10 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)) 05:20:10 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)) 05:20:10 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)) 05:20:10 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)) 05:20:10 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)) 05:20:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:12 INFO - Downloading blessings-1.6.tar.gz 05:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:20:12 INFO - Installing collected packages: blessings 05:20:12 INFO - Running setup.py install for blessings 05:20:13 INFO - Successfully installed blessings 05:20:13 INFO - Cleaning up... 05:20:13 INFO - Return code: 0 05:20:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:20:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:13 INFO - Reading from file tmpfile_stdout 05:20:13 INFO - Current package versions: 05:20:13 INFO - argparse == 1.2.1 05:20:13 INFO - blessings == 1.6 05:20:13 INFO - blobuploader == 1.2.4 05:20:13 INFO - docopt == 0.6.1 05:20:13 INFO - manifestparser == 1.1 05:20:13 INFO - mozInstall == 1.12 05:20:13 INFO - mozcrash == 0.17 05:20:13 INFO - mozdebug == 0.1 05:20:13 INFO - mozdevice == 0.48 05:20:13 INFO - mozfile == 1.2 05:20:13 INFO - mozhttpd == 0.7 05:20:13 INFO - mozinfo == 0.9 05:20:13 INFO - mozleak == 0.1 05:20:13 INFO - mozlog == 3.1 05:20:13 INFO - moznetwork == 0.27 05:20:13 INFO - mozprocess == 0.22 05:20:13 INFO - mozprofile == 0.28 05:20:13 INFO - mozrunner == 6.11 05:20:13 INFO - mozscreenshot == 0.1 05:20:13 INFO - mozsystemmonitor == 0.0 05:20:13 INFO - moztest == 0.7 05:20:13 INFO - mozversion == 1.4 05:20:13 INFO - psutil == 3.1.1 05:20:13 INFO - requests == 1.2.3 05:20:13 INFO - wsgiref == 0.1.2 05:20:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:13 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 0x7f2daa99ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172410>, '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 0x1173310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11737a0>, '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': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', '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 05:20:13 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 05:20:13 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 05:20:13 INFO - Using env: {'DISPLAY': ':0', 05:20:13 INFO - 'HOME': '/home/cltbld', 05:20:13 INFO - 'LANG': 'en_US.UTF-8', 05:20:13 INFO - 'LANGUAGE': 'en_US:en', 05:20:13 INFO - 'LOGNAME': 'cltbld', 05:20:13 INFO - 'MAIL': '/var/mail/cltbld', 05:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:13 INFO - 'MOZ_NO_REMOTE': '1', 05:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:13 INFO - 'NO_EM_RESTART': '1', 05:20:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:13 INFO - 'PWD': '/builds/slave/test', 05:20:13 INFO - 'SHELL': '/bin/bash', 05:20:13 INFO - 'SHLVL': '1', 05:20:13 INFO - 'TERM': 'linux', 05:20:13 INFO - 'TMOUT': '86400', 05:20:13 INFO - 'USER': 'cltbld', 05:20:13 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', 05:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:13 INFO - '_': '/tools/buildbot/bin/python'} 05:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:13 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)) 05:20:13 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)) 05:20:13 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)) 05:20:13 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)) 05:20:13 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)) 05:20:13 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)) 05:20:13 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)) 05:20:13 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)) 05:20:13 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)) 05:20:13 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)) 05:20:13 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)) 05:20:13 INFO - Cleaning up... 05:20:13 INFO - Return code: 0 05:20:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2daa99ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172410>, '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 0x1173310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11737a0>, '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': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', '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 05:20:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:20:13 INFO - Using env: {'DISPLAY': ':0', 05:20:13 INFO - 'HOME': '/home/cltbld', 05:20:13 INFO - 'LANG': 'en_US.UTF-8', 05:20:13 INFO - 'LANGUAGE': 'en_US:en', 05:20:13 INFO - 'LOGNAME': 'cltbld', 05:20:13 INFO - 'MAIL': '/var/mail/cltbld', 05:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:13 INFO - 'MOZ_NO_REMOTE': '1', 05:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:13 INFO - 'NO_EM_RESTART': '1', 05:20:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:13 INFO - 'PWD': '/builds/slave/test', 05:20:13 INFO - 'SHELL': '/bin/bash', 05:20:13 INFO - 'SHLVL': '1', 05:20:13 INFO - 'TERM': 'linux', 05:20:13 INFO - 'TMOUT': '86400', 05:20:13 INFO - 'USER': 'cltbld', 05:20:13 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', 05:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:13 INFO - '_': '/tools/buildbot/bin/python'} 05:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:13 INFO - Downloading/unpacking jsonschema 05:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:20:15 INFO - Downloading/unpacking functools32 (from jsonschema) 05:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:20:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:20:15 INFO - warning: no files found matching '*.txt' 05:20:15 INFO - no previously-included directories found matching 'build' 05:20:15 INFO - no previously-included directories found matching 'dist' 05:20:15 INFO - no previously-included directories found matching '.git*' 05:20:15 INFO - Installing collected packages: jsonschema, functools32 05:20:15 INFO - Running setup.py install for functools32 05:20:16 INFO - warning: no files found matching '*.txt' 05:20:16 INFO - no previously-included directories found matching 'build' 05:20:16 INFO - no previously-included directories found matching 'dist' 05:20:16 INFO - no previously-included directories found matching '.git*' 05:20:16 INFO - Successfully installed jsonschema functools32 05:20:16 INFO - Cleaning up... 05:20:16 INFO - Return code: 0 05:20:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:16 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 0x7f2daa99ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172410>, '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 0x1173310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11737a0>, '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': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', '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 05:20:16 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 05:20:16 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 05:20:16 INFO - Using env: {'DISPLAY': ':0', 05:20:16 INFO - 'HOME': '/home/cltbld', 05:20:16 INFO - 'LANG': 'en_US.UTF-8', 05:20:16 INFO - 'LANGUAGE': 'en_US:en', 05:20:16 INFO - 'LOGNAME': 'cltbld', 05:20:16 INFO - 'MAIL': '/var/mail/cltbld', 05:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:16 INFO - 'MOZ_NO_REMOTE': '1', 05:20:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:16 INFO - 'NO_EM_RESTART': '1', 05:20:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:16 INFO - 'PWD': '/builds/slave/test', 05:20:16 INFO - 'SHELL': '/bin/bash', 05:20:16 INFO - 'SHLVL': '1', 05:20:16 INFO - 'TERM': 'linux', 05:20:16 INFO - 'TMOUT': '86400', 05:20:16 INFO - 'USER': 'cltbld', 05:20:16 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', 05:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:16 INFO - '_': '/tools/buildbot/bin/python'} 05:20:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:16 INFO - Downloading/unpacking flake8 05:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:20:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:20:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:20:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:20:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:20:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:20:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:20:18 INFO - no previously-included directories found matching 'docs/_build' 05:20:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:20:18 INFO - Running setup.py install for pep8 05:20:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:20:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:20:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:20:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:20:18 INFO - no previously-included directories found matching 'docs/_build' 05:20:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:20:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:20:19 INFO - Cleaning up... 05:20:19 INFO - Return code: 0 05:20:19 INFO - Running post-action listener: _resource_record_post_action 05:20:19 INFO - Running post-action listener: _start_resource_monitoring 05:20:19 INFO - Starting resource monitoring. 05:20:19 INFO - ##### 05:20:19 INFO - ##### Running install step. 05:20:19 INFO - ##### 05:20:19 INFO - Running pre-action listener: _resource_record_pre_action 05:20:19 INFO - Running main action method: install 05:20:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:19 INFO - Reading from file tmpfile_stdout 05:20:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:20:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:20:19 INFO - Reading from file tmpfile_stdout 05:20:19 INFO - Output received: 05:20:19 INFO - Usage: mozinstall [options] installer 05:20:19 INFO - Options: 05:20:19 INFO - -h, --help show this help message and exit 05:20:19 INFO - -d DEST, --destination=DEST 05:20:19 INFO - Directory to install application into. [default: 05:20:19 INFO - "/builds/slave/test"] 05:20:19 INFO - --app=APP Application being installed. [default: firefox] 05:20:19 INFO - mkdir: /builds/slave/test/build/application 05:20:19 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'] 05:20:19 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 05:20:35 INFO - Reading from file tmpfile_stdout 05:20:35 INFO - Output received: 05:20:35 INFO - /builds/slave/test/build/application/firefox/firefox 05:20:35 INFO - Running post-action listener: _resource_record_post_action 05:20:35 INFO - ##### 05:20:35 INFO - ##### Running run-tests step. 05:20:35 INFO - ##### 05:20:35 INFO - Running pre-action listener: _resource_record_pre_action 05:20:35 INFO - Running main action method: run_tests 05:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:20:35 INFO - Python 2.7.3 05:20:35 INFO - Return code: 0 05:20:35 INFO - grabbing minidump binary from tooltool 05:20:35 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')]} 05:20:35 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 0x1172410>, '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 0x1173310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11737a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:20:35 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 05:20:35 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 05:20:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:20:35 INFO - Return code: 0 05:20:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:20:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:20:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:20:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:20:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:20:36 INFO - Return code: 0 05:20:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 05:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 05:20:36 INFO - Using env: {'DISPLAY': ':0', 05:20:36 INFO - 'HOME': '/home/cltbld', 05:20:36 INFO - 'LANG': 'en_US.UTF-8', 05:20:36 INFO - 'LANGUAGE': 'en_US:en', 05:20:36 INFO - 'LOGNAME': 'cltbld', 05:20:36 INFO - 'MAIL': '/var/mail/cltbld', 05:20:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:20:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:36 INFO - 'MOZ_NO_REMOTE': '1', 05:20:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:36 INFO - 'NO_EM_RESTART': '1', 05:20:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:36 INFO - 'PWD': '/builds/slave/test', 05:20:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:20:36 INFO - 'SHELL': '/bin/bash', 05:20:36 INFO - 'SHLVL': '1', 05:20:36 INFO - 'TERM': 'linux', 05:20:36 INFO - 'TMOUT': '86400', 05:20:36 INFO - 'USER': 'cltbld', 05:20:36 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682', 05:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:36 INFO - '_': '/tools/buildbot/bin/python'} 05:20:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 05:20:36 INFO - mozversion application_buildid: 20160413035653 05:20:36 INFO - mozversion application_changeset: 61e7426512e5cdc825615fd0b8dcc2f14b580d20 05:20:36 INFO - mozversion application_display_name: Nightly 05:20:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:20:36 INFO - mozversion application_name: Firefox 05:20:36 INFO - mozversion application_remotingname: firefox 05:20:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:20:36 INFO - mozversion application_vendor: Mozilla 05:20:36 INFO - mozversion application_version: 48.0a1 05:20:36 INFO - mozversion platform_buildid: 20160413035653 05:20:36 INFO - mozversion platform_changeset: 61e7426512e5cdc825615fd0b8dcc2f14b580d20 05:20:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:20:36 INFO - mozversion platform_version: 48.0a1 05:20:36 INFO - using testdate: 1460550036 05:20:36 INFO - actual date: 1460550036 05:20:36 INFO - starting webserver on 'localhost:36633' 05:20:36 INFO - SUITE-START | Running 2 tests 05:20:36 INFO - TEST-START | dromaeo_css 05:20:36 INFO - operating with platform_type : linux_ 05:20:36 INFO - Initialising browser for dromaeo_css test... 05:20:36 INFO - TEST-INFO | started process 3307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQkGHdo/profile http://localhost:36633/getInfo.html) 05:20:43 INFO - PROCESS | 3307 | 05:20:43 INFO - PROCESS | 3307 | (process:3376): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:20:43 INFO - PROCESS | 3307 | 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] 05:20:44 INFO - PROCESS | 3307 | __metrics Screen width/height:1600/1200 05:20:44 INFO - PROCESS | 3307 | colorDepth:24 05:20:44 INFO - PROCESS | 3307 | Browser inner width/height: 1024/697 05:20:44 INFO - PROCESS | 3307 | __metrics 05:20:45 ERROR - PROCESS | 3307 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:20:46 INFO - TEST-INFO | 3307: exit 0 05:20:46 INFO - Browser initialized. 05:20:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:20:46 INFO - TEST-INFO | started process 3427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQkGHdo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:48 INFO - PROCESS | 3427 | 05:20:48 INFO - PROCESS | 3427 | (process:3487): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:20:58 INFO - PROCESS | 3427 | RSS: Main: 164126720 05:20:58 INFO - PROCESS | 3427 | 05:21:47 INFO - PROCESS | 3427 | 1460550107715 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] 05:23:59 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:36633/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36633/tests/dromaeo/cssquery-ext.html) 05:24:00 INFO - PROCESS | 3427 | RSS: Main: 168853504 05:24:00 INFO - PROCESS | 3427 | 05:27:02 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:36633/tests/dromaeo/cssquery-ext.html (next: http://localhost:36633/tests/dromaeo/cssquery-jquery.html) 05:27:03 INFO - PROCESS | 3427 | RSS: Main: 165003264 05:27:03 INFO - PROCESS | 3427 | 05:30:05 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:36633/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36633/tests/dromaeo/cssquery-mootools.html) 05:30:05 INFO - PROCESS | 3427 | RSS: Main: 166768640 05:30:05 INFO - PROCESS | 3427 | 05:33:07 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:36633/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36633/tests/dromaeo/cssquery-prototype.html) 05:33:08 INFO - PROCESS | 3427 | RSS: Main: 164028416 05:33:08 INFO - PROCESS | 3427 | 05:36:10 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:36633/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36633/tests/dromaeo/cssquery-yui.html) 05:36:11 INFO - PROCESS | 3427 | RSS: Main: 165425152 05:36:11 INFO - PROCESS | 3427 | 05:39:13 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:36633/tests/dromaeo/cssquery-yui.html (next: http://localhost:36633/tests/dromaeo/cssquery-dojo.html) 05:39:13 INFO - PROCESS | 3427 | RSS: Main: 167436288 05:39:13 INFO - PROCESS | 3427 | 05:39:13 INFO - PROCESS | 3427 | __start_tp_report 05:39:13 INFO - PROCESS | 3427 | _x_x_mozilla_page_load 05:39:13 INFO - PROCESS | 3427 | _x_x_mozilla_page_load_details 05:39:13 INFO - PROCESS | 3427 | |i|pagename|runs| 05:39:13 INFO - PROCESS | 3427 | |0;dojo.html;2614.790816734661;2646.047422927747;2669.4260733942197;2676.9732302676966;2690.300521864315;4602.953970460303;4611.907761844761;4618.422697162855;4631.629469642429;4678.041001594674;4534.773261336936;4551.476580193279;4604.838830640928;4613.8154473821005;4618.076384723052;4243;4263.424437700902;4330.675199360045;4338.2191205582985;4341.936225624726;4276.123394704094;4295.720778149426;4316.935245971313;4338.197433474817;4392.143532011259;4174.0817020255645;4228.238916994939;4243.024104455962;4259.87220383389;4275.764832934187;4209.768462734548;4233.957660423418;4244.851430199959;4279.700420970502;4285.378620100099;4195.7063005589625;4218.767967761772;4226.028013556899;4227.133437645275;4269.231538323101;4513.842015529473;4547.954520454786;4554.817807287704;4584.908301833978;4595.586397224232;4941.1847045237855;4954.43024052235;4954.801807927679;4965.627577931669;4971.229459433794;4820;4968.403791545002;4995.325631039836;5008.524190201925;5029.471905449912;4623.838165664186;4624.283236098377;4642.814287428465;4649.070185962821;4653.092646933849;4962.751862406865;5033.546980771748;5049.293098966147;5069.5437410632485;5108.693478391308;4788.880277993008;4824.734639594786;4876.82931097417;4881.585065269421;4892.877678058077;4790.113828941657;4920.4095508538485;4978.875528111754;4979.402471703419;5047.596192304681;4888.828890988798;4896.730679812645;4906.484819093944;4908.239222920453;4948.851534453972;4782.545658162469;4876.780544875489;4895.73073480962;4911.607071434277;4952.925706114411;4115.36211887158;4123.154753275631;4124.195781822576;4132.73137246078;4165.645920096765;3624.130208749934;3635.781853088823;3653.2328211075974;3653.488511608377;3656.323580137683;4262.381954616563;4268.829246830154;4272.33778764292;4296.5273819879785;4303.07483890965;4907.263910413395;4954.8761280968265;4971.577415919615;4991.101601711654;5006.048850718352;4228.323468245066;4318.805653745589;4329.891752706208;4330.610245077958;4374.03771170342;4443.155800397914;4457.2645513489915;4459.353393757887;4506.504284528699;4516.525764794715;4713.2458806590785;4741.810327586858;4745.620350372031;4754.500777418321;4780.1873681473535;4893.437254715754;4981.950180498148;4982.078315511497;4983.401991761012;4996.825111121093;4696.483386827515;4711.246200607886;4712.0104777997;4745.311929770095;4749.35883655702;4840.128776820206;4853.635977301646;4860.416749990024;4868.099401610713;4940.036692844861;4898.461169271449;4930.6055515557955;4939.456659767495;4972.279019542074;5024.924626130684;4687.578117969263;4732.171869922819;4788.186008378514;4788.760561971957;4825.203841366135;4813.205821039489;4820.1805693031565;4821.566059054702;4828.130936431336;4886.486918873609;4656.254999200111;4726.71639701619;4761.595264402565;4762.261849413347;4829.541193586604;4876.756162191805;4877.634177436636;4885.1450996076255;4903.215485522299;4924.359833221658;4740.0756852414825;4783;4783.306420569068;4796.688215265996;4822.180229361087 05:39:13 INFO - PROCESS | 3427 | |1;ext.html;586.1003359842642;593.9961465123938;613.7544982007198;624.1168746224093;629.8582818865756;34350.828245858764;35156.64843351566;35177.47233791495;35485.46771798425;35589.46615800765;35782.64217357826;36417;36478.27043459136;36483.81758091206;36527;7613.01030865988;7742.612869356538;7756.6509507072315;7772.727954521592;7778.144404115543;7653.9617301913695;7731.613419329039;7760.456768026241;7906.407019473562;7917.722879699211;7864.0956290026525;7923.168067352903;7962.1639727828615;7966.4025198110085;7991.800204994893;7857.449978501507;7884.60576971152;7926.643301051437;7931.682732690685;7939.047314322261;7891.053073631201;7990.520568765893;8006.239407256301;8007.639656215484;8033.839323213561;38515;39012.21975560473;39244.21511569752;39250.41124383137;39315.21369572593;2598.5322641924445;3046.36026434449;3390.86436542538;3640.3447379471686;3925.156091440354;26283.737162628513;28069.298267543272;28584.857075714695;28636.427271454453;28737.28156796076;3422.5379573757473;3433.2790114076074;3437.157896315419;3453.188500702333;3511.122219445139;202548;204315.99999999852;205126;205348;205891;54183.45816541784;54298.45701543013;54480.727596361765;54735.17897231545;54742.45257547373;62236;63984;63994;64011;64129.35870641327;13006.284654344103;13131.671708207372;13154.21074735519;13165.341732913315;13192.076554641275;10360;10385.896141038644;10486.580536778596;10492.16062714981;10504.474776261157;18653;18995.050247487572;19006.904965475085;19879.900600496905;20040.398788036382;7418.925810741932;7740.922590774133;7784.532928024337;7888.960555197187;8032.839343213103;849.362977766675;895.5611750242465;896.251629889037;918.6600957645713;931.9114684104999;25985.870070649526;26346.077887273852;26538;26559.46881062368;26858;908.4276905549461;923.2890674180843;929.3152649743798;939.4691999020531;939.8684184214216;14256.429742810378;14282.285885705673;14395.136291822524;14413.639659008608;14496.85503144955;355986;509081;522083.7270695507;525607.3719631378;527974;47405.288920666215;48041.75979120152;48061.5193848064;48157.51842481601;48446.75776621094;1223.1988047828686;1274.6367285323638;1281.7372438650054;1284.0241416523322;1294.873460089728;25773.484530308913;26599.202023939313;26800.463990719687;26826.19521414361;27069.511176885462;41030.58969410268;41510;41931.161376771684;42057.158856823306;42115;324338;325903;326184;326341;329167;25310.746892531577;25446.745532545177;25765.96936122534;37079.814600926824;38367.808160959015;36404.81797591101;36692.0826979317;37034.629653703116;37364;37753.62246377501;33615.15962100967;33616.83191584027;33896.322073557894;34123.829380852934;34612.82693586516;33499.33001340008;33542.16144596405;33914.8304258487;33995.15012124618;34130.48804267888;29560.408791824473;31782.52326215155;32182;33248;34441.48337774885;29514.409711805216;31513;31718.524222136224;36917.63082369142;38686.613133868304;25097.87451062733;25609.103681371063;25775.355616109748;26372.472550548497;27197.320066998484 05:39:13 INFO - PROCESS | 3427 | |2;jquery.html;367.9705623550116;385.93053250414914;394.5561243600949;397.6480814479187;399.1179493319763;15218.923905380472;16700.08149551774;16954.576135596617;17076.573085672866;17196.91401542992;14589.416423343053;14635.268236588154;15199.696006079872;15207.391704331814;15211.847881521182;5102.209157580572;5246.055709972204;5253.527182553569;5270.7628156733035;5282.683039017652;3650.5984341722387;5562.332520097594;6041.637501749887;6094;6106.358832322609;6014.729337179838;6022.939770602282;6033.909491357633;6048.697565121748;6141.754329826802;6340.3659634036685;6478.773242936498;6511.153550038512;6538.248101468321;6546.279909209983;6647;6692.966535167342;6708.966455167693;6731.192256929151;6744.359285867884;20162.495937601532;21928.122875084977;22086.779132208634;23204.53590928172;23214.303570892902;2061.299158286175;2103.24283258027;2114.4291041418883;2172.2288587551348;2267.2971378872603;13190.60428187156;13508.189508629514;14124.576262712135;14436.061655992431;14574.271286435636;1882.3694062489083;1898.2407037185098;1963.3324669612257;1973.3882496426154;2022.3326302320347;78706.60646696787;79268.60365698134;79940.20059799385;80106;81018.18981810224;15262.16058116792;16310.266038028318;16461.917690411712;16467.5883102921;16650.916745416194;29622.851885740864;29704.10887673373;29724.40551188964;29793;30048.39903201924;8051.677932882736;8226;8319.417640765208;8346.165383461605;8380.120087390858;6600.141981542369;6680.265170831205;6694.799156025327;6738.124043874265;6798.864022719518;7959.403044771665;8107.270345668918;8153.184681531918;8157.347412207009;8473.110323415953;1676.2205574407958;1728.9221985010704;1778.9110544472724;1779.6796576616075;1794.5693033672085;853.4665833853842;865.3164000439582;871.324723339417;887.2547060469237;951.2912879904516;14495.782563261559;15109.54671359861;15136.167510786792;16115.919420402823;16226.594335141479;848.520585868982;851.9190676885686;852.0627309959119;853.8591132463198;885.2033170146791;6546.639934803537;9014.59434325457;9049.864252036225;9233.261339092856;9249.676261330822;281175;287141;288829;403772;404800;74935;79734.601326993;81808;82226.58886705528;83431;928.3687092776977;958.5878072428923;966.6085235479642;971.0338213477494;985.9408435493893;13640.249786261455;14875.776863347275;14947.701045978802;15001.399944002118;15050.69898602;33275;34652.13369665779;34663.306733865684;34840.825795871875;34841.47737783885;40148.598514015655;42994.78502607592;43693;43698.470553530475;44184.33723494086;4272.764997925144;4377.124575084932;6814;7392.410631714207;7730.304272615492;8788.560571971504;9591.616335346507;11646.126540509666;11773;11871.228370155912;9584.568694408628;9915.801683966425;10091.848622270818;10164.949175254076;10213.489325533545;9815.803683926424;9877.160441362565;10050.748731281776;10093.495325233856;10259.281850270409;10246.6413675521;10399.064084232456;10465.633702820365;10491.895081049397;10494.422806745397;7093.290670932865;7258.564486130849;7273.781786546412;7381.667824947783;7459.40324774006;9855.162311203629;9885.950570247103;10178.440185789852;10200;10222.335548189343 05:39:13 INFO - PROCESS | 3427 | |3;mootools.html;1448.0008793932184;1491.336355321882;1623.983760162398;1772.0608077718814;1813.564744461329;7003.439724822015;7656.7320143794905;7732.072151341833;7878.645460954256;7917.129115797265;7758.224177582239;7801.687932482694;7845.137034926168;7854.332381747558;7855.450118491708;2251.9662205066898;2271.931842044741;2289.5420915816903;2291.3813270416977;2294.208498068164;2093.696414019966;2100.159936025587;2109.4726318420394;2157.374361435182;2256.4584499720113;2223.944401389962;2255.616545187314;2262.2760716570706;2272.1933713531707;2315.097112126272;2232.620454522735;2248.6402175651897;2260.2089268755967;2263.3775711679336;2268.988655056714;2224.3104637562246;2237.3176181264707;2241.854279471829;2241.8542794718455;2245.9887700561394;8006.3995200360205;8052.637631306547;8080.676772929076;8104.230098140667;8112.797180070486;4525.796339164713;4648.163330600491;4670.486246512881;4682.555157260055;4684.929726054112;2844.1751891951308;3091.134482344947;3118.454270502653;3118.953215701766;3148.212946763309;1792.5429015601069;1796.2725096336005;1826.6894627913287;1826.7168588868747;1838.347386677737;10192.184625229964;10343.275970682056;10368.688939331756;10371.274010819247;10383.688489345257;4024.1146947671464;4050.918981620351;4183.958160418418;4193.056562273525;4241.406203131564;8394;8415.284700800501;8464.66141354339;8655.523946182895;8705.738827835175;4572.45130584332;4576.4737055239075;4596.264597664358;4598.379218805485;4602.585767280961;3704.277665855186;4013.538443079025;4118.588141185917;4287.892802679896;4316.028893498938;3532.3288575170636;3558.87543935961;3594.4428613564937;3679.043448703303;3690.704743620504;1098.2257508456519;1117.899389054989;1131.7510147767478;1133.0708818768696;1136.5737848306885;853.7310747114639;860.5181098584812;865.8787769712245;870.0168809245512;875.5272153037289;5312.415634280226;5370.248165256867;5413.538344646923;5495.065838807413;5554.1946417769195;398.1896839930727;440.5858493016554;441.474645172244;444.0608113839207;446.4709319456455;3638.76348037382;3702.870399536057;3705.4256590228556;3721.627837216311;3735.626437356297;9312.767180820534;9654.662086826927;10191.592336306465;10207.7448063799;10269.640562580274;9611.134997850228;9619.615215391446;9649.903500965042;9696.224302055818;9714.22286217101;7126.608036558039;7179.138503379628;7189.712411503586;7215.701173788663;7464.888026679604;5626.662400255997;5671.801486947937;5682.14767784819;5685.772569097356;5902.144189092472;9212.631494740135;9224.815503689755;9252.49111298885;9339.972603013528;9409.059094090537;9050.230730387728;9065.728028159167;9305.674301399418;9421;9570.95214523923;6269.247690277196;6802.693878775368;6949.826254343682;7013;7032.050673159058;7458.8508229834015;7499.287567681062;7549.962250188714;7593.164751877179;7624;6880.724771009103;7126.895331223669;7143.67841949241;7148.749793757193;7261.891071633824;6820.693068812015;6884.449244060564;6892.758753443605;6913.308669133046;6967.581945083311;6193.690315484298;6379.170707807955;6399.488040956619;6547.70535325902;6556;4664.183767840546;4706.741129237787;4759.3336932830125;4786.928196077131;4801.039792041536;4738.099761045391;4795.832145874878;4803.95196048049;4844.0554091951735;4875.3174555562955 05:39:13 INFO - PROCESS | 3427 | |4;prototype.html;317.23071551487647;319.70587059904886;328.6926723513515;330.98345082745874;335.1554083709055;5214.139666954952;5252.290940723006;5284.260203571503;5306.70813105279;5317.9202311965355;5188.143956247215;5225.634205605609;5231.79072837087;5237.266782650432;5241.2924255225535;3835.654791068803;3890.1636148228126;4067.2068946555432;4077.2864748669012;4092.1201941582553;4012;4032.5362583303004;4058.2492238935893;4064.349704047353;4071.409645601401;4026.3557830747086;4044.757314561121;4056.736312139716;4059.3505039193733;4070.430139780433;3770.3967365221706;3962.7424217426064;3973.7417067890783;4060.817263223162;4066.5120185577625;3484.930301393958;3493.1616412061176;3503.404421248368;3504.281622267429;3504.56192975878;4916.237983112624;4920.778564964549;4922;4933.309336692866;4939.234418665077;4321.9135617287475;4556.908861822745;4586.931196032062;4600.263957766741;4610.3315019322345;5410.783568657249;5447.400785913546;5453.700046497441;5453.836384908459;5454.10007348791;3837.4052021936645;3842.6733727633186;3860.4402361657403;3866.5360156781085;3869.496965394509;5423.566114710814;5636.351819540764;5761;5762.366139724669;5782.074868021138;3919.235749028969;3936.012313781522;3946.6053394660303;3955.8219880105466;3978.5225772906856;3977.3437382831507;4000.3199456092534;4005.339119045325;4010.3382941814857;4012.859549915739;4590.931136032962;4593.356930029799;4600.6549508786975;4602.746848923274;4603.930941035887;5166.535011848951;5460.699661518575;5465.945340546544;5468.425815289417;5477.67133971955;1375.8692924172187;1387.7779555271109;1400.5728252882968;1407.4510940733123;1410.5486244401898;876.1501343696605;900.1583519409373;943.5848226780195;953.880764904387;960.2893858544627;4780.091782561302;4812.109759694467;4812.422509298906;4817.13291607514;4821.9035619287415;5484.875600501888;5622.437756224344;5627.071533197059;5641.069223578145;5643.887122257614;4630.665920537208;4714.882127946828;4725.50382209863;4763.73799441034;4766.428028636586;2964.43675701616;2972.1677930179585;3002.2194229500487;3006.7895247332913;3020.9848950755545;5247.63266571344;5285.445028272053;5319.813806516753;5326.9467305327225;5330.493603107699;5600.159976003632;5742.942570574241;5776.971115144397;5782.3639399666;5817.7382017809305;5311.840644780663;5320.813771518133;5339.119045357473;5343.385510666323;5353.4646535346155;5424.783008679767;5595.40530948694;5607.859803504945;5618.775248990158;5628.324601047901;5484.8354549363585;5485.75314110858;5498.202760599771;5526.50261476469;5531.917021244604;5270.657407268515;5279.762410691451;5319.920201197063;5320.228566857862;5330.2804121443105;3815.065308999313;3931.253061918226;3939.4484772132496;3941.507311586052;3944.2308749793515;5542.196381524575;5561.916571251353;5563.944360556343;5566.387697353369;5574.804881829116;5333.280007198979;5352.143657014859;5388.814460818614;5404.243405923253;5418.620696551204;5264.2630031794815;5346.957343318016;5361.865953351197;5369.785208591768;5397.892042159214;5282.4717528246865;5290.539898946854;5312.4156342803035;5321.3880403754065;5331.280277162534;5248.737563121905;5324.121519949165;5515.641483303572;5530.91703624454;5536.695481748542;5338.75975581092;5339.652922560022;5363.865903352447;5364.14173732201;5391.191321301836 05:39:13 INFO - PROCESS | 3427 | |5;yui.html;706.106774929714;734.280405202901;742.361569050616;753.0511555440145;757.2994979643831;11949.58176463824;12215.267083974968;12350.258984460927;14071.788923166136;14621.12273263605;12878.4204710788;13206;13298.667533311673;13322.333883305844;13352.732945341088;645.1677336236249;826.3926014379426;844.67902197165;844.8394804987048;850.1795767084762;843.1399972028527;852.2755657690975;853.8633818589027;856.3534531428762;858.107568129148;888.1296329596998;888.3781353052857;889.7820034091657;890.145460358057;890.4568213389826;872.1583671756786;875.1511034296722;879.2394578689451;881.378628067211;885.1679421343916;650.5738741124571;650.7006776882592;651.6057785040077;651.8663673946829;653.0335104046038;13559.864401355959;13570.864291357157;13598.11612245201;13610.251436171007;13610.319484025858;12561.371931403484;12598.874011259863;12690.80963785544;12692.492300307977;12907.806382904264;10357.4303413313;10426.739331516697;10461.110805581535;10654.147668186526;10744.409057501834;3285.8685652573868;3348.5479460272795;3377.527146199534;3378.3918894598964;3392.355452464024;52064.21903671448;52253.47746522524;52373;52399.73800130975;52916.735416323056;9688.75778105553;10046.799064018678;10143.797124057477;10196.643117490852;10297.227707921937;16291.185440727917;17186.31254749796;17260.568485787957;17281.39515116965;17292.308307667554;6818.965905170541;6944.861102777916;6962.686679099453;7142.250063743336;7211.134663840373;3680.245549662313;3696.149885526344;3832.6358995895343;3841.682756831429;3919.5884432134217;2758.0622588320066;2838.914832555027;2850.2019434558356;2851.3726980064353;2853;540.2220802045042;543.0550841535778;545.0760960172548;549.3023859698161;550.9228707980886;514.6603241860354;592.2182718811214;639.587466084373;643.9742410303535;657.6202491407205;7971.641276142587;7976.282134607797;7998.721802258903;8137.145599711945;8181;511.43231013574905;564.1678524176806;607;620.8665136995568;638.113022898172;3651.8904432867057;3778.471014058034;3823.4264860271182;3853.2678791029616;3893;46528.76735616368;47029.764851175525;47115.528844711116;47395.76302118536;47520;44016.3397549037;45034.54965450369;45195;45208.54791452044;45548.08903821905;40804;41461.37807932883;41712.58287417148;41952.79023604924;42174.57825421768;7250.457693226082;7365.292673471974;7421.591812450367;7427.554346739213;7495.475316727777;25449.38599734221;25860.353491162117;26220;27078.593821093094;28687.13938581846;34244.143896401794;34994.650053499136;35016.82491587526;35262.294754105285;35498.82250588731;10696.465176741287;10783.568657253621;10990.560377584807;10999.23005389615;11062.391568463812;11751.353675547927;12001.459934302802;12116.575919842764;12132.696682583006;12142.542894852675;10515.106215971422;10588.841167382341;11084.445777711244;11333.829992550283;11375.658730238107;10839.295445795999;10888.18338624622;10952.371450805154;11008.724781880197;11110.166737494881;10745.785084298113;10766.192535559707;10844.295120817122;11445.828312575151;11585.420728963687;9128.771780705536;9433.198178154658;9870.210383169473;9989.700308990741;9990.600375984879;9198.310126740655;9680.951595241979;9758.560864761244;9854.950725246328;9953.701388958343 05:39:13 INFO - PROCESS | 3427 | __end_tp_report 05:39:13 INFO - PROCESS | 3427 | __start_cc_report 05:39:13 INFO - PROCESS | 3427 | _x_x_mozilla_cycle_collect,355 05:39:13 INFO - PROCESS | 3427 | __end_cc_report 05:39:13 INFO - PROCESS | 3427 | __startTimestamp1460551153987__endTimestamp 05:39:13 INFO - PROCESS | 3427 | 05:39:13 INFO - PROCESS | 3427 | ------- Summary: start ------- 05:39:13 INFO - PROCESS | 3427 | Number of tests: 6 05:39:13 INFO - PROCESS | 3427 | 05:39:13 INFO - PROCESS | 3427 | [#0] dojo.html Cycles:165 Average:4577.96 Median:4732.17 stddev:469.62 (9.9%) stddev-sans-first:445.09 05:39:14 INFO - PROCESS | 3427 | Values: 2614.8 2646.0 2669.4 2677.0 2690.3 4603.0 4611.9 4618.4 4631.6 4678.0 4534.8 4551.5 4604.8 4613.8 4618.1 4243.0 4263.4 4330.7 4338.2 4341.9 4276.1 4295.7 4316.9 4338.2 4392.1 4174.1 4228.2 4243.0 4259.9 4275.8 4209.8 4234.0 4244.9 4279.7 4285.4 4195.7 4218.8 4226.0 4227.1 4269.2 4513.8 4548.0 4554.8 4584.9 4595.6 4941.2 4954.4 4954.8 4965.6 4971.2 4820.0 4968.4 4995.3 5008.5 5029.5 4623.8 4624.3 4642.8 4649.1 4653.1 4962.8 5033.5 5049.3 5069.5 5108.7 4788.9 4824.7 4876.8 4881.6 4892.9 4790.1 4920.4 4978.9 4979.4 5047.6 4888.8 4896.7 4906.5 4908.2 4948.9 4782.5 4876.8 4895.7 4911.6 4952.9 4115.4 4123.2 4124.2 4132.7 4165.6 3624.1 3635.8 3653.2 3653.5 3656.3 4262.4 4268.8 4272.3 4296.5 4303.1 4907.3 4954.9 4971.6 4991.1 5006.0 4228.3 4318.8 4329.9 4330.6 4374.0 4443.2 4457.3 4459.4 4506.5 4516.5 4713.2 4741.8 4745.6 4754.5 4780.2 4893.4 4982.0 4982.1 4983.4 4996.8 4696.5 4711.2 4712.0 4745.3 4749.4 4840.1 4853.6 4860.4 4868.1 4940.0 4898.5 4930.6 4939.5 4972.3 5024.9 4687.6 4732.2 4788.2 4788.8 4825.2 4813.2 4820.2 4821.6 4828.1 4886.5 4656.3 4726.7 4761.6 4762.3 4829.5 4876.8 4877.6 4885.1 4903.2 4924.4 4740.1 4783.0 4783.3 4796.7 4822.2 05:39:14 INFO - PROCESS | 3427 | 05:39:14 INFO - PROCESS | 3427 | [#1] ext.html Cycles:180 Average:48911.41 Median:19711.49 stddev:96168.15 (487.9%) stddev-sans-first:96369.48 05:39:14 INFO - PROCESS | 3427 | Values: 586.1 594.0 613.8 624.1 629.9 34350.8 35156.6 35177.5 35485.5 35589.5 35782.6 36417.0 36478.3 36483.8 36527.0 7613.0 7742.6 7756.7 7772.7 7778.1 7654.0 7731.6 7760.5 7906.4 7917.7 7864.1 7923.2 7962.2 7966.4 7991.8 7857.4 7884.6 7926.6 7931.7 7939.0 7891.1 7990.5 8006.2 8007.6 8033.8 38515.0 39012.2 39244.2 39250.4 39315.2 2598.5 3046.4 3390.9 3640.3 3925.2 26283.7 28069.3 28584.9 28636.4 28737.3 3422.5 3433.3 3437.2 3453.2 3511.1 202548.0 204316.0 205126.0 205348.0 205891.0 54183.5 54298.5 54480.7 54735.2 54742.5 62236.0 63984.0 63994.0 64011.0 64129.4 13006.3 13131.7 13154.2 13165.3 13192.1 10360.0 10385.9 10486.6 10492.2 10504.5 18653.0 18995.1 19006.9 19879.9 20040.4 7418.9 7740.9 7784.5 7889.0 8032.8 849.4 895.6 896.3 918.7 931.9 25985.9 26346.1 26538.0 26559.5 26858.0 908.4 923.3 929.3 939.5 939.9 14256.4 14282.3 14395.1 14413.6 14496.9 355986.0 509081.0 522083.7 525607.4 527974.0 47405.3 48041.8 48061.5 48157.5 48446.8 1223.2 1274.6 1281.7 1284.0 1294.9 25773.5 26599.2 26800.5 26826.2 27069.5 41030.6 41510.0 41931.2 42057.2 42115.0 324338.0 325903.0 326184.0 326341.0 329167.0 25310.7 25446.7 25766.0 37079.8 38367.8 36404.8 36692.1 37034.6 37364.0 37753.6 33615.2 33616.8 33896.3 34123.8 34612.8 33499.3 33542.2 33914.8 33995.2 34130.5 29560.4 31782.5 32182.0 33248.0 34441.5 29514.4 31513.0 31718.5 36917.6 38686.6 25097.9 25609.1 25775.4 26372.5 27197.3 05:39:14 INFO - PROCESS | 3427 | 05:39:14 INFO - PROCESS | 3427 | [#2] jquery.html Cycles:180 Average:23608.13 Median:43343.89 stddev:56441.42 (130.2%) stddev-sans-first:56572.78 05:39:14 INFO - PROCESS | 3427 | Values: 368.0 385.9 394.6 397.6 399.1 15218.9 16700.1 16954.6 17076.6 17196.9 14589.4 14635.3 15199.7 15207.4 15211.8 5102.2 5246.1 5253.5 5270.8 5282.7 3650.6 5562.3 6041.6 6094.0 6106.4 6014.7 6022.9 6033.9 6048.7 6141.8 6340.4 6478.8 6511.2 6538.2 6546.3 6647.0 6693.0 6709.0 6731.2 6744.4 20162.5 21928.1 22086.8 23204.5 23214.3 2061.3 2103.2 2114.4 2172.2 2267.3 13190.6 13508.2 14124.6 14436.1 14574.3 1882.4 1898.2 1963.3 1973.4 2022.3 78706.6 79268.6 79940.2 80106.0 81018.2 15262.2 16310.3 16461.9 16467.6 16650.9 29622.9 29704.1 29724.4 29793.0 30048.4 8051.7 8226.0 8319.4 8346.2 8380.1 6600.1 6680.3 6694.8 6738.1 6798.9 7959.4 8107.3 8153.2 8157.3 8473.1 1676.2 1728.9 1778.9 1779.7 1794.6 853.5 865.3 871.3 887.3 951.3 14495.8 15109.5 15136.2 16115.9 16226.6 848.5 851.9 852.1 853.9 885.2 6546.6 9014.6 9049.9 9233.3 9249.7 281175.0 287141.0 288829.0 403772.0 404800.0 74935.0 79734.6 81808.0 82226.6 83431.0 928.4 958.6 966.6 971.0 985.9 13640.2 14875.8 14947.7 15001.4 15050.7 33275.0 34652.1 34663.3 34840.8 34841.5 40148.6 42994.8 43693.0 43698.5 44184.3 4272.8 4377.1 6814.0 7392.4 7730.3 8788.6 9591.6 11646.1 11773.0 11871.2 9584.6 9915.8 10091.8 10164.9 10213.5 9815.8 9877.2 10050.7 10093.5 10259.3 10246.6 10399.1 10465.6 10491.9 10494.4 7093.3 7258.6 7273.8 7381.7 7459.4 9855.2 9886.0 10178.4 10200.0 10222.3 05:39:14 INFO - PROCESS | 3427 | 05:39:14 INFO - PROCESS | 3427 | [#3] mootools.html Cycles:180 Average:5226.30 Median:4748.72 stddev:2866.63 (60.4%) stddev-sans-first:2860.61 05:39:14 INFO - PROCESS | 3427 | Values: 1448.0 1491.3 1624.0 1772.1 1813.6 7003.4 7656.7 7732.1 7878.6 7917.1 7758.2 7801.7 7845.1 7854.3 7855.5 2252.0 2271.9 2289.5 2291.4 2294.2 2093.7 2100.2 2109.5 2157.4 2256.5 2223.9 2255.6 2262.3 2272.2 2315.1 2232.6 2248.6 2260.2 2263.4 2269.0 2224.3 2237.3 2241.9 2241.9 2246.0 8006.4 8052.6 8080.7 8104.2 8112.8 4525.8 4648.2 4670.5 4682.6 4684.9 2844.2 3091.1 3118.5 3119.0 3148.2 1792.5 1796.3 1826.7 1826.7 1838.3 10192.2 10343.3 10368.7 10371.3 10383.7 4024.1 4050.9 4184.0 4193.1 4241.4 8394.0 8415.3 8464.7 8655.5 8705.7 4572.5 4576.5 4596.3 4598.4 4602.6 3704.3 4013.5 4118.6 4287.9 4316.0 3532.3 3558.9 3594.4 3679.0 3690.7 1098.2 1117.9 1131.8 1133.1 1136.6 853.7 860.5 865.9 870.0 875.5 5312.4 5370.2 5413.5 5495.1 5554.2 398.2 440.6 441.5 444.1 446.5 3638.8 3702.9 3705.4 3721.6 3735.6 9312.8 9654.7 10191.6 10207.7 10269.6 9611.1 9619.6 9649.9 9696.2 9714.2 7126.6 7179.1 7189.7 7215.7 7464.9 5626.7 5671.8 5682.1 5685.8 5902.1 9212.6 9224.8 9252.5 9340.0 9409.1 9050.2 9065.7 9305.7 9421.0 9571.0 6269.2 6802.7 6949.8 7013.0 7032.1 7458.9 7499.3 7550.0 7593.2 7624.0 6880.7 7126.9 7143.7 7148.7 7261.9 6820.7 6884.4 6892.8 6913.3 6967.6 6193.7 6379.2 6399.5 6547.7 6556.0 4664.2 4706.7 4759.3 4786.9 4801.0 4738.1 4795.8 4804.0 4844.1 4875.3 05:39:14 INFO - PROCESS | 3427 | 05:39:14 INFO - PROCESS | 3427 | [#4] prototype.html Cycles:180 Average:4507.98 Median:5239.28 stddev:1314.03 (25.1%) stddev-sans-first:1279.52 05:39:14 INFO - PROCESS | 3427 | Values: 317.2 319.7 328.7 331.0 335.2 5214.1 5252.3 5284.3 5306.7 5317.9 5188.1 5225.6 5231.8 5237.3 5241.3 3835.7 3890.2 4067.2 4077.3 4092.1 4012.0 4032.5 4058.2 4064.3 4071.4 4026.4 4044.8 4056.7 4059.4 4070.4 3770.4 3962.7 3973.7 4060.8 4066.5 3484.9 3493.2 3503.4 3504.3 3504.6 4916.2 4920.8 4922.0 4933.3 4939.2 4321.9 4556.9 4586.9 4600.3 4610.3 5410.8 5447.4 5453.7 5453.8 5454.1 3837.4 3842.7 3860.4 3866.5 3869.5 5423.6 5636.4 5761.0 5762.4 5782.1 3919.2 3936.0 3946.6 3955.8 3978.5 3977.3 4000.3 4005.3 4010.3 4012.9 4590.9 4593.4 4600.7 4602.7 4603.9 5166.5 5460.7 5465.9 5468.4 5477.7 1375.9 1387.8 1400.6 1407.5 1410.5 876.2 900.2 943.6 953.9 960.3 4780.1 4812.1 4812.4 4817.1 4821.9 5484.9 5622.4 5627.1 5641.1 5643.9 4630.7 4714.9 4725.5 4763.7 4766.4 2964.4 2972.2 3002.2 3006.8 3021.0 5247.6 5285.4 5319.8 5326.9 5330.5 5600.2 5742.9 5777.0 5782.4 5817.7 5311.8 5320.8 5339.1 5343.4 5353.5 5424.8 5595.4 5607.9 5618.8 5628.3 5484.8 5485.8 5498.2 5526.5 5531.9 5270.7 5279.8 5319.9 5320.2 5330.3 3815.1 3931.3 3939.4 3941.5 3944.2 5542.2 5561.9 5563.9 5566.4 5574.8 5333.3 5352.1 5388.8 5404.2 5418.6 5264.3 5347.0 5361.9 5369.8 5397.9 5282.5 5290.5 5312.4 5321.4 5331.3 5248.7 5324.1 5515.6 5530.9 5536.7 5338.8 5339.7 5363.9 5364.1 5391.2 05:39:14 INFO - PROCESS | 3427 | 05:39:14 INFO - PROCESS | 3427 | [#5] yui.html Cycles:180 Average:12670.15 Median:41586.98 stddev:14097.20 (33.9%) stddev-sans-first:14108.12 05:39:14 INFO - PROCESS | 3427 | Values: 706.1 734.3 742.4 753.1 757.3 11949.6 12215.3 12350.3 14071.8 14621.1 12878.4 13206.0 13298.7 13322.3 13352.7 645.2 826.4 844.7 844.8 850.2 843.1 852.3 853.9 856.4 858.1 888.1 888.4 889.8 890.1 890.5 872.2 875.2 879.2 881.4 885.2 650.6 650.7 651.6 651.9 653.0 13559.9 13570.9 13598.1 13610.3 13610.3 12561.4 12598.9 12690.8 12692.5 12907.8 10357.4 10426.7 10461.1 10654.1 10744.4 3285.9 3348.5 3377.5 3378.4 3392.4 52064.2 52253.5 52373.0 52399.7 52916.7 9688.8 10046.8 10143.8 10196.6 10297.2 16291.2 17186.3 17260.6 17281.4 17292.3 6819.0 6944.9 6962.7 7142.3 7211.1 3680.2 3696.1 3832.6 3841.7 3919.6 2758.1 2838.9 2850.2 2851.4 2853.0 540.2 543.1 545.1 549.3 550.9 514.7 592.2 639.6 644.0 657.6 7971.6 7976.3 7998.7 8137.1 8181.0 511.4 564.2 607.0 620.9 638.1 3651.9 3778.5 3823.4 3853.3 3893.0 46528.8 47029.8 47115.5 47395.8 47520.0 44016.3 45034.5 45195.0 45208.5 45548.1 40804.0 41461.4 41712.6 41952.8 42174.6 7250.5 7365.3 7421.6 7427.6 7495.5 25449.4 25860.4 26220.0 27078.6 28687.1 34244.1 34994.7 35016.8 35262.3 35498.8 10696.5 10783.6 10990.6 10999.2 11062.4 11751.4 12001.5 12116.6 12132.7 12142.5 10515.1 10588.8 11084.4 11333.8 11375.7 10839.3 10888.2 10952.4 11008.7 11110.2 10745.8 10766.2 10844.3 11445.8 11585.4 9128.8 9433.2 9870.2 9989.7 9990.6 9198.3 9681.0 9758.6 9855.0 9953.7 05:39:14 INFO - PROCESS | 3427 | -------- Summary: end -------- 05:39:14 INFO - PROCESS | 3427 | 05:39:14 INFO - TEST-INFO | 3427: exit 0 05:39:14 INFO - TEST-OK | dromaeo_css | took 1118126ms 05:39:14 INFO - TEST-START | kraken 05:39:14 INFO - operating with platform_type : linux_ 05:39:14 INFO - Initialising browser for kraken test... 05:39:14 INFO - TEST-INFO | started process 3696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD0Wkux/profile http://localhost:36633/getInfo.html) 05:39:18 INFO - PROCESS | 3696 | 05:39:18 INFO - PROCESS | 3696 | (process:3762): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:39:19 INFO - PROCESS | 3696 | 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] 05:39:19 INFO - PROCESS | 3696 | __metrics Screen width/height:1600/1200 05:39:19 INFO - PROCESS | 3696 | colorDepth:24 05:39:19 INFO - PROCESS | 3696 | Browser inner width/height: 1024/697 05:39:19 INFO - PROCESS | 3696 | __metrics 05:39:20 ERROR - PROCESS | 3696 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:39:21 INFO - TEST-INFO | 3696: exit 0 05:39:21 INFO - Browser initialized. 05:39:21 INFO - Running cycle 1/1 for kraken test... 05:39:21 INFO - TEST-INFO | started process 3813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD0Wkux/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:23 INFO - PROCESS | 3813 | 05:39:23 INFO - PROCESS | 3813 | (process:3874): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:39:33 INFO - PROCESS | 3813 | RSS: Main: 164892672 05:39:33 INFO - PROCESS | 3813 | 05:39:36 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36633/tests/kraken/driver.html?testName=audio-beat-detection) 05:39:37 INFO - PROCESS | 3813 | RSS: Main: 168796160 05:39:37 INFO - PROCESS | 3813 | 05:39:39 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36633/tests/kraken/driver.html?testName=audio-dft) 05:39:40 INFO - PROCESS | 3813 | RSS: Main: 172404736 05:39:40 INFO - PROCESS | 3813 | 05:39:43 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36633/tests/kraken/driver.html?testName=audio-fft) 05:39:44 INFO - PROCESS | 3813 | RSS: Main: 165707776 05:39:44 INFO - PROCESS | 3813 | 05:39:46 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36633/tests/kraken/driver.html?testName=audio-oscillator) 05:39:46 INFO - PROCESS | 3813 | RSS: Main: 165875712 05:39:46 INFO - PROCESS | 3813 | 05:39:49 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36633/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:39:49 INFO - PROCESS | 3813 | RSS: Main: 166215680 05:39:49 INFO - PROCESS | 3813 | 05:39:52 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36633/tests/kraken/driver.html?testName=imaging-darkroom) 05:39:53 INFO - PROCESS | 3813 | RSS: Main: 166060032 05:39:53 INFO - PROCESS | 3813 | 05:39:56 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36633/tests/kraken/driver.html?testName=imaging-desaturate) 05:39:57 INFO - PROCESS | 3813 | RSS: Main: 163307520 05:39:57 INFO - PROCESS | 3813 | 05:40:00 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36633/tests/kraken/driver.html?testName=json-parse-financial) 05:40:01 INFO - PROCESS | 3813 | RSS: Main: 164093952 05:40:01 INFO - PROCESS | 3813 | 05:40:02 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36633/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:40:03 INFO - PROCESS | 3813 | RSS: Main: 164433920 05:40:03 INFO - PROCESS | 3813 | 05:40:05 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:40:05 INFO - PROCESS | 3813 | RSS: Main: 164339712 05:40:05 INFO - PROCESS | 3813 | 05:40:08 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:40:08 INFO - PROCESS | 3813 | RSS: Main: 164876288 05:40:08 INFO - PROCESS | 3813 | 05:40:13 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:40:14 INFO - PROCESS | 3813 | RSS: Main: 163598336 05:40:14 INFO - PROCESS | 3813 | 05:40:17 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:40:17 INFO - PROCESS | 3813 | RSS: Main: 163373056 05:40:17 INFO - PROCESS | 3813 | 05:40:19 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:36633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36633/tests/kraken/driver.html?testName=ai-astar) 05:40:20 INFO - PROCESS | 3813 | RSS: Main: 165318656 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | __start_tp_report 05:40:20 INFO - PROCESS | 3813 | _x_x_mozilla_page_load 05:40:20 INFO - PROCESS | 3813 | _x_x_mozilla_page_load_details 05:40:20 INFO - PROCESS | 3813 | |i|pagename|runs| 05:40:20 INFO - PROCESS | 3813 | |0;ai-astar;117;111;113;113;116;127;113;114;115;115 05:40:20 INFO - PROCESS | 3813 | |1;audio-beat-detection;164;131;158;181;135;158;162;135;183;134 05:40:20 INFO - PROCESS | 3813 | |2;audio-dft;165;163;163;164;175;163;162;170;166;166 05:40:20 INFO - PROCESS | 3813 | |3;audio-fft;74;75;75;146;75;75;77;74;158;76 05:40:20 INFO - PROCESS | 3813 | |4;audio-oscillator;95;93;153;94;94;95;146;95;95;147 05:40:20 INFO - PROCESS | 3813 | |5;imaging-gaussian-blur;117;117;118;118;118;118;118;117;118;118 05:40:20 INFO - PROCESS | 3813 | |6;imaging-darkroom;148;148;148;148;146;148;147;148;146;148 05:40:20 INFO - PROCESS | 3813 | |7;imaging-desaturate;95;97;96;96;96;96;96;96;96;96 05:40:20 INFO - PROCESS | 3813 | |8;json-parse-financial;67;65;64;68;64;63;64;91;62;66 05:40:20 INFO - PROCESS | 3813 | |9;json-stringify-tinderbox;63;64;63;64;65;64;63;64;64;66 05:40:20 INFO - PROCESS | 3813 | |10;stanford-crypto-aes;93;83;85;93;86;85;86;94;87;85 05:40:20 INFO - PROCESS | 3813 | |11;stanford-crypto-ccm;139;137;138;150;145;150;141;140;152;144 05:40:20 INFO - PROCESS | 3813 | |12;stanford-crypto-pbkdf2;183;180;184;177;172;175;177;183;175;177 05:40:20 INFO - PROCESS | 3813 | |13;stanford-crypto-sha256-iterative;73;75;75;75;74;71;73;71;73;71 05:40:20 INFO - PROCESS | 3813 | __end_tp_report 05:40:20 INFO - PROCESS | 3813 | __start_cc_report 05:40:20 INFO - PROCESS | 3813 | _x_x_mozilla_cycle_collect,912 05:40:20 INFO - PROCESS | 3813 | __end_cc_report 05:40:20 INFO - PROCESS | 3813 | __startTimestamp1460551220014__endTimestamp 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | ------- Summary: start ------- 05:40:20 INFO - PROCESS | 3813 | Number of tests: 14 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.00 stddev:4.43 (3.8%) stddev-sans-first:4.66 05:40:20 INFO - PROCESS | 3813 | Values: 117.0 111.0 113.0 113.0 116.0 127.0 113.0 114.0 115.0 115.0 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | [#1] audio-beat-detection Cycles:10 Average:154.10 Median:160.00 stddev:19.48 (12.2%) stddev-sans-first:20.33 05:40:20 INFO - PROCESS | 3813 | Values: 164.0 131.0 158.0 181.0 135.0 158.0 162.0 135.0 183.0 134.0 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | [#2] audio-dft Cycles:10 Average:165.70 Median:165.50 stddev:4.00 (2.4%) stddev-sans-first:4.24 05:40:20 INFO - PROCESS | 3813 | Values: 165.0 163.0 163.0 164.0 175.0 163.0 162.0 170.0 166.0 166.0 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | [#3] audio-fft Cycles:10 Average:90.50 Median:75.00 stddev:32.55 (43.4%) stddev-sans-first:33.97 05:40:20 INFO - PROCESS | 3813 | Values: 74.0 75.0 75.0 146.0 75.0 75.0 77.0 74.0 158.0 76.0 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:94.50 stddev:26.27 (27.8%) stddev-sans-first:27.24 05:40:20 INFO - PROCESS | 3813 | Values: 95.0 93.0 153.0 94.0 94.0 95.0 146.0 95.0 95.0 147.0 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 05:40:20 INFO - PROCESS | 3813 | Values: 117.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 05:40:20 INFO - PROCESS | 3813 | Values: 148.0 148.0 148.0 148.0 146.0 148.0 147.0 148.0 146.0 148.0 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 05:40:20 INFO - PROCESS | 3813 | Values: 95.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:65.50 stddev:8.49 (13.0%) stddev-sans-first:9.00 05:40:20 INFO - PROCESS | 3813 | Values: 67.0 65.0 64.0 68.0 64.0 63.0 64.0 91.0 62.0 66.0 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 05:40:20 INFO - PROCESS | 3813 | Values: 63.0 64.0 63.0 64.0 65.0 64.0 63.0 64.0 64.0 66.0 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:86.50 stddev:4.03 (4.7%) stddev-sans-first:3.79 05:40:20 INFO - PROCESS | 3813 | Values: 93.0 83.0 85.0 93.0 86.0 85.0 86.0 94.0 87.0 85.0 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:144.50 stddev:5.48 (3.8%) stddev-sans-first:5.56 05:40:20 INFO - PROCESS | 3813 | Values: 139.0 137.0 138.0 150.0 145.0 150.0 141.0 140.0 152.0 144.0 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:178.50 stddev:4.03 (2.3%) stddev-sans-first:3.90 05:40:20 INFO - PROCESS | 3813 | Values: 183.0 180.0 184.0 177.0 172.0 175.0 177.0 183.0 175.0 177.0 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - PROCESS | 3813 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:73.50 stddev:1.66 (2.3%) stddev-sans-first:1.76 05:40:20 INFO - PROCESS | 3813 | Values: 73.0 75.0 75.0 75.0 74.0 71.0 73.0 71.0 73.0 71.0 05:40:20 INFO - PROCESS | 3813 | -------- Summary: end -------- 05:40:20 INFO - PROCESS | 3813 | 05:40:20 INFO - TEST-INFO | 3813: exit 0 05:40:21 INFO - TEST-OK | kraken | took 66267ms 05:40:21 INFO - SUITE-END | took 1184s 05:40:21 INFO - Completed test suite (00:19:44) 05:40:21 INFO - javascript benchmark 05:40:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2614.790816734661, 2646.047422927747, 2669.4260733942197, 2676.9732302676966, 2690.300521864315, 4602.953970460303, 4611.907761844761, 4618.422697162855, 4631.629469642429, 4678.041001594674, 4534.773261336936, 4551.476580193279, 4604.838830640928, 4613.8154473821005, 4618.076384723052, 4243.0, 4263.424437700902, 4330.675199360045, 4338.2191205582985, 4341.936225624726, 4276.123394704094, 4295.720778149426, 4316.935245971313, 4338.197433474817, 4392.143532011259, 4174.0817020255645, 4228.238916994939, 4243.024104455962, 4259.87220383389, 4275.764832934187, 4209.768462734548, 4233.957660423418, 4244.851430199959, 4279.700420970502, 4285.378620100099, 4195.7063005589625, 4218.767967761772, 4226.028013556899, 4227.133437645275, 4269.231538323101, 4513.842015529473, 4547.954520454786, 4554.817807287704, 4584.908301833978, 4595.586397224232, 4941.1847045237855, 4954.43024052235, 4954.801807927679, 4965.627577931669, 4971.229459433794, 4820.0, 4968.403791545002, 4995.325631039836, 5008.524190201925, 5029.471905449912, 4623.838165664186, 4624.283236098377, 4642.814287428465, 4649.070185962821, 4653.092646933849, 4962.751862406865, 5033.546980771748, 5049.293098966147, 5069.5437410632485, 5108.693478391308, 4788.880277993008, 4824.734639594786, 4876.82931097417, 4881.585065269421, 4892.877678058077, 4790.113828941657, 4920.4095508538485, 4978.875528111754, 4979.402471703419, 5047.596192304681, 4888.828890988798, 4896.730679812645, 4906.484819093944, 4908.239222920453, 4948.851534453972, 4782.545658162469, 4876.780544875489, 4895.73073480962, 4911.607071434277, 4952.925706114411, 4115.36211887158, 4123.154753275631, 4124.195781822576, 4132.73137246078, 4165.645920096765, 3624.130208749934, 3635.781853088823, 3653.2328211075974, 3653.488511608377, 3656.323580137683, 4262.381954616563, 4268.829246830154, 4272.33778764292, 4296.5273819879785, 4303.07483890965, 4907.263910413395, 4954.8761280968265, 4971.577415919615, 4991.101601711654, 5006.048850718352, 4228.323468245066, 4318.805653745589, 4329.891752706208, 4330.610245077958, 4374.03771170342, 4443.155800397914, 4457.2645513489915, 4459.353393757887, 4506.504284528699, 4516.525764794715, 4713.2458806590785, 4741.810327586858, 4745.620350372031, 4754.500777418321, 4780.1873681473535, 4893.437254715754, 4981.950180498148, 4982.078315511497, 4983.401991761012, 4996.825111121093, 4696.483386827515, 4711.246200607886, 4712.0104777997, 4745.311929770095, 4749.35883655702, 4840.128776820206, 4853.635977301646, 4860.416749990024, 4868.099401610713, 4940.036692844861, 4898.461169271449, 4930.6055515557955, 4939.456659767495, 4972.279019542074, 5024.924626130684, 4687.578117969263, 4732.171869922819, 4788.186008378514, 4788.760561971957, 4825.203841366135, 4813.205821039489, 4820.1805693031565, 4821.566059054702, 4828.130936431336, 4886.486918873609, 4656.254999200111, 4726.71639701619, 4761.595264402565, 4762.261849413347, 4829.541193586604, 4876.756162191805, 4877.634177436636, 4885.1450996076255, 4903.215485522299, 4924.359833221658, 4740.0756852414825, 4783.0, 4783.306420569068, 4796.688215265996, 4822.180229361087], "value": 4548.916925549788, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.1003359842642, 593.9961465123938, 613.7544982007198, 624.1168746224093, 629.8582818865756, 34350.828245858764, 35156.64843351566, 35177.47233791495, 35485.46771798425, 35589.46615800765, 35782.64217357826, 36417.0, 36478.27043459136, 36483.81758091206, 36527.0, 7613.01030865988, 7742.612869356538, 7756.6509507072315, 7772.727954521592, 7778.144404115543, 7653.9617301913695, 7731.613419329039, 7760.456768026241, 7906.407019473562, 7917.722879699211, 7864.0956290026525, 7923.168067352903, 7962.1639727828615, 7966.4025198110085, 7991.800204994893, 7857.449978501507, 7884.60576971152, 7926.643301051437, 7931.682732690685, 7939.047314322261, 7891.053073631201, 7990.520568765893, 8006.239407256301, 8007.639656215484, 8033.839323213561, 38515.0, 39012.21975560473, 39244.21511569752, 39250.41124383137, 39315.21369572593, 2598.5322641924445, 3046.36026434449, 3390.86436542538, 3640.3447379471686, 3925.156091440354, 26283.737162628513, 28069.298267543272, 28584.857075714695, 28636.427271454453, 28737.28156796076, 3422.5379573757473, 3433.2790114076074, 3437.157896315419, 3453.188500702333, 3511.122219445139, 202548.0, 204315.99999999852, 205126.0, 205348.0, 205891.0, 54183.45816541784, 54298.45701543013, 54480.727596361765, 54735.17897231545, 54742.45257547373, 62236.0, 63984.0, 63994.0, 64011.0, 64129.35870641327, 13006.284654344103, 13131.671708207372, 13154.21074735519, 13165.341732913315, 13192.076554641275, 10360.0, 10385.896141038644, 10486.580536778596, 10492.16062714981, 10504.474776261157, 18653.0, 18995.050247487572, 19006.904965475085, 19879.900600496905, 20040.398788036382, 7418.925810741932, 7740.922590774133, 7784.532928024337, 7888.960555197187, 8032.839343213103, 849.362977766675, 895.5611750242465, 896.251629889037, 918.6600957645713, 931.9114684104999, 25985.870070649526, 26346.077887273852, 26538.0, 26559.46881062368, 26858.0, 908.4276905549461, 923.2890674180843, 929.3152649743798, 939.4691999020531, 939.8684184214216, 14256.429742810378, 14282.285885705673, 14395.136291822524, 14413.639659008608, 14496.85503144955, 355986.0, 509081.0, 522083.7270695507, 525607.3719631378, 527974.0, 47405.288920666215, 48041.75979120152, 48061.5193848064, 48157.51842481601, 48446.75776621094, 1223.1988047828686, 1274.6367285323638, 1281.7372438650054, 1284.0241416523322, 1294.873460089728, 25773.484530308913, 26599.202023939313, 26800.463990719687, 26826.19521414361, 27069.511176885462, 41030.58969410268, 41510.0, 41931.161376771684, 42057.158856823306, 42115.0, 324338.0, 325903.0, 326184.0, 326341.0, 329167.0, 25310.746892531577, 25446.745532545177, 25765.96936122534, 37079.814600926824, 38367.808160959015, 36404.81797591101, 36692.0826979317, 37034.629653703116, 37364.0, 37753.62246377501, 33615.15962100967, 33616.83191584027, 33896.322073557894, 34123.829380852934, 34612.82693586516, 33499.33001340008, 33542.16144596405, 33914.8304258487, 33995.15012124618, 34130.48804267888, 29560.408791824473, 31782.52326215155, 32182.0, 33248.0, 34441.48337774885, 29514.409711805216, 31513.0, 31718.524222136224, 36917.63082369142, 38686.613133868304, 25097.87451062733, 25609.103681371063, 25775.355616109748, 26372.472550548497, 27197.320066998484], "value": 17484.056841466216, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.9705623550116, 385.93053250414914, 394.5561243600949, 397.6480814479187, 399.1179493319763, 15218.923905380472, 16700.08149551774, 16954.576135596617, 17076.573085672866, 17196.91401542992, 14589.416423343053, 14635.268236588154, 15199.696006079872, 15207.391704331814, 15211.847881521182, 5102.209157580572, 5246.055709972204, 5253.527182553569, 5270.7628156733035, 5282.683039017652, 3650.5984341722387, 5562.332520097594, 6041.637501749887, 6094.0, 6106.358832322609, 6014.729337179838, 6022.939770602282, 6033.909491357633, 6048.697565121748, 6141.754329826802, 6340.3659634036685, 6478.773242936498, 6511.153550038512, 6538.248101468321, 6546.279909209983, 6647.0, 6692.966535167342, 6708.966455167693, 6731.192256929151, 6744.359285867884, 20162.495937601532, 21928.122875084977, 22086.779132208634, 23204.53590928172, 23214.303570892902, 2061.299158286175, 2103.24283258027, 2114.4291041418883, 2172.2288587551348, 2267.2971378872603, 13190.60428187156, 13508.189508629514, 14124.576262712135, 14436.061655992431, 14574.271286435636, 1882.3694062489083, 1898.2407037185098, 1963.3324669612257, 1973.3882496426154, 2022.3326302320347, 78706.60646696787, 79268.60365698134, 79940.20059799385, 80106.0, 81018.18981810224, 15262.16058116792, 16310.266038028318, 16461.917690411712, 16467.5883102921, 16650.916745416194, 29622.851885740864, 29704.10887673373, 29724.40551188964, 29793.0, 30048.39903201924, 8051.677932882736, 8226.0, 8319.417640765208, 8346.165383461605, 8380.120087390858, 6600.141981542369, 6680.265170831205, 6694.799156025327, 6738.124043874265, 6798.864022719518, 7959.403044771665, 8107.270345668918, 8153.184681531918, 8157.347412207009, 8473.110323415953, 1676.2205574407958, 1728.9221985010704, 1778.9110544472724, 1779.6796576616075, 1794.5693033672085, 853.4665833853842, 865.3164000439582, 871.324723339417, 887.2547060469237, 951.2912879904516, 14495.782563261559, 15109.54671359861, 15136.167510786792, 16115.919420402823, 16226.594335141479, 848.520585868982, 851.9190676885686, 852.0627309959119, 853.8591132463198, 885.2033170146791, 6546.639934803537, 9014.59434325457, 9049.864252036225, 9233.261339092856, 9249.676261330822, 281175.0, 287141.0, 288829.0, 403772.0, 404800.0, 74935.0, 79734.601326993, 81808.0, 82226.58886705528, 83431.0, 928.3687092776977, 958.5878072428923, 966.6085235479642, 971.0338213477494, 985.9408435493893, 13640.249786261455, 14875.776863347275, 14947.701045978802, 15001.399944002118, 15050.69898602, 33275.0, 34652.13369665779, 34663.306733865684, 34840.825795871875, 34841.47737783885, 40148.598514015655, 42994.78502607592, 43693.0, 43698.470553530475, 44184.33723494086, 4272.764997925144, 4377.124575084932, 6814.0, 7392.410631714207, 7730.304272615492, 8788.560571971504, 9591.616335346507, 11646.126540509666, 11773.0, 11871.228370155912, 9584.568694408628, 9915.801683966425, 10091.848622270818, 10164.949175254076, 10213.489325533545, 9815.803683926424, 9877.160441362565, 10050.748731281776, 10093.495325233856, 10259.281850270409, 10246.6413675521, 10399.064084232456, 10465.633702820365, 10491.895081049397, 10494.422806745397, 7093.290670932865, 7258.564486130849, 7273.781786546412, 7381.667824947783, 7459.40324774006, 9855.162311203629, 9885.950570247103, 10178.440185789852, 10200.0, 10222.335548189343], "value": 8753.12931328472, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.0008793932184, 1491.336355321882, 1623.983760162398, 1772.0608077718814, 1813.564744461329, 7003.439724822015, 7656.7320143794905, 7732.072151341833, 7878.645460954256, 7917.129115797265, 7758.224177582239, 7801.687932482694, 7845.137034926168, 7854.332381747558, 7855.450118491708, 2251.9662205066898, 2271.931842044741, 2289.5420915816903, 2291.3813270416977, 2294.208498068164, 2093.696414019966, 2100.159936025587, 2109.4726318420394, 2157.374361435182, 2256.4584499720113, 2223.944401389962, 2255.616545187314, 2262.2760716570706, 2272.1933713531707, 2315.097112126272, 2232.620454522735, 2248.6402175651897, 2260.2089268755967, 2263.3775711679336, 2268.988655056714, 2224.3104637562246, 2237.3176181264707, 2241.854279471829, 2241.8542794718455, 2245.9887700561394, 8006.3995200360205, 8052.637631306547, 8080.676772929076, 8104.230098140667, 8112.797180070486, 4525.796339164713, 4648.163330600491, 4670.486246512881, 4682.555157260055, 4684.929726054112, 2844.1751891951308, 3091.134482344947, 3118.454270502653, 3118.953215701766, 3148.212946763309, 1792.5429015601069, 1796.2725096336005, 1826.6894627913287, 1826.7168588868747, 1838.347386677737, 10192.184625229964, 10343.275970682056, 10368.688939331756, 10371.274010819247, 10383.688489345257, 4024.1146947671464, 4050.918981620351, 4183.958160418418, 4193.056562273525, 4241.406203131564, 8394.0, 8415.284700800501, 8464.66141354339, 8655.523946182895, 8705.738827835175, 4572.45130584332, 4576.4737055239075, 4596.264597664358, 4598.379218805485, 4602.585767280961, 3704.277665855186, 4013.538443079025, 4118.588141185917, 4287.892802679896, 4316.028893498938, 3532.3288575170636, 3558.87543935961, 3594.4428613564937, 3679.043448703303, 3690.704743620504, 1098.2257508456519, 1117.899389054989, 1131.7510147767478, 1133.0708818768696, 1136.5737848306885, 853.7310747114639, 860.5181098584812, 865.8787769712245, 870.0168809245512, 875.5272153037289, 5312.415634280226, 5370.248165256867, 5413.538344646923, 5495.065838807413, 5554.1946417769195, 398.1896839930727, 440.5858493016554, 441.474645172244, 444.0608113839207, 446.4709319456455, 3638.76348037382, 3702.870399536057, 3705.4256590228556, 3721.627837216311, 3735.626437356297, 9312.767180820534, 9654.662086826927, 10191.592336306465, 10207.7448063799, 10269.640562580274, 9611.134997850228, 9619.615215391446, 9649.903500965042, 9696.224302055818, 9714.22286217101, 7126.608036558039, 7179.138503379628, 7189.712411503586, 7215.701173788663, 7464.888026679604, 5626.662400255997, 5671.801486947937, 5682.14767784819, 5685.772569097356, 5902.144189092472, 9212.631494740135, 9224.815503689755, 9252.49111298885, 9339.972603013528, 9409.059094090537, 9050.230730387728, 9065.728028159167, 9305.674301399418, 9421.0, 9570.95214523923, 6269.247690277196, 6802.693878775368, 6949.826254343682, 7013.0, 7032.050673159058, 7458.8508229834015, 7499.287567681062, 7549.962250188714, 7593.164751877179, 7624.0, 6880.724771009103, 7126.895331223669, 7143.67841949241, 7148.749793757193, 7261.891071633824, 6820.693068812015, 6884.449244060564, 6892.758753443605, 6913.308669133046, 6967.581945083311, 6193.690315484298, 6379.170707807955, 6399.488040956619, 6547.70535325902, 6556.0, 4664.183767840546, 4706.741129237787, 4759.3336932830125, 4786.928196077131, 4801.039792041536, 4738.099761045391, 4795.832145874878, 4803.95196048049, 4844.0554091951735, 4875.3174555562955], "value": 4211.145220958072, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.23071551487647, 319.70587059904886, 328.6926723513515, 330.98345082745874, 335.1554083709055, 5214.139666954952, 5252.290940723006, 5284.260203571503, 5306.70813105279, 5317.9202311965355, 5188.143956247215, 5225.634205605609, 5231.79072837087, 5237.266782650432, 5241.2924255225535, 3835.654791068803, 3890.1636148228126, 4067.2068946555432, 4077.2864748669012, 4092.1201941582553, 4012.0, 4032.5362583303004, 4058.2492238935893, 4064.349704047353, 4071.409645601401, 4026.3557830747086, 4044.757314561121, 4056.736312139716, 4059.3505039193733, 4070.430139780433, 3770.3967365221706, 3962.7424217426064, 3973.7417067890783, 4060.817263223162, 4066.5120185577625, 3484.930301393958, 3493.1616412061176, 3503.404421248368, 3504.281622267429, 3504.56192975878, 4916.237983112624, 4920.778564964549, 4922.0, 4933.309336692866, 4939.234418665077, 4321.9135617287475, 4556.908861822745, 4586.931196032062, 4600.263957766741, 4610.3315019322345, 5410.783568657249, 5447.400785913546, 5453.700046497441, 5453.836384908459, 5454.10007348791, 3837.4052021936645, 3842.6733727633186, 3860.4402361657403, 3866.5360156781085, 3869.496965394509, 5423.566114710814, 5636.351819540764, 5761.0, 5762.366139724669, 5782.074868021138, 3919.235749028969, 3936.012313781522, 3946.6053394660303, 3955.8219880105466, 3978.5225772906856, 3977.3437382831507, 4000.3199456092534, 4005.339119045325, 4010.3382941814857, 4012.859549915739, 4590.931136032962, 4593.356930029799, 4600.6549508786975, 4602.746848923274, 4603.930941035887, 5166.535011848951, 5460.699661518575, 5465.945340546544, 5468.425815289417, 5477.67133971955, 1375.8692924172187, 1387.7779555271109, 1400.5728252882968, 1407.4510940733123, 1410.5486244401898, 876.1501343696605, 900.1583519409373, 943.5848226780195, 953.880764904387, 960.2893858544627, 4780.091782561302, 4812.109759694467, 4812.422509298906, 4817.13291607514, 4821.9035619287415, 5484.875600501888, 5622.437756224344, 5627.071533197059, 5641.069223578145, 5643.887122257614, 4630.665920537208, 4714.882127946828, 4725.50382209863, 4763.73799441034, 4766.428028636586, 2964.43675701616, 2972.1677930179585, 3002.2194229500487, 3006.7895247332913, 3020.9848950755545, 5247.63266571344, 5285.445028272053, 5319.813806516753, 5326.9467305327225, 5330.493603107699, 5600.159976003632, 5742.942570574241, 5776.971115144397, 5782.3639399666, 5817.7382017809305, 5311.840644780663, 5320.813771518133, 5339.119045357473, 5343.385510666323, 5353.4646535346155, 5424.783008679767, 5595.40530948694, 5607.859803504945, 5618.775248990158, 5628.324601047901, 5484.8354549363585, 5485.75314110858, 5498.202760599771, 5526.50261476469, 5531.917021244604, 5270.657407268515, 5279.762410691451, 5319.920201197063, 5320.228566857862, 5330.2804121443105, 3815.065308999313, 3931.253061918226, 3939.4484772132496, 3941.507311586052, 3944.2308749793515, 5542.196381524575, 5561.916571251353, 5563.944360556343, 5566.387697353369, 5574.804881829116, 5333.280007198979, 5352.143657014859, 5388.814460818614, 5404.243405923253, 5418.620696551204, 5264.2630031794815, 5346.957343318016, 5361.865953351197, 5369.785208591768, 5397.892042159214, 5282.4717528246865, 5290.539898946854, 5312.4156342803035, 5321.3880403754065, 5331.280277162534, 5248.737563121905, 5324.121519949165, 5515.641483303572, 5530.91703624454, 5536.695481748542, 5338.75975581092, 5339.652922560022, 5363.865903352447, 5364.14173732201, 5391.191321301836], "value": 4092.9818831720013, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.106774929714, 734.280405202901, 742.361569050616, 753.0511555440145, 757.2994979643831, 11949.58176463824, 12215.267083974968, 12350.258984460927, 14071.788923166136, 14621.12273263605, 12878.4204710788, 13206.0, 13298.667533311673, 13322.333883305844, 13352.732945341088, 645.1677336236249, 826.3926014379426, 844.67902197165, 844.8394804987048, 850.1795767084762, 843.1399972028527, 852.2755657690975, 853.8633818589027, 856.3534531428762, 858.107568129148, 888.1296329596998, 888.3781353052857, 889.7820034091657, 890.145460358057, 890.4568213389826, 872.1583671756786, 875.1511034296722, 879.2394578689451, 881.378628067211, 885.1679421343916, 650.5738741124571, 650.7006776882592, 651.6057785040077, 651.8663673946829, 653.0335104046038, 13559.864401355959, 13570.864291357157, 13598.11612245201, 13610.251436171007, 13610.319484025858, 12561.371931403484, 12598.874011259863, 12690.80963785544, 12692.492300307977, 12907.806382904264, 10357.4303413313, 10426.739331516697, 10461.110805581535, 10654.147668186526, 10744.409057501834, 3285.8685652573868, 3348.5479460272795, 3377.527146199534, 3378.3918894598964, 3392.355452464024, 52064.21903671448, 52253.47746522524, 52373.0, 52399.73800130975, 52916.735416323056, 9688.75778105553, 10046.799064018678, 10143.797124057477, 10196.643117490852, 10297.227707921937, 16291.185440727917, 17186.31254749796, 17260.568485787957, 17281.39515116965, 17292.308307667554, 6818.965905170541, 6944.861102777916, 6962.686679099453, 7142.250063743336, 7211.134663840373, 3680.245549662313, 3696.149885526344, 3832.6358995895343, 3841.682756831429, 3919.5884432134217, 2758.0622588320066, 2838.914832555027, 2850.2019434558356, 2851.3726980064353, 2853.0, 540.2220802045042, 543.0550841535778, 545.0760960172548, 549.3023859698161, 550.9228707980886, 514.6603241860354, 592.2182718811214, 639.587466084373, 643.9742410303535, 657.6202491407205, 7971.641276142587, 7976.282134607797, 7998.721802258903, 8137.145599711945, 8181.0, 511.43231013574905, 564.1678524176806, 607.0, 620.8665136995568, 638.113022898172, 3651.8904432867057, 3778.471014058034, 3823.4264860271182, 3853.2678791029616, 3893.0, 46528.76735616368, 47029.764851175525, 47115.528844711116, 47395.76302118536, 47520.0, 44016.3397549037, 45034.54965450369, 45195.0, 45208.54791452044, 45548.08903821905, 40804.0, 41461.37807932883, 41712.58287417148, 41952.79023604924, 42174.57825421768, 7250.457693226082, 7365.292673471974, 7421.591812450367, 7427.554346739213, 7495.475316727777, 25449.38599734221, 25860.353491162117, 26220.0, 27078.593821093094, 28687.13938581846, 34244.143896401794, 34994.650053499136, 35016.82491587526, 35262.294754105285, 35498.82250588731, 10696.465176741287, 10783.568657253621, 10990.560377584807, 10999.23005389615, 11062.391568463812, 11751.353675547927, 12001.459934302802, 12116.575919842764, 12132.696682583006, 12142.542894852675, 10515.106215971422, 10588.841167382341, 11084.445777711244, 11333.829992550283, 11375.658730238107, 10839.295445795999, 10888.18338624622, 10952.371450805154, 11008.724781880197, 11110.166737494881, 10745.785084298113, 10766.192535559707, 10844.295120817122, 11445.828312575151, 11585.420728963687, 9128.771780705536, 9433.198178154658, 9870.210383169473, 9989.700308990741, 9990.600375984879, 9198.310126740655, 9680.951595241979, 9758.560864761244, 9854.950725246328, 9953.701388958343], "value": 6011.855898519126, "unit": "score"}], "name": "dromaeo_css", "value": 6452.107801798026, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 113.0, 113.0, 116.0, 127.0, 113.0, 114.0, 115.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 131.0, 158.0, 181.0, 135.0, 158.0, 162.0, 135.0, 183.0, 134.0], "value": 154.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 164.0, 175.0, 163.0, 162.0, 170.0, 166.0, 166.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 146.0, 75.0, 75.0, 77.0, 74.0, 158.0, 76.0], "value": 90.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 153.0, 94.0, 94.0, 95.0, 146.0, 95.0, 95.0, 147.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 146.0, 148.0, 147.0, 148.0, 146.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 68.0, 64.0, 63.0, 64.0, 91.0, 62.0, 66.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 64.0, 65.0, 64.0, 63.0, 64.0, 64.0, 66.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 83.0, 85.0, 93.0, 86.0, 85.0, 86.0, 94.0, 87.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 138.0, 150.0, 145.0, 150.0, 141.0, 140.0, 152.0, 144.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 184.0, 177.0, 172.0, 175.0, 177.0, 183.0, 175.0, 177.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 75.0, 74.0, 71.0, 73.0, 71.0, 73.0, 71.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1611.7, "alertThreshold": 2.0}]} 05:40:21 INFO - Return code: 0 05:40:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:40:21 ERROR - # TBPL SUCCESS # 05:40:21 INFO - Running post-action listener: _resource_record_post_action 05:40:21 INFO - Running post-run listener: _resource_record_post_run 05:40:22 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 10596352; Write bytes: 415592448; Read time: 3108; Write time: 715208 05:40:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 33910784; Read time: 0; Write time: 22228 05:40:22 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 10596352; Write bytes: 331083776; Read time: 3108; Write time: 574824 05:40:22 INFO - Running post-run listener: _upload_blobber_files 05:40:22 INFO - Blob upload gear active. 05:40:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:40:22 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 05:40:22 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:40:22 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:40:22 INFO - (blobuploader) - INFO - Open directory for files ... 05:40:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:40:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:40:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:23 INFO - (blobuploader) - INFO - Done attempting. 05:40:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:40:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:40:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:24 INFO - (blobuploader) - INFO - Done attempting. 05:40:24 INFO - (blobuploader) - INFO - Iteration through files over. 05:40:24 INFO - Return code: 0 05:40:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:40:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:40:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0ec0414e1a6063108b14314bfa75c93f1a00cd89b6ef8b7d1c945814a39741991797c8cca8f890b4a1bb8abfe3653882c476742b09c925640b7d6439e89df4e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8d3cd4daaf9982b1c6d6a30dec36b662f919126c9b3d454712adfcbb714b60020c0cfbcc1205a2e3d37259976c684ca772ab84c8ef61987fe4d2b63e224af82"} 05:40:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:40:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:40:24 INFO - Contents: 05:40:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0ec0414e1a6063108b14314bfa75c93f1a00cd89b6ef8b7d1c945814a39741991797c8cca8f890b4a1bb8abfe3653882c476742b09c925640b7d6439e89df4e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8d3cd4daaf9982b1c6d6a30dec36b662f919126c9b3d454712adfcbb714b60020c0cfbcc1205a2e3d37259976c684ca772ab84c8ef61987fe4d2b63e224af82"} 05:40:24 INFO - Running post-run listener: copy_logs_to_upload_dir 05:40:24 INFO - Copying logs to upload dir... 05:40:24 INFO - mkdir: /builds/slave/test/build/upload/logs 05:40:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.317044 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-13 05:40:24.421950) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 05:40:24.425480) ========= 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=1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682 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/Fx-Team-Non-PGO/sha512/c0ec0414e1a6063108b14314bfa75c93f1a00cd89b6ef8b7d1c945814a39741991797c8cca8f890b4a1bb8abfe3653882c476742b09c925640b7d6439e89df4e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8d3cd4daaf9982b1c6d6a30dec36b662f919126c9b3d454712adfcbb714b60020c0cfbcc1205a2e3d37259976c684ca772ab84c8ef61987fe4d2b63e224af82"} build_url:https://queue.taskcluster.net/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011168 build_url: 'https://queue.taskcluster.net/v1/task/Bbe2NveETd-Nmw3mKXUzJQ/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/Fx-Team-Non-PGO/sha512/c0ec0414e1a6063108b14314bfa75c93f1a00cd89b6ef8b7d1c945814a39741991797c8cca8f890b4a1bb8abfe3653882c476742b09c925640b7d6439e89df4e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8d3cd4daaf9982b1c6d6a30dec36b662f919126c9b3d454712adfcbb714b60020c0cfbcc1205a2e3d37259976c684ca772ab84c8ef61987fe4d2b63e224af82"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 05:40:24.450207) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:40:24.450549) ========= 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=1861a34ebfea852630dec091000001fa-1460549970.769967-1719752682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:40:24.533020) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 05:40:24.533354) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 05:40:24.533656) ========= ========= Total master_lag: 0.24 =========