builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1458316065.93 results: success (0) buildid: 20160318075414 builduid: cf49355be9ef43e5819335b0fbed2d6c revision: d211f362a8fa08816c8f0a19fc9a2f7f11aeff43 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:45.925718) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:45.926369) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:45.926872) ========= 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=1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006395 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:45.953696) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:45.954126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:45.984201) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:45.984573) ========= 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=1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:46.034704) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:46.035017) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:46.035408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:46.035692) ========= 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=1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-18 08:47:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-03-18 08:47:46 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184102 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:46.232697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:46.233028) ========= 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=1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022487 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:46.283117) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 08:47:46.283496) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d211f362a8fa08816c8f0a19fc9a2f7f11aeff43 --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 d211f362a8fa08816c8f0a19fc9a2f7f11aeff43 --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=1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-18 08:47:46,862 truncating revision to first 12 chars 2016-03-18 08:47:46,862 Setting DEBUG logging. 2016-03-18 08:47:46,863 attempt 1/10 2016-03-18 08:47:46,863 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d211f362a8fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 08:47:47,919 unpacking tar archive at: fx-team-d211f362a8fa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.354687 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 08:47:47.651105) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:47.651450) ========= echo d211f362a8fa08816c8f0a19fc9a2f7f11aeff43 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd211f362a8fa08816c8f0a19fc9a2f7f11aeff43'] 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=1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d211f362a8fa08816c8f0a19fc9a2f7f11aeff43 program finished with exit code 0 elapsedTime=0.004721 script_repo_revision: 'd211f362a8fa08816c8f0a19fc9a2f7f11aeff43' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:47.701709) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:47.702037) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 08:47:47.714894) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-03-18 08:47:47.715227) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:47:48 INFO - MultiFileLogger online at 20160318 08:47:48 in /builds/slave/test 08:47:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 08:47:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:47:48 INFO - {'append_to_log': False, 08:47:48 INFO - 'base_work_dir': '/builds/slave/test', 08:47:48 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:47:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:47:48 INFO - 'branch': 'Fx-Team-Non-PGO', 08:47:48 INFO - 'buildbot_json_path': 'buildprops.json', 08:47:48 INFO - 'config_files': ('talos/linux_config.py',), 08:47:48 INFO - 'default_actions': ('clobber', 08:47:48 INFO - 'read-buildbot-config', 08:47:48 INFO - 'download-and-extract', 08:47:48 INFO - 'populate-webroot', 08:47:48 INFO - 'create-virtualenv', 08:47:48 INFO - 'install', 08:47:48 INFO - 'run-tests'), 08:47:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:47:48 INFO - 'download_minidump_stackwalk': True, 08:47:48 INFO - 'download_symbols': 'ondemand', 08:47:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:47:48 INFO - 'tooltool.py': '/tools/tooltool.py', 08:47:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:47:48 INFO - '/tools/misc-python/virtualenv.py')}, 08:47:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:47:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:47:48 INFO - 'installer_path': 'installer.exe', 08:47:48 INFO - 'log_level': 'info', 08:47:48 INFO - 'log_name': 'talos', 08:47:48 INFO - 'log_to_console': True, 08:47:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:47:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:47:48 INFO - 'opt_config_files': (), 08:47:48 INFO - 'pip_index': False, 08:47:48 INFO - 'sps_profile': False, 08:47:48 INFO - 'sps_profile_interval': 0, 08:47:48 INFO - 'suite': 'dromaeojs', 08:47:48 INFO - 'system_bits': '32', 08:47:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:47:48 INFO - 'title': 'talos-linux64-ix-045', 08:47:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:47:48 INFO - 'use_talos_json': True, 08:47:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:47:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:47:48 INFO - 'work_dir': 'build'} 08:47:48 INFO - ##### 08:47:48 INFO - ##### Running clobber step. 08:47:48 INFO - ##### 08:47:48 INFO - Running pre-action listener: _resource_record_pre_action 08:47:48 INFO - Running main action method: clobber 08:47:48 INFO - rmtree: /builds/slave/test/build 08:47:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:47:49 INFO - Running post-action listener: _resource_record_post_action 08:47:49 INFO - ##### 08:47:49 INFO - ##### Running read-buildbot-config step. 08:47:49 INFO - ##### 08:47:49 INFO - Running pre-action listener: _resource_record_pre_action 08:47:49 INFO - Running main action method: read_buildbot_config 08:47:49 INFO - Using buildbot properties: 08:47:49 INFO - { 08:47:49 INFO - "project": "", 08:47:49 INFO - "product": "firefox", 08:47:49 INFO - "script_repo_revision": "production", 08:47:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:47:49 INFO - "repository": "", 08:47:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:47:49 INFO - "buildid": "20160318075414", 08:47:49 INFO - "pgo_build": "False", 08:47:49 INFO - "basedir": "/builds/slave/test", 08:47:49 INFO - "buildnumber": 1473, 08:47:49 INFO - "slavename": "talos-linux64-ix-045", 08:47:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:47:49 INFO - "platform": "ubuntu64_hw", 08:47:49 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:47:49 INFO - "branch": "fx-team", 08:47:49 INFO - "repo_path": "integration/fx-team", 08:47:49 INFO - "revision": "d211f362a8fa08816c8f0a19fc9a2f7f11aeff43", 08:47:49 INFO - "stage_platform": "linux64", 08:47:49 INFO - "builduid": "cf49355be9ef43e5819335b0fbed2d6c", 08:47:49 INFO - "slavebuilddir": "test" 08:47:49 INFO - } 08:47:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:47:49 INFO - Running post-action listener: _resource_record_post_action 08:47:49 INFO - ##### 08:47:49 INFO - ##### Running download-and-extract step. 08:47:49 INFO - ##### 08:47:49 INFO - Running pre-action listener: _resource_record_pre_action 08:47:49 INFO - Running main action method: download_and_extract 08:47:49 INFO - mkdir: /builds/slave/test/build/tests 08:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:49 INFO - https://queue.taskcluster.net/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:47:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:47:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:47:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:47:52 INFO - Downloaded 1361 bytes. 08:47:52 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:47:52 INFO - Using the following test package requirements: 08:47:52 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:47:52 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:47:52 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:47:52 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:52 INFO - u'jsshell-linux-x86_64.zip'], 08:47:52 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:47:52 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:47:52 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:47:52 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:47:52 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:47:52 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:47:52 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:47: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')]} 08:47:52 INFO - https://queue.taskcluster.net/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:47:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:47:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:47:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:47:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:47:55 INFO - Downloaded 22009031 bytes. 08:47:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:47:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:47:56 INFO - Return code: 0 08:47:56 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:56 INFO - https://queue.taskcluster.net/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:47:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:47:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:47:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:47:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:48:00 INFO - Downloaded 22009031 bytes. 08:48:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:48:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:48:01 INFO - Return code: 0 08:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:01 INFO - https://queue.taskcluster.net/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:48:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:48:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:48:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:48:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:48:03 INFO - Downloaded 10846565 bytes. 08:48:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:48:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:48:03 INFO - Return code: 0 08:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:03 INFO - https://queue.taskcluster.net/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:48:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:48:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:48:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:48:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:48:05 INFO - Downloaded 54145421 bytes. 08:48:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:48:05 INFO - mkdir: /builds/slave/test/properties 08:48:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:48:05 INFO - Writing to file /builds/slave/test/properties/build_url 08:48:05 INFO - Contents: 08:48:05 INFO - build_url:https://queue.taskcluster.net/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:48:06 INFO - Running post-action listener: _resource_record_post_action 08:48:06 INFO - Running post-action listener: set_extra_try_arguments 08:48:06 INFO - ##### 08:48:06 INFO - ##### Running populate-webroot step. 08:48:06 INFO - ##### 08:48:06 INFO - Running pre-action listener: _resource_record_pre_action 08:48:06 INFO - Running main action method: populate_webroot 08:48:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:48:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:48:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:48:06 INFO - '--tppagecycles', 08:48:06 INFO - '7'], 08:48:06 INFO - 'tests': ['tsvgm']}}, 08:48:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:48:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:48:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:48:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:48:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:48:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:48:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'talos_options': ['--e10s'], 08:48:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'tests': ['damp', 'tps']}, 08:48:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'talos_options': ['--e10s'], 08:48:06 INFO - 'tests': ['damp', 'tps']}, 08:48:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:48:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:48:06 INFO - 'other': {'tests': ['a11yr', 08:48:06 INFO - 'ts_paint', 08:48:06 INFO - 'tpaint', 08:48:06 INFO - 'sessionrestore', 08:48:06 INFO - 'sessionrestore_no_auto_restore', 08:48:06 INFO - 'tabpaint']}, 08:48:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:48:06 INFO - 'tests': ['a11yr', 08:48:06 INFO - 'ts_paint', 08:48:06 INFO - 'tpaint', 08:48:06 INFO - 'sessionrestore', 08:48:06 INFO - 'sessionrestore_no_auto_restore', 08:48:06 INFO - 'tabpaint']}, 08:48:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:48:06 INFO - 'tests': ['a11yr', 08:48:06 INFO - 'ts_paint', 08:48:06 INFO - 'tpaint', 08:48:06 INFO - 'sessionrestore', 08:48:06 INFO - 'sessionrestore_no_auto_restore', 08:48:06 INFO - 'tabpaint']}, 08:48:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:48:06 INFO - 'tests': ['a11yr', 08:48:06 INFO - 'ts_paint', 08:48:06 INFO - 'tpaint', 08:48:06 INFO - 'sessionrestore', 08:48:06 INFO - 'sessionrestore_no_auto_restore', 08:48:06 INFO - 'tabpaint']}, 08:48:06 INFO - 'other_l64': {'tests': ['a11yr', 08:48:06 INFO - 'ts_paint', 08:48:06 INFO - 'tpaint', 08:48:06 INFO - 'sessionrestore', 08:48:06 INFO - 'sessionrestore_no_auto_restore', 08:48:06 INFO - 'tabpaint']}, 08:48:06 INFO - 'other_nol64': {'tests': ['a11yr', 08:48:06 INFO - 'ts_paint', 08:48:06 INFO - 'tpaint', 08:48:06 INFO - 'sessionrestore', 08:48:06 INFO - 'sessionrestore_no_auto_restore', 08:48:06 INFO - 'tabpaint']}, 08:48:06 INFO - 'svgr': {'tests': ['tsvgx', 08:48:06 INFO - 'tsvgr_opacity', 08:48:06 INFO - 'tart', 08:48:06 INFO - 'tscrollx', 08:48:06 INFO - 'cart']}, 08:48:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:48:06 INFO - 'tests': ['tsvgx', 08:48:06 INFO - 'tsvgr_opacity', 08:48:06 INFO - 'tart', 08:48:06 INFO - 'tscrollx', 08:48:06 INFO - 'cart']}, 08:48:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'tests': ['tp5o']}, 08:48:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'talos_options': ['--e10s'], 08:48:06 INFO - 'tests': ['tp5o']}, 08:48:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'talos_options': ['--xperf_path', 08:48:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:06 INFO - 'tests': ['tp5n']}, 08:48:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:06 INFO - 'talos_options': ['--e10s', 08:48:06 INFO - '--xperf_path', 08:48:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:06 INFO - 'tests': ['tp5n']}}, 08:48:06 INFO - 'talos.zip': {'path': '', 08:48:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:48:06 INFO - Running post-action listener: _resource_record_post_action 08:48:06 INFO - ##### 08:48:06 INFO - ##### Running create-virtualenv step. 08:48:06 INFO - ##### 08:48:06 INFO - Running pre-action listener: _resource_record_pre_action 08:48:06 INFO - Running main action method: create_virtualenv 08:48:06 INFO - Creating virtualenv /builds/slave/test/build/venv 08:48:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:48:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:48:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:48:06 INFO - Using real prefix '/usr' 08:48:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:48:06 INFO - Installing distribute.............................................................................................................................................................................................done. 08:48:08 INFO - Installing pip.................done. 08:48:08 INFO - Return code: 0 08:48:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6e63dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7410>, '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 0x1fd8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd87a0>, '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': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:48:08 INFO - Using env: {'DISPLAY': ':0', 08:48:08 INFO - 'HOME': '/home/cltbld', 08:48:08 INFO - 'LANG': 'en_US.UTF-8', 08:48:08 INFO - 'LANGUAGE': 'en_US:en', 08:48:08 INFO - 'LOGNAME': 'cltbld', 08:48:08 INFO - 'MAIL': '/var/mail/cltbld', 08:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:08 INFO - 'MOZ_NO_REMOTE': '1', 08:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:08 INFO - 'NO_EM_RESTART': '1', 08:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:08 INFO - 'PWD': '/builds/slave/test', 08:48:08 INFO - 'SHELL': '/bin/bash', 08:48:08 INFO - 'SHLVL': '1', 08:48:08 INFO - 'TERM': 'linux', 08:48:08 INFO - 'TMOUT': '86400', 08:48:08 INFO - 'USER': 'cltbld', 08:48:08 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 08:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:08 INFO - '_': '/tools/buildbot/bin/python'} 08:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:48:08 INFO - Cleaning up... 08:48:08 INFO - Return code: 0 08:48:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6e63dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7410>, '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 0x1fd8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd87a0>, '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': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:48:08 INFO - Using env: {'DISPLAY': ':0', 08:48:08 INFO - 'HOME': '/home/cltbld', 08:48:08 INFO - 'LANG': 'en_US.UTF-8', 08:48:08 INFO - 'LANGUAGE': 'en_US:en', 08:48:08 INFO - 'LOGNAME': 'cltbld', 08:48:08 INFO - 'MAIL': '/var/mail/cltbld', 08:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:08 INFO - 'MOZ_NO_REMOTE': '1', 08:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:08 INFO - 'NO_EM_RESTART': '1', 08:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:08 INFO - 'PWD': '/builds/slave/test', 08:48:08 INFO - 'SHELL': '/bin/bash', 08:48:08 INFO - 'SHLVL': '1', 08:48:08 INFO - 'TERM': 'linux', 08:48:08 INFO - 'TMOUT': '86400', 08:48:08 INFO - 'USER': 'cltbld', 08:48:08 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 08:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:08 INFO - '_': '/tools/buildbot/bin/python'} 08:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:09 INFO - Downloading/unpacking psutil>=0.7.1 08:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:11 INFO - Installing collected packages: psutil 08:48:11 INFO - Running setup.py install for psutil 08:48:11 INFO - building 'psutil._psutil_linux' extension 08:48:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:48:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:48:11 INFO - building 'psutil._psutil_posix' extension 08:48:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:48:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:48:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:11 INFO - Successfully installed psutil 08:48:11 INFO - Cleaning up... 08:48:11 INFO - Return code: 0 08:48:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6e63dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7410>, '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 0x1fd8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd87a0>, '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': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:48:11 INFO - Using env: {'DISPLAY': ':0', 08:48:11 INFO - 'HOME': '/home/cltbld', 08:48:11 INFO - 'LANG': 'en_US.UTF-8', 08:48:11 INFO - 'LANGUAGE': 'en_US:en', 08:48:11 INFO - 'LOGNAME': 'cltbld', 08:48:11 INFO - 'MAIL': '/var/mail/cltbld', 08:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:11 INFO - 'MOZ_NO_REMOTE': '1', 08:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:11 INFO - 'NO_EM_RESTART': '1', 08:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:11 INFO - 'PWD': '/builds/slave/test', 08:48:11 INFO - 'SHELL': '/bin/bash', 08:48:11 INFO - 'SHLVL': '1', 08:48:11 INFO - 'TERM': 'linux', 08:48:11 INFO - 'TMOUT': '86400', 08:48:11 INFO - 'USER': 'cltbld', 08:48:11 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 08:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:11 INFO - '_': '/tools/buildbot/bin/python'} 08:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:48:13 INFO - Installing collected packages: mozsystemmonitor 08:48:13 INFO - Running setup.py install for mozsystemmonitor 08:48:13 INFO - Successfully installed mozsystemmonitor 08:48:13 INFO - Cleaning up... 08:48:13 INFO - Return code: 0 08:48:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:48: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')]} 08:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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')]} 08:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6e63dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7410>, '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 0x1fd8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd87a0>, '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': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:48:13 INFO - Using env: {'DISPLAY': ':0', 08:48:13 INFO - 'HOME': '/home/cltbld', 08:48:13 INFO - 'LANG': 'en_US.UTF-8', 08:48:13 INFO - 'LANGUAGE': 'en_US:en', 08:48:13 INFO - 'LOGNAME': 'cltbld', 08:48:13 INFO - 'MAIL': '/var/mail/cltbld', 08:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:13 INFO - 'MOZ_NO_REMOTE': '1', 08:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:13 INFO - 'NO_EM_RESTART': '1', 08:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:13 INFO - 'PWD': '/builds/slave/test', 08:48:13 INFO - 'SHELL': '/bin/bash', 08:48:13 INFO - 'SHLVL': '1', 08:48:13 INFO - 'TERM': 'linux', 08:48:13 INFO - 'TMOUT': '86400', 08:48:13 INFO - 'USER': 'cltbld', 08:48:13 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 08:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:13 INFO - '_': '/tools/buildbot/bin/python'} 08:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:14 INFO - Downloading/unpacking blobuploader==1.2.4 08:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:15 INFO - Downloading blobuploader-1.2.4.tar.gz 08:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:48:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:48: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 08:48: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 08:48: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 08:48: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 08:48: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 08:48: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 08:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:48:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:48: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 08:48: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 08:48: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 08:48: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 08:48: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 08:48: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 08:48:16 INFO - Downloading docopt-0.6.1.tar.gz 08:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:48:16 INFO - Installing collected packages: blobuploader, requests, docopt 08:48:16 INFO - Running setup.py install for blobuploader 08:48:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:48:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:48:16 INFO - Running setup.py install for requests 08:48:17 INFO - Running setup.py install for docopt 08:48:17 INFO - Successfully installed blobuploader requests docopt 08:48:17 INFO - Cleaning up... 08:48:17 INFO - Return code: 0 08:48:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6e63dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7410>, '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 0x1fd8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd87a0>, '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': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:48:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:48:17 INFO - Using env: {'DISPLAY': ':0', 08:48:17 INFO - 'HOME': '/home/cltbld', 08:48:17 INFO - 'LANG': 'en_US.UTF-8', 08:48:17 INFO - 'LANGUAGE': 'en_US:en', 08:48:17 INFO - 'LOGNAME': 'cltbld', 08:48:17 INFO - 'MAIL': '/var/mail/cltbld', 08:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:17 INFO - 'MOZ_NO_REMOTE': '1', 08:48:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:17 INFO - 'NO_EM_RESTART': '1', 08:48:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:17 INFO - 'PWD': '/builds/slave/test', 08:48:17 INFO - 'SHELL': '/bin/bash', 08:48:17 INFO - 'SHLVL': '1', 08:48:17 INFO - 'TERM': 'linux', 08:48:17 INFO - 'TMOUT': '86400', 08:48:17 INFO - 'USER': 'cltbld', 08:48:17 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 08:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:17 INFO - '_': '/tools/buildbot/bin/python'} 08:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:17 INFO - Running setup.py (path:/tmp/pip-y2sgCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:17 INFO - Running setup.py (path:/tmp/pip-oMAq4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:17 INFO - Running setup.py (path:/tmp/pip-0HlYpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:17 INFO - Running setup.py (path:/tmp/pip-QGUwyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:17 INFO - Running setup.py (path:/tmp/pip-x_cNIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:17 INFO - Running setup.py (path:/tmp/pip-W6Chov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:17 INFO - Running setup.py (path:/tmp/pip-IhqDfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:17 INFO - Running setup.py (path:/tmp/pip-IG04YX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:18 INFO - Running setup.py (path:/tmp/pip-aHZwhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:18 INFO - Running setup.py (path:/tmp/pip-WjdxFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:18 INFO - Running setup.py (path:/tmp/pip-iF9gBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:18 INFO - Running setup.py (path:/tmp/pip-pElunX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:18 INFO - Running setup.py (path:/tmp/pip-njWvSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:18 INFO - Running setup.py (path:/tmp/pip-gyhD7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:18 INFO - Running setup.py (path:/tmp/pip-MhQn1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:18 INFO - Running setup.py (path:/tmp/pip-q_eJMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:18 INFO - Running setup.py (path:/tmp/pip-QbkaQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:48:18 INFO - Running setup.py install for manifestparser 08:48:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:48:18 INFO - Running setup.py install for mozcrash 08:48:18 INFO - Running setup.py install for mozdebug 08:48:18 INFO - Running setup.py install for mozdevice 08:48:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Running setup.py install for mozfile 08:48:19 INFO - Running setup.py install for mozhttpd 08:48:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Running setup.py install for mozinfo 08:48:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Running setup.py install for mozInstall 08:48:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Running setup.py install for mozleak 08:48:19 INFO - Running setup.py install for mozlog 08:48:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Running setup.py install for moznetwork 08:48:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Running setup.py install for mozprocess 08:48:19 INFO - Running setup.py install for mozprofile 08:48:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Running setup.py install for mozrunner 08:48:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Running setup.py install for mozscreenshot 08:48:20 INFO - Running setup.py install for moztest 08:48:20 INFO - Running setup.py install for mozversion 08:48:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:48:20 INFO - Cleaning up... 08:48:20 INFO - Return code: 0 08:48:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6e63dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7410>, '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 0x1fd8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd87a0>, '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': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:48:20 INFO - Using env: {'DISPLAY': ':0', 08:48:20 INFO - 'HOME': '/home/cltbld', 08:48:20 INFO - 'LANG': 'en_US.UTF-8', 08:48:20 INFO - 'LANGUAGE': 'en_US:en', 08:48:20 INFO - 'LOGNAME': 'cltbld', 08:48:20 INFO - 'MAIL': '/var/mail/cltbld', 08:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:20 INFO - 'MOZ_NO_REMOTE': '1', 08:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:20 INFO - 'NO_EM_RESTART': '1', 08:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:20 INFO - 'PWD': '/builds/slave/test', 08:48:20 INFO - 'SHELL': '/bin/bash', 08:48:20 INFO - 'SHLVL': '1', 08:48:20 INFO - 'TERM': 'linux', 08:48:20 INFO - 'TMOUT': '86400', 08:48:20 INFO - 'USER': 'cltbld', 08:48:20 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 08:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:20 INFO - '_': '/tools/buildbot/bin/python'} 08:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:20 INFO - Running setup.py (path:/tmp/pip-Uc8eER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:20 INFO - Running setup.py (path:/tmp/pip-_PTatV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:20 INFO - Running setup.py (path:/tmp/pip-OzilBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:20 INFO - Running setup.py (path:/tmp/pip-OLnP86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:21 INFO - Running setup.py (path:/tmp/pip-Jxy2ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:21 INFO - Running setup.py (path:/tmp/pip-I1Ifbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:21 INFO - Running setup.py (path:/tmp/pip-FzAWVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:21 INFO - Running setup.py (path:/tmp/pip-47ic5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:21 INFO - Running setup.py (path:/tmp/pip-einhtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:21 INFO - Running setup.py (path:/tmp/pip-dZjq0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:21 INFO - Running setup.py (path:/tmp/pip-VaEgOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:21 INFO - Running setup.py (path:/tmp/pip-kZov7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:21 INFO - Running setup.py (path:/tmp/pip-iLtkEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:21 INFO - Running setup.py (path:/tmp/pip-GIgN26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:21 INFO - Running setup.py (path:/tmp/pip-J59B19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:21 INFO - Running setup.py (path:/tmp/pip-P1MoyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:21 INFO - Running setup.py (path:/tmp/pip-t6kcW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:48:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:23 INFO - Downloading blessings-1.6.tar.gz 08:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:48:23 INFO - Installing collected packages: blessings 08:48:23 INFO - Running setup.py install for blessings 08:48:23 INFO - Successfully installed blessings 08:48:23 INFO - Cleaning up... 08:48:24 INFO - Return code: 0 08:48:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:48:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:24 INFO - Reading from file tmpfile_stdout 08:48:24 INFO - Current package versions: 08:48:24 INFO - argparse == 1.2.1 08:48:24 INFO - blessings == 1.6 08:48:24 INFO - blobuploader == 1.2.4 08:48:24 INFO - docopt == 0.6.1 08:48:24 INFO - manifestparser == 1.1 08:48:24 INFO - mozInstall == 1.12 08:48:24 INFO - mozcrash == 0.17 08:48:24 INFO - mozdebug == 0.1 08:48:24 INFO - mozdevice == 0.48 08:48:24 INFO - mozfile == 1.2 08:48:24 INFO - mozhttpd == 0.7 08:48:24 INFO - mozinfo == 0.9 08:48:24 INFO - mozleak == 0.1 08:48:24 INFO - mozlog == 3.1 08:48:24 INFO - moznetwork == 0.27 08:48:24 INFO - mozprocess == 0.22 08:48:24 INFO - mozprofile == 0.28 08:48:24 INFO - mozrunner == 6.11 08:48:24 INFO - mozscreenshot == 0.1 08:48:24 INFO - mozsystemmonitor == 0.0 08:48:24 INFO - moztest == 0.7 08:48:24 INFO - mozversion == 1.4 08:48:24 INFO - psutil == 3.1.1 08:48:24 INFO - requests == 1.2.3 08:48:24 INFO - wsgiref == 0.1.2 08:48:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6e63dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7410>, '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 0x1fd8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd87a0>, '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': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:48:24 INFO - Using env: {'DISPLAY': ':0', 08:48:24 INFO - 'HOME': '/home/cltbld', 08:48:24 INFO - 'LANG': 'en_US.UTF-8', 08:48:24 INFO - 'LANGUAGE': 'en_US:en', 08:48:24 INFO - 'LOGNAME': 'cltbld', 08:48:24 INFO - 'MAIL': '/var/mail/cltbld', 08:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:24 INFO - 'MOZ_NO_REMOTE': '1', 08:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:24 INFO - 'NO_EM_RESTART': '1', 08:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:24 INFO - 'PWD': '/builds/slave/test', 08:48:24 INFO - 'SHELL': '/bin/bash', 08:48:24 INFO - 'SHLVL': '1', 08:48:24 INFO - 'TERM': 'linux', 08:48:24 INFO - 'TMOUT': '86400', 08:48:24 INFO - 'USER': 'cltbld', 08:48:24 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 08:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:24 INFO - '_': '/tools/buildbot/bin/python'} 08:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:48:24 INFO - Cleaning up... 08:48:24 INFO - Return code: 0 08:48:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6e63dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7410>, '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 0x1fd8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd87a0>, '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': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:48:24 INFO - Using env: {'DISPLAY': ':0', 08:48:24 INFO - 'HOME': '/home/cltbld', 08:48:24 INFO - 'LANG': 'en_US.UTF-8', 08:48:24 INFO - 'LANGUAGE': 'en_US:en', 08:48:24 INFO - 'LOGNAME': 'cltbld', 08:48:24 INFO - 'MAIL': '/var/mail/cltbld', 08:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:24 INFO - 'MOZ_NO_REMOTE': '1', 08:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:24 INFO - 'NO_EM_RESTART': '1', 08:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:24 INFO - 'PWD': '/builds/slave/test', 08:48:24 INFO - 'SHELL': '/bin/bash', 08:48:24 INFO - 'SHLVL': '1', 08:48:24 INFO - 'TERM': 'linux', 08:48:24 INFO - 'TMOUT': '86400', 08:48:24 INFO - 'USER': 'cltbld', 08:48:24 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 08:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:24 INFO - '_': '/tools/buildbot/bin/python'} 08:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:24 INFO - Downloading/unpacking jsonschema 08:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:48:27 INFO - Downloading/unpacking functools32 (from jsonschema) 08:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:27 INFO - Downloading functools32-3.2.3-2.tar.gz 08:48:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:48:27 INFO - warning: no files found matching '*.txt' 08:48:27 INFO - no previously-included directories found matching 'build' 08:48:27 INFO - no previously-included directories found matching 'dist' 08:48:27 INFO - no previously-included directories found matching '.git*' 08:48:27 INFO - Installing collected packages: jsonschema, functools32 08:48:27 INFO - Running setup.py install for functools32 08:48:27 INFO - warning: no files found matching '*.txt' 08:48:27 INFO - no previously-included directories found matching 'build' 08:48:27 INFO - no previously-included directories found matching 'dist' 08:48:27 INFO - no previously-included directories found matching '.git*' 08:48:27 INFO - Successfully installed jsonschema functools32 08:48:27 INFO - Cleaning up... 08:48:27 INFO - Return code: 0 08:48:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:27 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 0x7fe6e63dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7410>, '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 0x1fd8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd87a0>, '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': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:48:27 INFO - Using env: {'DISPLAY': ':0', 08:48:27 INFO - 'HOME': '/home/cltbld', 08:48:27 INFO - 'LANG': 'en_US.UTF-8', 08:48:27 INFO - 'LANGUAGE': 'en_US:en', 08:48:27 INFO - 'LOGNAME': 'cltbld', 08:48:27 INFO - 'MAIL': '/var/mail/cltbld', 08:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:27 INFO - 'MOZ_NO_REMOTE': '1', 08:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:27 INFO - 'NO_EM_RESTART': '1', 08:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:27 INFO - 'PWD': '/builds/slave/test', 08:48:27 INFO - 'SHELL': '/bin/bash', 08:48:27 INFO - 'SHLVL': '1', 08:48:27 INFO - 'TERM': 'linux', 08:48:27 INFO - 'TMOUT': '86400', 08:48:27 INFO - 'USER': 'cltbld', 08:48:27 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 08:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:27 INFO - '_': '/tools/buildbot/bin/python'} 08:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:27 INFO - Downloading/unpacking flake8 08:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:48:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:48:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:48:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:48:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:48:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:48:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:48:30 INFO - no previously-included directories found matching 'docs/_build' 08:48:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:48:30 INFO - Running setup.py install for pep8 08:48:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:48:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:48:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:48:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:48:30 INFO - no previously-included directories found matching 'docs/_build' 08:48:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:48:30 INFO - Cleaning up... 08:48:30 INFO - Return code: 0 08:48:30 INFO - Running post-action listener: _resource_record_post_action 08:48:30 INFO - Running post-action listener: _start_resource_monitoring 08:48:30 INFO - Starting resource monitoring. 08:48:30 INFO - ##### 08:48:30 INFO - ##### Running install step. 08:48:30 INFO - ##### 08:48:30 INFO - Running pre-action listener: _resource_record_pre_action 08:48:30 INFO - Running main action method: install 08:48:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:31 INFO - Reading from file tmpfile_stdout 08:48:31 INFO - Detecting whether we're running mozinstall >=1.0... 08:48:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:48:31 INFO - Reading from file tmpfile_stdout 08:48:31 INFO - Output received: 08:48:31 INFO - Usage: mozinstall [options] installer 08:48:31 INFO - Options: 08:48:31 INFO - -h, --help show this help message and exit 08:48:31 INFO - -d DEST, --destination=DEST 08:48:31 INFO - Directory to install application into. [default: 08:48:31 INFO - "/builds/slave/test"] 08:48:31 INFO - --app=APP Application being installed. [default: firefox] 08:48:31 INFO - mkdir: /builds/slave/test/build/application 08:48:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:48:46 INFO - Reading from file tmpfile_stdout 08:48:46 INFO - Output received: 08:48:46 INFO - /builds/slave/test/build/application/firefox/firefox 08:48:46 INFO - Running post-action listener: _resource_record_post_action 08:48:46 INFO - ##### 08:48:46 INFO - ##### Running run-tests step. 08:48:46 INFO - ##### 08:48:46 INFO - Running pre-action listener: _resource_record_pre_action 08:48:46 INFO - Running main action method: run_tests 08:48:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:48:46 INFO - Python 2.7.3 08:48:46 INFO - Return code: 0 08:48:46 INFO - grabbing minidump binary from tooltool 08:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:46 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7410>, '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 0x1fd8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd87a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:48:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:48:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:48:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:48:46 INFO - Return code: 0 08:48:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:48:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:48:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:48:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:48:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:48:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:48:47 INFO - Return code: 0 08:48:47 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:48:47 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:48:47 INFO - Using env: {'DISPLAY': ':0', 08:48:47 INFO - 'HOME': '/home/cltbld', 08:48:47 INFO - 'LANG': 'en_US.UTF-8', 08:48:47 INFO - 'LANGUAGE': 'en_US:en', 08:48:47 INFO - 'LOGNAME': 'cltbld', 08:48:47 INFO - 'MAIL': '/var/mail/cltbld', 08:48:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:48:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:47 INFO - 'MOZ_NO_REMOTE': '1', 08:48:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:47 INFO - 'NO_EM_RESTART': '1', 08:48:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:47 INFO - 'PWD': '/builds/slave/test', 08:48:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:48:47 INFO - 'SHELL': '/bin/bash', 08:48:47 INFO - 'SHLVL': '1', 08:48:47 INFO - 'TERM': 'linux', 08:48:47 INFO - 'TMOUT': '86400', 08:48:47 INFO - 'USER': 'cltbld', 08:48:47 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313', 08:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:47 INFO - '_': '/tools/buildbot/bin/python'} 08:48:47 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:48:48 INFO - mozversion application_buildid: 20160318075414 08:48:48 INFO - mozversion application_changeset: d211f362a8fa08816c8f0a19fc9a2f7f11aeff43 08:48:48 INFO - mozversion application_display_name: Nightly 08:48:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:48:48 INFO - mozversion application_name: Firefox 08:48:48 INFO - mozversion application_remotingname: firefox 08:48:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:48:48 INFO - mozversion application_vendor: Mozilla 08:48:48 INFO - mozversion application_version: 48.0a1 08:48:48 INFO - mozversion platform_buildid: 20160318075414 08:48:48 INFO - mozversion platform_changeset: d211f362a8fa08816c8f0a19fc9a2f7f11aeff43 08:48:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:48:48 INFO - mozversion platform_version: 48.0a1 08:48:48 INFO - using testdate: 1458316128 08:48:48 INFO - actual date: 1458316128 08:48:48 INFO - starting webserver on 'localhost:46876' 08:48:48 INFO - SUITE-START | Running 2 tests 08:48:48 INFO - TEST-START | dromaeo_css 08:48:48 INFO - operating with platform_type : linux_ 08:48:48 INFO - Initialising browser for dromaeo_css test... 08:48:48 INFO - TEST-INFO | started process 28190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxV4cLE/profile http://localhost:46876/getInfo.html) 08:48:52 INFO - PROCESS | 28190 | __metrics Screen width/height:1600/1200 08:48:52 INFO - PROCESS | 28190 | colorDepth:24 08:48:52 INFO - PROCESS | 28190 | Browser inner width/height: 1024/697 08:48:52 INFO - PROCESS | 28190 | __metrics 08:48:52 ERROR - PROCESS | 28190 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:48:53 INFO - TEST-INFO | 28190: exit 0 08:48:53 INFO - Browser initialized. 08:48:53 INFO - Running cycle 1/1 for dromaeo_css test... 08:48:53 INFO - TEST-INFO | started process 28282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxV4cLE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:05 INFO - PROCESS | 28282 | RSS: Main: 154722304 08:49:05 INFO - PROCESS | 28282 | 08:49:56 INFO - PROCESS | 28282 | 1458316196835 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:52:08 INFO - PROCESS | 28282 | Cycle 1(1): loaded http://localhost:46876/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46876/tests/dromaeo/cssquery-ext.html) 08:52:09 INFO - PROCESS | 28282 | RSS: Main: 267636736 08:52:09 INFO - PROCESS | 28282 | 08:55:11 INFO - PROCESS | 28282 | Cycle 1(1): loaded http://localhost:46876/tests/dromaeo/cssquery-ext.html (next: http://localhost:46876/tests/dromaeo/cssquery-jquery.html) 08:55:12 INFO - PROCESS | 28282 | RSS: Main: 235302912 08:55:12 INFO - PROCESS | 28282 | 08:58:14 INFO - PROCESS | 28282 | Cycle 1(1): loaded http://localhost:46876/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46876/tests/dromaeo/cssquery-mootools.html) 08:58:15 INFO - PROCESS | 28282 | RSS: Main: 232730624 08:58:15 INFO - PROCESS | 28282 | 09:01:17 INFO - PROCESS | 28282 | Cycle 1(1): loaded http://localhost:46876/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46876/tests/dromaeo/cssquery-prototype.html) 09:01:17 INFO - PROCESS | 28282 | RSS: Main: 211972096 09:01:17 INFO - PROCESS | 28282 | 09:04:20 INFO - PROCESS | 28282 | Cycle 1(1): loaded http://localhost:46876/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46876/tests/dromaeo/cssquery-yui.html) 09:04:20 INFO - PROCESS | 28282 | RSS: Main: 205893632 09:04:20 INFO - PROCESS | 28282 | 09:07:23 INFO - PROCESS | 28282 | Cycle 1(1): loaded http://localhost:46876/tests/dromaeo/cssquery-yui.html (next: http://localhost:46876/tests/dromaeo/cssquery-dojo.html) 09:07:23 INFO - PROCESS | 28282 | RSS: Main: 272023552 09:07:23 INFO - PROCESS | 28282 | 09:07:23 INFO - PROCESS | 28282 | __start_tp_report 09:07:23 INFO - PROCESS | 28282 | _x_x_mozilla_page_load 09:07:23 INFO - PROCESS | 28282 | _x_x_mozilla_page_load_details 09:07:23 INFO - PROCESS | 28282 | |i|pagename|runs| 09:07:23 INFO - PROCESS | 28282 | |0;dojo.html;2626.6191402246673;2689.3411114277005;2703.297142742889;2711.2408525612836;2731.2762118038722;4665.83669571565;4689.390379250697;4710.599599034082;4714.599259062979;4803;4673.672842900998;4719.90560188796;4756.239001759719;4773.90452190956;4789.066132104241;4332.718373305733;4343.457067866517;4343.478782546099;4393.846215382462;4398.582134697199;4435.512093669694;4437.378766972626;4484.394606728099;4519.977400113011;4529.2526733089;4294.527601963781;4344.761038142901;4369.12617476506;4431.556844315575;4473.881529617612;4351.760653164075;4375.540568240321;4385.122975404932;4403.097365040159;4411.426514553087;4337.349397590355;4344.6524278058;4347.695661303678;4349.5215526292395;4386.29819228925;4527.909441811178;4566.1552612766745;4610.792514336829;4620.283856002325;4661.72029678217;5023.14606516893;5036.546710796009;5046.6719663221775;5047.848564543069;5080.695158290514;5072.34059572257;5078.390593128811;5078.5937125029905;5080.390353157608;5124.052050370693;4647.024124933768;4720.976395118071;4739.73931433771;4816.060868130751;4819.445763737215;5237.580993520509;5249.658772179796;5252.028374750607;5252.842414727565;5279.762410691528;5031.371078615173;5042.42012168598;5045.318881950963;5048.848534543969;5096.6941983480365;4960.404751429852;5066.16408292635;5099.311592934981;5118.923216151761;5156.20078887773;5028.874278143076;5049.823256186016;5055.292259083658;5061.367329083864;5105.719185444762;5045.217991211368;5046.34397528319;5049.772760225798;5051.6716413433005;5053.7220452875445;4134.855280065183;4158.812853421603;4204.5375008749015;4224.5353011168745;4226.619604235633;3713.3687273163628;3722.088088418355;3732.757370770891;3744.4196149596855;3768.1521657626813;4375.949772054748;4377.846775362911;4380.167768124046;4381.036172042146;4424;4959.776810043557;5052.216906379517;5091.210862316347;5127.66670166438;5132.332796736475;4393.846215382447;4411.8014689338415;4413.337999300131;4417.0724147929295;4455.086707225011;4478.149151661174;4548.403517352207;4574.542545745466;4582.24392975162;4611.769411529477;4844.588210002189;4892.143874821821;4893.804247830047;4918.336024636628;4934;5101.0818052750865;5147.099257629825;5147.6654017488745;5154.046501397103;5198.922016169836;4706.247000479907;4889.486603906681;4907.312976183409;4907.337509436323;4957.752112394293;4987.202047672355;4995.400551933792;5016.899662006813;5062.519060689228;5070.290159377616;5091.1854103343285;5104.05574968632;5105.7191854448365;5112.207607820794;5151.562117219928;4858.149823780754;4934.827281045146;4935.506449355035;4953.356063711694;4955.380577427822;4906.705597664151;4923.163062279349;4931.605471562195;4946.62900282473;4972.055309491185;4847.660663753503;4852.078105160008;4853.514648535118;4854.19905715553;4900.779464924016;4894.975525122494;4897.46127925935;4910.9263361050325;4956.157453232887;4971.403431588233;4842.15262329084;4866.975665121652;4869;4879.804807807648;4915.287283343967 09:07:23 INFO - PROCESS | 28282 | |1;ext.html;543.6928135603381;554.4954091776483;569.4931510955253;576.5618130221031;578.1587789765891;26851.32871678209;34299.31401371974;34740.65259347406;34880.82559587198;34881.47677784835;37266;37774.055648608795;37837.24325513495;37842.62157378425;37876.242475150546;7659.923400765991;7780.766577002699;7784.026996625422;7784.104827944774;7813.140554538996;7706.190849960757;7816.609169541529;7827.060752709683;7831.334336581397;7834.177411371809;7815.726449574266;7874.6456409461425;7877.291043806056;7881.7241396551135;7884.842303153933;7758.418118641096;7819.452638315321;7821.608919554;7822.804429889298;7825.060992680887;7784.649690763929;7827.6868925242925;7827.96086019572;7829.412794040412;7896.763097107096;38192.80903595464;39021.80489097565;39082.21835563301;39184.60815391838;39359.60640393588;2903.375774208534;2944.455275773989;2995.2961054152256;2999.8350090745002;3021.894233701832;28794.424111517652;28989.710102898913;29155.271118222;29521.409571808657;29667.70332296671;3084.5373194021076;3106.502959526465;3165.6359518655418;3169.065125787875;3229.1765599771907;241246;241666;241735;241837;241915.99999999825;48150.518494815304;54708.452915471134;55028.72485637626;55048.72475637596;56090.158647620316;50982;51249;51287;51389.48610513847;51395;14584.854151458561;15106.093634381972;15126.924365378323;15133.924330378277;15153.54539363821;9327.02066283044;11351.318920864609;11480.368579728029;11853.585124520772;12132.090093242865;18264.726029109574;18344.633107337777;18349.3577724779;18421.447356579323;18469.81530184681;7306.671199796022;7470.36501897334;7511.887321690179;7518.210587888193;7621.542707437571;920.2637889688223;942.3450701762347;982.1210017034714;1000.3197825478744;1076.6393258258415;26609;27762.722372776418;27840.443191136063;28317;28393.858030710126;959.0697023886819;1000.5142363590063;1004.5931397783909;1031.582209205273;1122.0182340452104;13930.86069139316;14485.855141448661;14503.1298122113;14629.707405851823;14701.632459188606;303815.8092095386;309216;309284;309738;310019;48877.51122488801;49114.26328605074;49148.50851491439;49159;49257.50742492601;1078.3260462211117;1251.466952982589;1268.6130730127215;1274.0317358807188;1288.909776315649;25545.23364299074;27151.59272610873;27468.313292167855;28105.43789124165;28106.156815295573;35509.86940783561;35954.28091438209;36298.63701362952;36401.635983639826;36421;177776;182278;194555;194910;195284;26755.46489070169;30698.539521907634;30734.231644209074;31650.525242121847;31661.208469787518;34725;35311.64688353187;35437.46843797397;35694.464583030756;36111.45832812563;30928.845355773075;34004.82997584996;34156.82921585376;34312.65687343095;34398.312033759685;33518.329633406705;33853;34184.316313674084;34258.828705856315;34278.14304642304;33453.83273083619;34127.658723412445;34295.31409371849;34333.313333733684;34426.31147377088;29424.26439339034;30304.39391212119;30500.84749576238;30554;30556.236094097825;23876.52246955086;23965.884435023334;24299.514009719354;24343.756562434148;24429.26712198637 09:07:23 INFO - PROCESS | 28282 | |2;jquery.html;343.965603439656;363.9745217834751;368.34250862210956;375.09227669040916;379.0334646651039;15537;15979.280932358042;17100.315987360507;17395.391161309355;17486.737698934525;16160.83839161608;16546.83453165468;16822.57943551412;16944.23750931208;17001.23494442753;4507.233770259048;4919.966806970522;5005.649604527675;5012.273220383042;5120.871978200556;5032.320636714052;5104.412992505853;5113.872153196163;5122.8207012754565;5131.692098474085;5044.772985215655;5098.235264710304;5098.821541246057;5103.132467480537;5312.681239125645;5257.947420525803;5263.157894736823;5284.920726189111;5305.946940530584;5306.151015837467;5046.167382381903;5110.795568177268;5116.744162791882;5120.61595380348;5187.19598462239;12079.698007549794;12312.322822244772;12324.81512777309;12419.379031048411;12428.875711242952;1859.191251805469;1875.8217969292896;1937.728717979484;1945.9805401945941;1986.2650819196845;9167.862482062774;9195.954020229923;9294;9387.76530586734;9568.5694143763;1767.3195819609543;1791.1492041280417;1809.2448239908592;1827.7167039108826;1853.8146185381488;44132;56225.43774562243;58086.419135808945;59785.70107149436;64124;10569.207309451822;10573.894261057445;10605.787884242427;10735.248532602798;10739.087177589836;12163.574274900337;12687.936560317139;13241.27173005494;13263.204207747565;13825.10136841102;6930.410915072275;7055.7177712891935;7148.356647901714;7175.748848790267;7289.963550182215;6423.582467139621;6443.935560644333;6486.67566621667;6812.931870681329;6828.112345395166;4366.541513141138;4369.47566292047;4394.494633117232;4520.706154099973;4520.728756274634;1791.480470663519;1793.6323053773945;1808.1230603157458;1836.8714190006572;1842.7420161177447;859.9957000214958;866.181458521691;881.7883707910055;885.406777459104;895.6417433026842;14866.331015104346;15619.136960600476;15679.294431750599;16096.195190240442;16162;833.5582141465034;857.3698331726176;857.7984173719171;877.2499512916493;900.7883147460342;7806.18035106317;8923.866142007875;9214.539273036455;9248.167664910055;9383.765405864908;421745;441890;444678;453611;453646;69729.65135174291;71126;71232.2876771236;71545;71775.64112179406;872.4852337121129;888.0542222532981;889.9777505562283;890.7372325164092;966.3960024984385;14438.579678336931;14485.348159332645;14557.92721036388;14636.85363146355;15595.142267175414;27298.863505682344;27555.448891021668;27774.44451110926;35815.82092089523;36240.09399765027;38987.6101238984;39097.41353879751;39221.2155756889;39347;40613.1877362457;7308.123025237006;7342.118945726547;7419.814504637211;7448.851022979618;7461.440391970733;8795.208431241219;9865.950670246602;10747.785044299226;11405.429728513707;11661.06711463098;9862.358946668444;9898.10917017472;9938.45338506389;10105.24210684187;10356.948215258875;9166.770830729018;9436.575354109218;9602.951985240308;9849.901500985185;10010.44942528168;9926.15627671656;9931;10297.53661085238;10317.535710892878;10708.250422470352;7006.159260888522;7007.859842803217;7075.893861592183;7124.501284910007;7186.640667966685;7577.659005344883;9092.77268068277;9490.335676502578;9570.282228833004;9830.852537211804 09:07:23 INFO - PROCESS | 28282 | |3;mootools.html;1233.0751936047964;1412.992935035325;1419.1626940105339;1587.412657316793;1801.4235444657706;6764.188297404312;7405.370543503802;7563.394928405728;7589.430792690543;7597.92402075979;7506.474546781727;7610.58141802202;7632.809179770508;7636.312731854132;7641.159472458039;1938.7285779990812;2248.2693124734446;2308.2728940383727;2321.3500219938446;2353.788159065684;2307.9884600576975;2309.515001849614;2315.8147348212187;2316.6756654068445;2318.710161229846;2257.559775843711;2319.686842276288;2323.2913961241816;2324.2562380038394;2324.476992676651;2276.2147059264526;2310.410845234463;2321.8955147018423;2330.079618550663;2331.8484298520625;2296.6784650148993;2342.6251799712136;2356.575816353056;2356.7643235676464;2357.787799098089;7749.728759493447;7820.5307681538725;7827.882581761278;7832.412569057344;7835.764927052198;4829.058333624945;4926.630502712311;4933.901321973541;4947.851564453073;4953.678010929278;3035.666076731558;3135.561021456998;3171.096237572304;3237.0612522368483;3241.4489536778806;963.2871674960548;974.5517062151418;987.9901200988041;988.0810845913297;1021.1269364693229;10749.516271767789;10912.072473839733;10930.453477326022;10939.890601093966;10976.506057227443;4495.775211239425;4560.5211452796975;4665.4168228971375;4677.22825733757;4692.061587682477;9166.954165229132;9256.490893000815;9261.16649501548;9272.443653380818;9309.627614895327;4261.105167914772;4947.529984651453;4950.529699678525;4954.578860796801;4956.3804524434445;4311.8490852820005;4334.371516130143;4376.540463251376;4377.671674624416;4410.911781764346;3713.090292878208;3821.8662346818282;3837.7505462144873;3857.517810273716;3866.4586957825363;1267.2966503590596;1287.5815360008035;1289.052546378411;1289.6066699656508;1300.2523548959387;1134.8354488599107;1140.0366690146814;1143.5197217168643;1158.8783177766381;1175.905927525796;7332.743353982585;7462.253774622603;7467.1039475263315;7475.439342049368;7487.3261406473675;1056.7041228456044;1060.9045185933303;1081.799867024603;1084.4035780320792;1098.9505472253768;5428.104362780176;5582;5611.270534830446;5650.830475085754;5655.575831812631;9271.07289271081;9406.811863762687;9484.525773711286;9536.189423898908;9558.378705384266;9349.953250233706;9351.859722104175;9575.138237558653;9640.325177237526;9642.903570964341;7396.3713084387355;7561.584112873845;7613.0483689538805;7620.237976202336;7630.694772209161;7085.964570177116;7107.040549525748;7107.786766397016;7168.713251469882;7190.676419561237;8563.95718021406;8621.482711037357;8687.739367818975;8751.562421879007;8775.297976162019;8704.91295087041;8811.60347784364;9006.864897026418;9017.729468115967;9025.097490250922;5675.177099320658;6108.45023947829;6353.4599559038;6546.083548303337;6676.83307917306;7228.096487939008;7256.818579535554;7265.527740696838;7297.963510182628;7308.086489188851;6420.165378500765;6653.700583473658;6687.832804179934;6803.761868334783;6836.042953986346;6537.8692426152165;6546.0508226307875;6566;6598.538102332791;6622.933770662425;6795.626240556619;6836.28219036994;6869.416099631388;6885.173779146535;6886.208086070166;6365.490760739037;6419.743210271537;6420.454261387835;6440.452561532322;6442.162518872517;6456.322086180883;6467.385598368148;6472.579282346633;6495.382938620824;6519.348065193442 09:07:23 INFO - PROCESS | 28282 | |4;prototype.html;325.9820709860957;329.83013747919813;330.8081312838554;331.11592049228557;338.56156277620494;5369.973150134244;5374.355077390714;5376.542993845523;5381.757820898054;5393.217983392406;5265.7893684252585;5282.841514754554;5298.841034768953;5311.2298716686055;5311.973440132803;3945.881623551298;4092.3452247640384;4149.7302675326155;4165.354370072636;4188.455500784894;4157.8544750933725;4166.1251137261215;4167.6457501112445;4171.89444797129;4182.477190351206;4109.178164367124;4130.318497447917;4131.483564554431;4133.256013917494;4138;3918.4318273850276;4067.7966101694947;4144.544100148981;4146.91706165878;4163.75017498948;3687.8893633191046;3691.870784522529;3697.3529632314508;3697.8335974881193;3706.5366829146355;5096.898062038738;5111.872203194913;5129.563987061104;5132.640715149941;5141.76862041209;4825.179719447702;4826.155422800995;4828.324034635154;4833.492483289274;4833.830815921461;5603.803866864681;5606.831795046114;5614.494695477427;5617.831465056055;5619.269494965669;4073.4704488416614;4075.449814275094;4077.2864748668862;4078.082431452929;4085.8569950051606;5636.971815140898;5840.240768700084;5854.97072514639;5856.472917437409;5861.706914654293;3950.4469374287623;3967.246223217637;3970;3980.0447892506168;3994.580569040267;4009.558948515661;4026.9798651007145;4027.8791636250958;4037.515498140242;4040.6565441937178;4641.373414589055;4644.581987621063;4647.790849411785;4653.069386122789;4657.906841863144;5546.500814926676;5574.9442505574425;5579.525740312119;5585.134304182858;5591.189277554813;1477.416420513891;1499.520153550875;1500.1524138861507;1503.646643038885;1503.9548813535612;966.7486453522135;1024.2164743970868;1037.4864442101057;1041.146260066753;1061.4215252687304;4925.950740492549;4938.802447902115;4949.628777841676;4953.6037117030555;4956.157453232887;5794.88410231793;5808.535317174616;5809.099589563624;5810.680412577349;5812.738426770806;4929.605631549467;4941.209406494943;4945.9258111128365;4948.38145231846;4949.579285760678;3080.4455198064115;3111.0355789705263;3114.408262430131;3119.922001949924;3120.531920211941;5482.068048431776;5483.917741233885;5490.505854473036;5492.231087647732;5492.47821456961;5816.796412125555;6072.089186621954;6082.908756368658;6090.725917333731;6098.664573448503;5549.667019978814;5550.69471179089;5556.055470570093;5559.694216818033;5562.91655625174;5876.236089308362;5876.911846322394;5879.764809407576;5882.617629854046;5890.941090589039;5735.971320143372;5736.42635736423;5742.827715168552;5798.971005144947;5819.330776960704;5378.112611419228;5550.888982220252;5557.472040156179;5600.467955544217;5615.7192140392;3990.30169720292;4029.0531725045175;4047.615476529725;4055.310597198424;4073.124278280184;5865.120231965068;5865.853353666022;5872.236609240771;5873.647581145145;5881.147233651182;5663.943360566506;5670.234518339971;5673.914891276717;5675.7445914933105;5678.971605141948;5657.547396208376;5660.235868157911;5661.688607126647;5663.263775709132;5682.289713785777;5389.86525336854;5567.025770490067;5585.273914391266;5587.469190426903;5588.133839254922;5614.6631202128;5652.265205523256;5675.120356344773;5681.77272909079;5732.082866741302;5521.0062188804795;5544.251526044094;5581.302337207849;5581.74882130297;5591.077472217201 09:07:23 INFO - PROCESS | 28282 | |5;yui.html;719.0966719492869;753.6118898767136;773.8297574533601;778.3111945927852;794.1264608930178;14757.11457312562;14911.850881491182;15030.624234394145;15067.321970511326;15071.62320941977;14215.076020058688;14222.644433889158;14234.857651423483;14250.643733906658;14295.78556321656;651.3258777165635;812.8049268175639;827.9254867061964;828.0477450931417;829.6100832608695;808.1635507249997;827.8427098851229;836.6067948064431;837.1921096142222;837.3970741066422;860.0281681699671;860.2644738748373;860.6514361683528;863.3007264116055;867.7136544940155;674.8549061951704;840.7729912923477;842.3724325377602;843.8818565400818;845.8731190321439;633.360306090847;633.3824521091944;633.4045996763028;633.9461145802612;634.784173381048;13293.53472628463;13324.333783310893;13377.598672039854;13394.397252123677;13399.866001339959;11669.649910502698;11688.707782305426;12009.159358844885;12077.57728479499;12376.938115309365;9912.89777262205;10095.747606309827;10207;10284.074433300964;10322.7419314517;3241.254511462353;3293.7859039162377;3337.716294115003;3372.6795954384293;3385.407553678121;45390.99999999967;45513.77243113763;45769;45889.54110458886;46045.76977115127;9795.363301385387;9894.455804930654;9918.652847150315;9986.600535978625;10189.74525636865;17236.396726114526;17247.223874925658;17263.309467621155;17263.65472690539;17270.13649317554;6698.263191048981;6871.175458944858;6879.415249703731;7015.088038554955;7092.326229008236;3735.1782607826235;3746.1758413149064;3806.2197249563774;3840.558335791364;3901.941470877939;2876.956845647317;2910.6070680458292;2912.810667306618;2918.212082737649;2928.326484908483;526.6603041038509;527.8653943244448;536.051189394769;545.6944111297686;548.2461615278992;551.7985935133647;554.6838302167806;560.1262031231292;574.3882764855416;587.4888846703395;7427.962860185773;7643.7324693635455;7767.883481747665;7853.253940875607;7867.763967080997;436.11686335170896;463.6870112673999;518.4530320511897;551.2998491915246;555.9249501317352;3505.9298814024087;3526.594441639193;3537.3986422307753;3542.8937131886087;3673.7061035117663;55459.72270138704;56213.43786562082;56218.71890640521;56312.43687563154;56349;46600.30099548509;46732.53267467282;48050.519494804605;48082.519174808505;48167;40744;40757.38863917044;41380.1723965525;41460.37809432861;41524.37713434301;7954.284114429729;8116.594170291343;8152;8233.135520770233;8260;31906.52140217852;31985;32504.187395315308;32854.34291314208;33238.16904577405;37251;39062;39884.40173397459;43826.78086609547;43832;9377.1091746284;9380.81238375215;9394.389364691546;10005.699829005142;10038.16317876836;11018.39398833072;11126.221164518405;11163.497642606264;11337.26307789991;11339.092872570009;8941.239994600532;9716.3198576099;9952.800943980936;10408.635697750542;10667.786644267226;8786;8849.955750221208;10218;10307.484625768831;10411.115055220089;9844.751232093535;10174.084332410119;10174.898251017396;10514.78970420572;10685.465726713477;9358.4384936904;9457.668981585612;9627.663031793854;9668.274879384215;9887.604495820087;8947;8964.282857371525;9009.23421509179;9093.272538196796;9129.360944733804 09:07:23 INFO - PROCESS | 28282 | __end_tp_report 09:07:23 INFO - PROCESS | 28282 | __start_cc_report 09:07:23 INFO - PROCESS | 28282 | _x_x_mozilla_cycle_collect,1081 09:07:23 INFO - PROCESS | 28282 | __end_cc_report 09:07:23 INFO - PROCESS | 28282 | __startTimestamp1458317243946__endTimestamp 09:07:23 INFO - PROCESS | 28282 | 09:07:23 INFO - PROCESS | 28282 | ------- Summary: start ------- 09:07:23 INFO - PROCESS | 28282 | Number of tests: 6 09:07:23 INFO - PROCESS | 28282 | 09:07:23 INFO - PROCESS | 28282 | [#0] dojo.html Cycles:165 Average:4698.26 Median:4858.15 stddev:492.69 (10.1%) stddev-sans-first:466.63 09:07:23 INFO - PROCESS | 28282 | Values: 2626.6 2689.3 2703.3 2711.2 2731.3 4665.8 4689.4 4710.6 4714.6 4803.0 4673.7 4719.9 4756.2 4773.9 4789.1 4332.7 4343.5 4343.5 4393.8 4398.6 4435.5 4437.4 4484.4 4520.0 4529.3 4294.5 4344.8 4369.1 4431.6 4473.9 4351.8 4375.5 4385.1 4403.1 4411.4 4337.3 4344.7 4347.7 4349.5 4386.3 4527.9 4566.2 4610.8 4620.3 4661.7 5023.1 5036.5 5046.7 5047.8 5080.7 5072.3 5078.4 5078.6 5080.4 5124.1 4647.0 4721.0 4739.7 4816.1 4819.4 5237.6 5249.7 5252.0 5252.8 5279.8 5031.4 5042.4 5045.3 5048.8 5096.7 4960.4 5066.2 5099.3 5118.9 5156.2 5028.9 5049.8 5055.3 5061.4 5105.7 5045.2 5046.3 5049.8 5051.7 5053.7 4134.9 4158.8 4204.5 4224.5 4226.6 3713.4 3722.1 3732.8 3744.4 3768.2 4375.9 4377.8 4380.2 4381.0 4424.0 4959.8 5052.2 5091.2 5127.7 5132.3 4393.8 4411.8 4413.3 4417.1 4455.1 4478.1 4548.4 4574.5 4582.2 4611.8 4844.6 4892.1 4893.8 4918.3 4934.0 5101.1 5147.1 5147.7 5154.0 5198.9 4706.2 4889.5 4907.3 4907.3 4957.8 4987.2 4995.4 5016.9 5062.5 5070.3 5091.2 5104.1 5105.7 5112.2 5151.6 4858.1 4934.8 4935.5 4953.4 4955.4 4906.7 4923.2 4931.6 4946.6 4972.1 4847.7 4852.1 4853.5 4854.2 4900.8 4895.0 4897.5 4910.9 4956.2 4971.4 4842.2 4867.0 4869.0 4879.8 4915.3 09:07:23 INFO - PROCESS | 28282 | 09:07:23 INFO - PROCESS | 28282 | [#1] ext.html Cycles:180 Average:40581.33 Median:34066.24 stddev:65606.41 (192.6%) stddev-sans-first:65721.58 09:07:23 INFO - PROCESS | 28282 | Values: 543.7 554.5 569.5 576.6 578.2 26851.3 34299.3 34740.7 34880.8 34881.5 37266.0 37774.1 37837.2 37842.6 37876.2 7659.9 7780.8 7784.0 7784.1 7813.1 7706.2 7816.6 7827.1 7831.3 7834.2 7815.7 7874.6 7877.3 7881.7 7884.8 7758.4 7819.5 7821.6 7822.8 7825.1 7784.6 7827.7 7828.0 7829.4 7896.8 38192.8 39021.8 39082.2 39184.6 39359.6 2903.4 2944.5 2995.3 2999.8 3021.9 28794.4 28989.7 29155.3 29521.4 29667.7 3084.5 3106.5 3165.6 3169.1 3229.2 241246.0 241666.0 241735.0 241837.0 241916.0 48150.5 54708.5 55028.7 55048.7 56090.2 50982.0 51249.0 51287.0 51389.5 51395.0 14584.9 15106.1 15126.9 15133.9 15153.5 9327.0 11351.3 11480.4 11853.6 12132.1 18264.7 18344.6 18349.4 18421.4 18469.8 7306.7 7470.4 7511.9 7518.2 7621.5 920.3 942.3 982.1 1000.3 1076.6 26609.0 27762.7 27840.4 28317.0 28393.9 959.1 1000.5 1004.6 1031.6 1122.0 13930.9 14485.9 14503.1 14629.7 14701.6 303815.8 309216.0 309284.0 309738.0 310019.0 48877.5 49114.3 49148.5 49159.0 49257.5 1078.3 1251.5 1268.6 1274.0 1288.9 25545.2 27151.6 27468.3 28105.4 28106.2 35509.9 35954.3 36298.6 36401.6 36421.0 177776.0 182278.0 194555.0 194910.0 195284.0 26755.5 30698.5 30734.2 31650.5 31661.2 34725.0 35311.6 35437.5 35694.5 36111.5 30928.8 34004.8 34156.8 34312.7 34398.3 33518.3 33853.0 34184.3 34258.8 34278.1 33453.8 34127.7 34295.3 34333.3 34426.3 29424.3 30304.4 30500.8 30554.0 30556.2 23876.5 23965.9 24299.5 24343.8 24429.3 09:07:23 INFO - PROCESS | 28282 | 09:07:23 INFO - PROCESS | 28282 | [#2] jquery.html Cycles:180 Average:24314.77 Median:5045.47 stddev:72562.89 (1438.2%) stddev-sans-first:72744.12 09:07:23 INFO - PROCESS | 28282 | Values: 344.0 364.0 368.3 375.1 379.0 15537.0 15979.3 17100.3 17395.4 17486.7 16160.8 16546.8 16822.6 16944.2 17001.2 4507.2 4920.0 5005.6 5012.3 5120.9 5032.3 5104.4 5113.9 5122.8 5131.7 5044.8 5098.2 5098.8 5103.1 5312.7 5257.9 5263.2 5284.9 5305.9 5306.2 5046.2 5110.8 5116.7 5120.6 5187.2 12079.7 12312.3 12324.8 12419.4 12428.9 1859.2 1875.8 1937.7 1946.0 1986.3 9167.9 9196.0 9294.0 9387.8 9568.6 1767.3 1791.1 1809.2 1827.7 1853.8 44132.0 56225.4 58086.4 59785.7 64124.0 10569.2 10573.9 10605.8 10735.2 10739.1 12163.6 12687.9 13241.3 13263.2 13825.1 6930.4 7055.7 7148.4 7175.7 7290.0 6423.6 6443.9 6486.7 6812.9 6828.1 4366.5 4369.5 4394.5 4520.7 4520.7 1791.5 1793.6 1808.1 1836.9 1842.7 860.0 866.2 881.8 885.4 895.6 14866.3 15619.1 15679.3 16096.2 16162.0 833.6 857.4 857.8 877.2 900.8 7806.2 8923.9 9214.5 9248.2 9383.8 421745.0 441890.0 444678.0 453611.0 453646.0 69729.7 71126.0 71232.3 71545.0 71775.6 872.5 888.1 890.0 890.7 966.4 14438.6 14485.3 14557.9 14636.9 15595.1 27298.9 27555.4 27774.4 35815.8 36240.1 38987.6 39097.4 39221.2 39347.0 40613.2 7308.1 7342.1 7419.8 7448.9 7461.4 8795.2 9866.0 10747.8 11405.4 11661.1 9862.4 9898.1 9938.5 10105.2 10356.9 9166.8 9436.6 9603.0 9849.9 10010.4 9926.2 9931.0 10297.5 10317.5 10708.3 7006.2 7007.9 7075.9 7124.5 7186.6 7577.7 9092.8 9490.3 9570.3 9830.9 09:07:23 INFO - PROCESS | 28282 | 09:07:23 INFO - PROCESS | 28282 | [#3] mootools.html Cycles:180 Average:5472.10 Median:6419.95 stddev:2827.10 (44.0%) stddev-sans-first:2817.07 09:07:23 INFO - PROCESS | 28282 | Values: 1233.1 1413.0 1419.2 1587.4 1801.4 6764.2 7405.4 7563.4 7589.4 7597.9 7506.5 7610.6 7632.8 7636.3 7641.2 1938.7 2248.3 2308.3 2321.4 2353.8 2308.0 2309.5 2315.8 2316.7 2318.7 2257.6 2319.7 2323.3 2324.3 2324.5 2276.2 2310.4 2321.9 2330.1 2331.8 2296.7 2342.6 2356.6 2356.8 2357.8 7749.7 7820.5 7827.9 7832.4 7835.8 4829.1 4926.6 4933.9 4947.9 4953.7 3035.7 3135.6 3171.1 3237.1 3241.4 963.3 974.6 988.0 988.1 1021.1 10749.5 10912.1 10930.5 10939.9 10976.5 4495.8 4560.5 4665.4 4677.2 4692.1 9167.0 9256.5 9261.2 9272.4 9309.6 4261.1 4947.5 4950.5 4954.6 4956.4 4311.8 4334.4 4376.5 4377.7 4410.9 3713.1 3821.9 3837.8 3857.5 3866.5 1267.3 1287.6 1289.1 1289.6 1300.3 1134.8 1140.0 1143.5 1158.9 1175.9 7332.7 7462.3 7467.1 7475.4 7487.3 1056.7 1060.9 1081.8 1084.4 1099.0 5428.1 5582.0 5611.3 5650.8 5655.6 9271.1 9406.8 9484.5 9536.2 9558.4 9350.0 9351.9 9575.1 9640.3 9642.9 7396.4 7561.6 7613.0 7620.2 7630.7 7086.0 7107.0 7107.8 7168.7 7190.7 8564.0 8621.5 8687.7 8751.6 8775.3 8704.9 8811.6 9006.9 9017.7 9025.1 5675.2 6108.5 6353.5 6546.1 6676.8 7228.1 7256.8 7265.5 7298.0 7308.1 6420.2 6653.7 6687.8 6803.8 6836.0 6537.9 6546.1 6566.0 6598.5 6622.9 6795.6 6836.3 6869.4 6885.2 6886.2 6365.5 6419.7 6420.5 6440.5 6442.2 6456.3 6467.4 6472.6 6495.4 6519.3 09:07:23 INFO - PROCESS | 28282 | 09:07:23 INFO - PROCESS | 28282 | [#4] prototype.html Cycles:180 Average:4680.34 Median:5290.84 stddev:1365.64 (25.8%) stddev-sans-first:1329.79 09:07:23 INFO - PROCESS | 28282 | Values: 326.0 329.8 330.8 331.1 338.6 5370.0 5374.4 5376.5 5381.8 5393.2 5265.8 5282.8 5298.8 5311.2 5312.0 3945.9 4092.3 4149.7 4165.4 4188.5 4157.9 4166.1 4167.6 4171.9 4182.5 4109.2 4130.3 4131.5 4133.3 4138.0 3918.4 4067.8 4144.5 4146.9 4163.8 3687.9 3691.9 3697.4 3697.8 3706.5 5096.9 5111.9 5129.6 5132.6 5141.8 4825.2 4826.2 4828.3 4833.5 4833.8 5603.8 5606.8 5614.5 5617.8 5619.3 4073.5 4075.4 4077.3 4078.1 4085.9 5637.0 5840.2 5855.0 5856.5 5861.7 3950.4 3967.2 3970.0 3980.0 3994.6 4009.6 4027.0 4027.9 4037.5 4040.7 4641.4 4644.6 4647.8 4653.1 4657.9 5546.5 5574.9 5579.5 5585.1 5591.2 1477.4 1499.5 1500.2 1503.6 1504.0 966.7 1024.2 1037.5 1041.1 1061.4 4926.0 4938.8 4949.6 4953.6 4956.2 5794.9 5808.5 5809.1 5810.7 5812.7 4929.6 4941.2 4945.9 4948.4 4949.6 3080.4 3111.0 3114.4 3119.9 3120.5 5482.1 5483.9 5490.5 5492.2 5492.5 5816.8 6072.1 6082.9 6090.7 6098.7 5549.7 5550.7 5556.1 5559.7 5562.9 5876.2 5876.9 5879.8 5882.6 5890.9 5736.0 5736.4 5742.8 5799.0 5819.3 5378.1 5550.9 5557.5 5600.5 5615.7 3990.3 4029.1 4047.6 4055.3 4073.1 5865.1 5865.9 5872.2 5873.6 5881.1 5663.9 5670.2 5673.9 5675.7 5679.0 5657.5 5660.2 5661.7 5663.3 5682.3 5389.9 5567.0 5585.3 5587.5 5588.1 5614.7 5652.3 5675.1 5681.8 5732.1 5521.0 5544.3 5581.3 5581.7 5591.1 09:07:23 INFO - PROCESS | 28282 | 09:07:23 INFO - PROCESS | 28282 | [#5] yui.html Cycles:180 Average:12993.61 Median:48066.52 stddev:14955.12 (31.1%) stddev-sans-first:14968.66 09:07:23 INFO - PROCESS | 28282 | Values: 719.1 753.6 773.8 778.3 794.1 14757.1 14911.9 15030.6 15067.3 15071.6 14215.1 14222.6 14234.9 14250.6 14295.8 651.3 812.8 827.9 828.0 829.6 808.2 827.8 836.6 837.2 837.4 860.0 860.3 860.7 863.3 867.7 674.9 840.8 842.4 843.9 845.9 633.4 633.4 633.4 633.9 634.8 13293.5 13324.3 13377.6 13394.4 13399.9 11669.6 11688.7 12009.2 12077.6 12376.9 9912.9 10095.7 10207.0 10284.1 10322.7 3241.3 3293.8 3337.7 3372.7 3385.4 45391.0 45513.8 45769.0 45889.5 46045.8 9795.4 9894.5 9918.7 9986.6 10189.7 17236.4 17247.2 17263.3 17263.7 17270.1 6698.3 6871.2 6879.4 7015.1 7092.3 3735.2 3746.2 3806.2 3840.6 3901.9 2877.0 2910.6 2912.8 2918.2 2928.3 526.7 527.9 536.1 545.7 548.2 551.8 554.7 560.1 574.4 587.5 7428.0 7643.7 7767.9 7853.3 7867.8 436.1 463.7 518.5 551.3 555.9 3505.9 3526.6 3537.4 3542.9 3673.7 55459.7 56213.4 56218.7 56312.4 56349.0 46600.3 46732.5 48050.5 48082.5 48167.0 40744.0 40757.4 41380.2 41460.4 41524.4 7954.3 8116.6 8152.0 8233.1 8260.0 31906.5 31985.0 32504.2 32854.3 33238.2 37251.0 39062.0 39884.4 43826.8 43832.0 9377.1 9380.8 9394.4 10005.7 10038.2 11018.4 11126.2 11163.5 11337.3 11339.1 8941.2 9716.3 9952.8 10408.6 10667.8 8786.0 8850.0 10218.0 10307.5 10411.1 9844.8 10174.1 10174.9 10514.8 10685.5 9358.4 9457.7 9627.7 9668.3 9887.6 8947.0 8964.3 9009.2 9093.3 9129.4 09:07:23 INFO - PROCESS | 28282 | -------- Summary: end -------- 09:07:23 INFO - PROCESS | 28282 | 09:07:24 INFO - TEST-INFO | 28282: exit 0 09:07:24 INFO - TEST-OK | dromaeo_css | took 1116603ms 09:07:24 INFO - TEST-START | kraken 09:07:24 INFO - operating with platform_type : linux_ 09:07:24 INFO - Initialising browser for kraken test... 09:07:24 INFO - TEST-INFO | started process 28459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphsd54m/profile http://localhost:46876/getInfo.html) 09:07:28 INFO - PROCESS | 28459 | __metrics Screen width/height:1600/1200 09:07:28 INFO - PROCESS | 28459 | colorDepth:24 09:07:28 INFO - PROCESS | 28459 | Browser inner width/height: 1024/697 09:07:28 INFO - PROCESS | 28459 | __metrics 09:07:29 ERROR - PROCESS | 28459 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:07:30 INFO - TEST-INFO | 28459: exit 0 09:07:30 INFO - Browser initialized. 09:07:30 INFO - Running cycle 1/1 for kraken test... 09:07:30 INFO - TEST-INFO | started process 28542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphsd54m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:42 INFO - PROCESS | 28542 | RSS: Main: 154075136 09:07:42 INFO - PROCESS | 28542 | 09:07:44 INFO - PROCESS | 28542 | Cycle 1(1): loaded http://localhost:46876/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46876/tests/kraken/driver.html?testName=audio-beat-detection) 09:07:45 INFO - PROCESS | 28542 | RSS: Main: 198131712 09:07:45 INFO - PROCESS | 28542 | 09:07:48 INFO - PROCESS | 28542 | Cycle 1(1): loaded http://localhost:46876/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46876/tests/kraken/driver.html?testName=audio-dft) 09:07:48 INFO - PROCESS | 28542 | RSS: Main: 186691584 09:07:48 INFO - PROCESS | 28542 | 09:07:51 INFO - PROCESS | 28542 | Cycle 1(1): loaded http://localhost:46876/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46876/tests/kraken/driver.html?testName=audio-fft) 09:07:52 INFO - PROCESS | 28542 | RSS: Main: 173568000 09:07:52 INFO - PROCESS | 28542 | 09:07:54 INFO - PROCESS | 28542 | Cycle 1(1): loaded http://localhost:46876/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46876/tests/kraken/driver.html?testName=audio-oscillator) 09:07:55 INFO - PROCESS | 28542 | RSS: Main: 175255552 09:07:55 INFO - PROCESS | 28542 | 09:07:57 INFO - PROCESS | 28542 | Cycle 1(1): loaded http://localhost:46876/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46876/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:07:57 INFO - PROCESS | 28542 | RSS: Main: 174874624 09:07:57 INFO - PROCESS | 28542 | 09:08:00 INFO - PROCESS | 28542 | Cycle 1(1): loaded http://localhost:46876/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46876/tests/kraken/driver.html?testName=imaging-darkroom) 09:08:01 INFO - PROCESS | 28542 | RSS: Main: 175656960 09:08:01 INFO - PROCESS | 28542 | 09:08:05 INFO - PROCESS | 28542 | Cycle 1(1): loaded http://localhost:46876/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46876/tests/kraken/driver.html?testName=imaging-desaturate) 09:08:05 INFO - PROCESS | 28542 | RSS: Main: 176812032 09:08:05 INFO - PROCESS | 28542 | 09:08:08 INFO - PROCESS | 28542 | Cycle 1(1): loaded http://localhost:46876/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46876/tests/kraken/driver.html?testName=json-parse-financial) 09:08:09 INFO - PROCESS | 28542 | RSS: Main: 176070656 09:08:09 INFO - PROCESS | 28542 | 09:08:10 INFO - PROCESS | 28542 | Cycle 1(1): loaded http://localhost:46876/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46876/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:08:11 INFO - PROCESS | 28542 | RSS: Main: 185995264 09:08:11 INFO - PROCESS | 28542 | 09:08:13 INFO - PROCESS | 28542 | Cycle 1(1): loaded http://localhost:46876/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46876/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:08:13 INFO - PROCESS | 28542 | RSS: Main: 184078336 09:08:13 INFO - PROCESS | 28542 | 09:08:15 INFO - PROCESS | 28542 | Cycle 1(1): loaded http://localhost:46876/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46876/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:08:16 INFO - PROCESS | 28542 | RSS: Main: 191488000 09:08:16 INFO - PROCESS | 28542 | 09:08:19 INFO - PROCESS | 28542 | Cycle 1(1): loaded http://localhost:46876/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:08:19 INFO - PROCESS | 28542 | RSS: Main: 198021120 09:08:19 INFO - PROCESS | 28542 | 09:08:22 INFO - PROCESS | 28542 | Cycle 1(1): loaded http://localhost:46876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:08:22 INFO - PROCESS | 28542 | RSS: Main: 197689344 09:08:22 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | Cycle 1(1): loaded http://localhost:46876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46876/tests/kraken/driver.html?testName=ai-astar) 09:08:24 INFO - PROCESS | 28542 | RSS: Main: 257335296 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | __start_tp_report 09:08:24 INFO - PROCESS | 28542 | _x_x_mozilla_page_load 09:08:24 INFO - PROCESS | 28542 | _x_x_mozilla_page_load_details 09:08:24 INFO - PROCESS | 28542 | |i|pagename|runs| 09:08:24 INFO - PROCESS | 28542 | |0;ai-astar;108;113;106;112;113;114;101;112;110;110 09:08:24 INFO - PROCESS | 28542 | |1;audio-beat-detection;159;129;151;174;130;150;149;137;184;136 09:08:24 INFO - PROCESS | 28542 | |2;audio-dft;161;161;160;161;161;161;161;161;160;160 09:08:24 INFO - PROCESS | 28542 | |3;audio-fft;74;73;73;156;73;74;73;77;154;73 09:08:24 INFO - PROCESS | 28542 | |4;audio-oscillator;92;93;145;93;93;93;138;93;93;142 09:08:24 INFO - PROCESS | 28542 | |5;imaging-gaussian-blur;116;116;117;117;118;117;116;116;116;116 09:08:24 INFO - PROCESS | 28542 | |6;imaging-darkroom;146;146;146;146;146;146;146;147;147;148 09:08:24 INFO - PROCESS | 28542 | |7;imaging-desaturate;95;95;95;96;96;96;96;95;96;95 09:08:24 INFO - PROCESS | 28542 | |8;json-parse-financial;65;64;65;65;64;64;65;73;62;63 09:08:24 INFO - PROCESS | 28542 | |9;json-stringify-tinderbox;64;65;64;64;65;64;64;65;65;65 09:08:24 INFO - PROCESS | 28542 | |10;stanford-crypto-aes;81;89;81;83;93;89;82;89;83;81 09:08:24 INFO - PROCESS | 28542 | |11;stanford-crypto-ccm;122;114;118;115;126;115;122;115;115;115 09:08:24 INFO - PROCESS | 28542 | |12;stanford-crypto-pbkdf2;134;155;141;139;141;132;140;138;140;143 09:08:24 INFO - PROCESS | 28542 | |13;stanford-crypto-sha256-iterative;66;69;66;66;65;66;66;72;68;67 09:08:24 INFO - PROCESS | 28542 | __end_tp_report 09:08:24 INFO - PROCESS | 28542 | __start_cc_report 09:08:24 INFO - PROCESS | 28542 | _x_x_mozilla_cycle_collect,1114 09:08:24 INFO - PROCESS | 28542 | __end_cc_report 09:08:24 INFO - PROCESS | 28542 | __startTimestamp1458317304798__endTimestamp 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | ------- Summary: start ------- 09:08:24 INFO - PROCESS | 28542 | Number of tests: 14 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | [#0] ai-astar Cycles:10 Average:109.90 Median:112.00 stddev:3.98 (3.6%) stddev-sans-first:4.17 09:08:24 INFO - PROCESS | 28542 | Values: 108.0 113.0 106.0 112.0 113.0 114.0 101.0 112.0 110.0 110.0 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:150.50 stddev:18.32 (12.2%) stddev-sans-first:19.13 09:08:24 INFO - PROCESS | 28542 | Values: 159.0 129.0 151.0 174.0 130.0 150.0 149.0 137.0 184.0 136.0 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:08:24 INFO - PROCESS | 28542 | Values: 161.0 161.0 160.0 161.0 161.0 161.0 161.0 161.0 160.0 160.0 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | [#3] audio-fft Cycles:10 Average:90.00 Median:73.00 stddev:34.28 (47.0%) stddev-sans-first:35.87 09:08:24 INFO - PROCESS | 28542 | Values: 74.0 73.0 73.0 156.0 73.0 74.0 73.0 77.0 154.0 73.0 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:93.00 stddev:23.64 (25.4%) stddev-sans-first:24.40 09:08:24 INFO - PROCESS | 28542 | Values: 92.0 93.0 145.0 93.0 93.0 93.0 138.0 93.0 93.0 142.0 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 09:08:24 INFO - PROCESS | 28542 | Values: 116.0 116.0 117.0 117.0 118.0 117.0 116.0 116.0 116.0 116.0 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 09:08:24 INFO - PROCESS | 28542 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 148.0 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:08:24 INFO - PROCESS | 28542 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:2.98 (4.6%) stddev-sans-first:3.16 09:08:24 INFO - PROCESS | 28542 | Values: 65.0 64.0 65.0 65.0 64.0 64.0 65.0 73.0 62.0 63.0 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 09:08:24 INFO - PROCESS | 28542 | Values: 64.0 65.0 64.0 64.0 65.0 64.0 64.0 65.0 65.0 65.0 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:86.00 stddev:4.43 (5.2%) stddev-sans-first:4.45 09:08:24 INFO - PROCESS | 28542 | Values: 81.0 89.0 81.0 83.0 93.0 89.0 82.0 89.0 83.0 81.0 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:116.50 stddev:4.16 (3.6%) stddev-sans-first:4.12 09:08:24 INFO - PROCESS | 28542 | Values: 122.0 114.0 118.0 115.0 126.0 115.0 122.0 115.0 115.0 115.0 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.30 Median:140.50 stddev:6.15 (4.4%) stddev-sans-first:6.08 09:08:24 INFO - PROCESS | 28542 | Values: 134.0 155.0 141.0 139.0 141.0 132.0 140.0 138.0 140.0 143.0 09:08:24 INFO - PROCESS | 28542 | 09:08:24 INFO - PROCESS | 28542 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:66.50 stddev:2.08 (3.1%) stddev-sans-first:2.17 09:08:24 INFO - PROCESS | 28542 | Values: 66.0 69.0 66.0 66.0 65.0 66.0 66.0 72.0 68.0 67.0 09:08:24 INFO - PROCESS | 28542 | -------- Summary: end -------- 09:08:24 INFO - PROCESS | 28542 | 09:08:25 INFO - TEST-INFO | 28542: exit 0 09:08:25 INFO - TEST-OK | kraken | took 61136ms 09:08:25 INFO - SUITE-END | took 1177s 09:08:25 INFO - Completed test suite (00:19:37) 09:08:25 INFO - javascript benchmark 09:08:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2626.6191402246673, 2689.3411114277005, 2703.297142742889, 2711.2408525612836, 2731.2762118038722, 4665.83669571565, 4689.390379250697, 4710.599599034082, 4714.599259062979, 4803.0, 4673.672842900998, 4719.90560188796, 4756.239001759719, 4773.90452190956, 4789.066132104241, 4332.718373305733, 4343.457067866517, 4343.478782546099, 4393.846215382462, 4398.582134697199, 4435.512093669694, 4437.378766972626, 4484.394606728099, 4519.977400113011, 4529.2526733089, 4294.527601963781, 4344.761038142901, 4369.12617476506, 4431.556844315575, 4473.881529617612, 4351.760653164075, 4375.540568240321, 4385.122975404932, 4403.097365040159, 4411.426514553087, 4337.349397590355, 4344.6524278058, 4347.695661303678, 4349.5215526292395, 4386.29819228925, 4527.909441811178, 4566.1552612766745, 4610.792514336829, 4620.283856002325, 4661.72029678217, 5023.14606516893, 5036.546710796009, 5046.6719663221775, 5047.848564543069, 5080.695158290514, 5072.34059572257, 5078.390593128811, 5078.5937125029905, 5080.390353157608, 5124.052050370693, 4647.024124933768, 4720.976395118071, 4739.73931433771, 4816.060868130751, 4819.445763737215, 5237.580993520509, 5249.658772179796, 5252.028374750607, 5252.842414727565, 5279.762410691528, 5031.371078615173, 5042.42012168598, 5045.318881950963, 5048.848534543969, 5096.6941983480365, 4960.404751429852, 5066.16408292635, 5099.311592934981, 5118.923216151761, 5156.20078887773, 5028.874278143076, 5049.823256186016, 5055.292259083658, 5061.367329083864, 5105.719185444762, 5045.217991211368, 5046.34397528319, 5049.772760225798, 5051.6716413433005, 5053.7220452875445, 4134.855280065183, 4158.812853421603, 4204.5375008749015, 4224.5353011168745, 4226.619604235633, 3713.3687273163628, 3722.088088418355, 3732.757370770891, 3744.4196149596855, 3768.1521657626813, 4375.949772054748, 4377.846775362911, 4380.167768124046, 4381.036172042146, 4424.0, 4959.776810043557, 5052.216906379517, 5091.210862316347, 5127.66670166438, 5132.332796736475, 4393.846215382447, 4411.8014689338415, 4413.337999300131, 4417.0724147929295, 4455.086707225011, 4478.149151661174, 4548.403517352207, 4574.542545745466, 4582.24392975162, 4611.769411529477, 4844.588210002189, 4892.143874821821, 4893.804247830047, 4918.336024636628, 4934.0, 5101.0818052750865, 5147.099257629825, 5147.6654017488745, 5154.046501397103, 5198.922016169836, 4706.247000479907, 4889.486603906681, 4907.312976183409, 4907.337509436323, 4957.752112394293, 4987.202047672355, 4995.400551933792, 5016.899662006813, 5062.519060689228, 5070.290159377616, 5091.1854103343285, 5104.05574968632, 5105.7191854448365, 5112.207607820794, 5151.562117219928, 4858.149823780754, 4934.827281045146, 4935.506449355035, 4953.356063711694, 4955.380577427822, 4906.705597664151, 4923.163062279349, 4931.605471562195, 4946.62900282473, 4972.055309491185, 4847.660663753503, 4852.078105160008, 4853.514648535118, 4854.19905715553, 4900.779464924016, 4894.975525122494, 4897.46127925935, 4910.9263361050325, 4956.157453232887, 4971.403431588233, 4842.15262329084, 4866.975665121652, 4869.0, 4879.804807807648, 4915.287283343967], "unit": "score", "name": "dojo.html", "value": 4667.025444809941}, {"lowerIsBetter": false, "replicates": [543.6928135603381, 554.4954091776483, 569.4931510955253, 576.5618130221031, 578.1587789765891, 26851.32871678209, 34299.31401371974, 34740.65259347406, 34880.82559587198, 34881.47677784835, 37266.0, 37774.055648608795, 37837.24325513495, 37842.62157378425, 37876.242475150546, 7659.923400765991, 7780.766577002699, 7784.026996625422, 7784.104827944774, 7813.140554538996, 7706.190849960757, 7816.609169541529, 7827.060752709683, 7831.334336581397, 7834.177411371809, 7815.726449574266, 7874.6456409461425, 7877.291043806056, 7881.7241396551135, 7884.842303153933, 7758.418118641096, 7819.452638315321, 7821.608919554, 7822.804429889298, 7825.060992680887, 7784.649690763929, 7827.6868925242925, 7827.96086019572, 7829.412794040412, 7896.763097107096, 38192.80903595464, 39021.80489097565, 39082.21835563301, 39184.60815391838, 39359.60640393588, 2903.375774208534, 2944.455275773989, 2995.2961054152256, 2999.8350090745002, 3021.894233701832, 28794.424111517652, 28989.710102898913, 29155.271118222, 29521.409571808657, 29667.70332296671, 3084.5373194021076, 3106.502959526465, 3165.6359518655418, 3169.065125787875, 3229.1765599771907, 241246.0, 241666.0, 241735.0, 241837.0, 241915.99999999825, 48150.518494815304, 54708.452915471134, 55028.72485637626, 55048.72475637596, 56090.158647620316, 50982.0, 51249.0, 51287.0, 51389.48610513847, 51395.0, 14584.854151458561, 15106.093634381972, 15126.924365378323, 15133.924330378277, 15153.54539363821, 9327.02066283044, 11351.318920864609, 11480.368579728029, 11853.585124520772, 12132.090093242865, 18264.726029109574, 18344.633107337777, 18349.3577724779, 18421.447356579323, 18469.81530184681, 7306.671199796022, 7470.36501897334, 7511.887321690179, 7518.210587888193, 7621.542707437571, 920.2637889688223, 942.3450701762347, 982.1210017034714, 1000.3197825478744, 1076.6393258258415, 26609.0, 27762.722372776418, 27840.443191136063, 28317.0, 28393.858030710126, 959.0697023886819, 1000.5142363590063, 1004.5931397783909, 1031.582209205273, 1122.0182340452104, 13930.86069139316, 14485.855141448661, 14503.1298122113, 14629.707405851823, 14701.632459188606, 303815.8092095386, 309216.0, 309284.0, 309738.0, 310019.0, 48877.51122488801, 49114.26328605074, 49148.50851491439, 49159.0, 49257.50742492601, 1078.3260462211117, 1251.466952982589, 1268.6130730127215, 1274.0317358807188, 1288.909776315649, 25545.23364299074, 27151.59272610873, 27468.313292167855, 28105.43789124165, 28106.156815295573, 35509.86940783561, 35954.28091438209, 36298.63701362952, 36401.635983639826, 36421.0, 177776.0, 182278.0, 194555.0, 194910.0, 195284.0, 26755.46489070169, 30698.539521907634, 30734.231644209074, 31650.525242121847, 31661.208469787518, 34725.0, 35311.64688353187, 35437.46843797397, 35694.464583030756, 36111.45832812563, 30928.845355773075, 34004.82997584996, 34156.82921585376, 34312.65687343095, 34398.312033759685, 33518.329633406705, 33853.0, 34184.316313674084, 34258.828705856315, 34278.14304642304, 33453.83273083619, 34127.658723412445, 34295.31409371849, 34333.313333733684, 34426.31147377088, 29424.26439339034, 30304.39391212119, 30500.84749576238, 30554.0, 30556.236094097825, 23876.52246955086, 23965.884435023334, 24299.514009719354, 24343.756562434148, 24429.26712198637], "unit": "score", "name": "ext.html", "value": 16859.73421013079}, {"lowerIsBetter": false, "replicates": [343.965603439656, 363.9745217834751, 368.34250862210956, 375.09227669040916, 379.0334646651039, 15537.0, 15979.280932358042, 17100.315987360507, 17395.391161309355, 17486.737698934525, 16160.83839161608, 16546.83453165468, 16822.57943551412, 16944.23750931208, 17001.23494442753, 4507.233770259048, 4919.966806970522, 5005.649604527675, 5012.273220383042, 5120.871978200556, 5032.320636714052, 5104.412992505853, 5113.872153196163, 5122.8207012754565, 5131.692098474085, 5044.772985215655, 5098.235264710304, 5098.821541246057, 5103.132467480537, 5312.681239125645, 5257.947420525803, 5263.157894736823, 5284.920726189111, 5305.946940530584, 5306.151015837467, 5046.167382381903, 5110.795568177268, 5116.744162791882, 5120.61595380348, 5187.19598462239, 12079.698007549794, 12312.322822244772, 12324.81512777309, 12419.379031048411, 12428.875711242952, 1859.191251805469, 1875.8217969292896, 1937.728717979484, 1945.9805401945941, 1986.2650819196845, 9167.862482062774, 9195.954020229923, 9294.0, 9387.76530586734, 9568.5694143763, 1767.3195819609543, 1791.1492041280417, 1809.2448239908592, 1827.7167039108826, 1853.8146185381488, 44132.0, 56225.43774562243, 58086.419135808945, 59785.70107149436, 64124.0, 10569.207309451822, 10573.894261057445, 10605.787884242427, 10735.248532602798, 10739.087177589836, 12163.574274900337, 12687.936560317139, 13241.27173005494, 13263.204207747565, 13825.10136841102, 6930.410915072275, 7055.7177712891935, 7148.356647901714, 7175.748848790267, 7289.963550182215, 6423.582467139621, 6443.935560644333, 6486.67566621667, 6812.931870681329, 6828.112345395166, 4366.541513141138, 4369.47566292047, 4394.494633117232, 4520.706154099973, 4520.728756274634, 1791.480470663519, 1793.6323053773945, 1808.1230603157458, 1836.8714190006572, 1842.7420161177447, 859.9957000214958, 866.181458521691, 881.7883707910055, 885.406777459104, 895.6417433026842, 14866.331015104346, 15619.136960600476, 15679.294431750599, 16096.195190240442, 16162.0, 833.5582141465034, 857.3698331726176, 857.7984173719171, 877.2499512916493, 900.7883147460342, 7806.18035106317, 8923.866142007875, 9214.539273036455, 9248.167664910055, 9383.765405864908, 421745.0, 441890.0, 444678.0, 453611.0, 453646.0, 69729.65135174291, 71126.0, 71232.2876771236, 71545.0, 71775.64112179406, 872.4852337121129, 888.0542222532981, 889.9777505562283, 890.7372325164092, 966.3960024984385, 14438.579678336931, 14485.348159332645, 14557.92721036388, 14636.85363146355, 15595.142267175414, 27298.863505682344, 27555.448891021668, 27774.44451110926, 35815.82092089523, 36240.09399765027, 38987.6101238984, 39097.41353879751, 39221.2155756889, 39347.0, 40613.1877362457, 7308.123025237006, 7342.118945726547, 7419.814504637211, 7448.851022979618, 7461.440391970733, 8795.208431241219, 9865.950670246602, 10747.785044299226, 11405.429728513707, 11661.06711463098, 9862.358946668444, 9898.10917017472, 9938.45338506389, 10105.24210684187, 10356.948215258875, 9166.770830729018, 9436.575354109218, 9602.951985240308, 9849.901500985185, 10010.44942528168, 9926.15627671656, 9931.0, 10297.53661085238, 10317.535710892878, 10708.250422470352, 7006.159260888522, 7007.859842803217, 7075.893861592183, 7124.501284910007, 7186.640667966685, 7577.659005344883, 9092.77268068277, 9490.335676502578, 9570.282228833004, 9830.852537211804], "unit": "score", "name": "jquery.html", "value": 7769.502433382451}, {"lowerIsBetter": false, "replicates": [1233.0751936047964, 1412.992935035325, 1419.1626940105339, 1587.412657316793, 1801.4235444657706, 6764.188297404312, 7405.370543503802, 7563.394928405728, 7589.430792690543, 7597.92402075979, 7506.474546781727, 7610.58141802202, 7632.809179770508, 7636.312731854132, 7641.159472458039, 1938.7285779990812, 2248.2693124734446, 2308.2728940383727, 2321.3500219938446, 2353.788159065684, 2307.9884600576975, 2309.515001849614, 2315.8147348212187, 2316.6756654068445, 2318.710161229846, 2257.559775843711, 2319.686842276288, 2323.2913961241816, 2324.2562380038394, 2324.476992676651, 2276.2147059264526, 2310.410845234463, 2321.8955147018423, 2330.079618550663, 2331.8484298520625, 2296.6784650148993, 2342.6251799712136, 2356.575816353056, 2356.7643235676464, 2357.787799098089, 7749.728759493447, 7820.5307681538725, 7827.882581761278, 7832.412569057344, 7835.764927052198, 4829.058333624945, 4926.630502712311, 4933.901321973541, 4947.851564453073, 4953.678010929278, 3035.666076731558, 3135.561021456998, 3171.096237572304, 3237.0612522368483, 3241.4489536778806, 963.2871674960548, 974.5517062151418, 987.9901200988041, 988.0810845913297, 1021.1269364693229, 10749.516271767789, 10912.072473839733, 10930.453477326022, 10939.890601093966, 10976.506057227443, 4495.775211239425, 4560.5211452796975, 4665.4168228971375, 4677.22825733757, 4692.061587682477, 9166.954165229132, 9256.490893000815, 9261.16649501548, 9272.443653380818, 9309.627614895327, 4261.105167914772, 4947.529984651453, 4950.529699678525, 4954.578860796801, 4956.3804524434445, 4311.8490852820005, 4334.371516130143, 4376.540463251376, 4377.671674624416, 4410.911781764346, 3713.090292878208, 3821.8662346818282, 3837.7505462144873, 3857.517810273716, 3866.4586957825363, 1267.2966503590596, 1287.5815360008035, 1289.052546378411, 1289.6066699656508, 1300.2523548959387, 1134.8354488599107, 1140.0366690146814, 1143.5197217168643, 1158.8783177766381, 1175.905927525796, 7332.743353982585, 7462.253774622603, 7467.1039475263315, 7475.439342049368, 7487.3261406473675, 1056.7041228456044, 1060.9045185933303, 1081.799867024603, 1084.4035780320792, 1098.9505472253768, 5428.104362780176, 5582.0, 5611.270534830446, 5650.830475085754, 5655.575831812631, 9271.07289271081, 9406.811863762687, 9484.525773711286, 9536.189423898908, 9558.378705384266, 9349.953250233706, 9351.859722104175, 9575.138237558653, 9640.325177237526, 9642.903570964341, 7396.3713084387355, 7561.584112873845, 7613.0483689538805, 7620.237976202336, 7630.694772209161, 7085.964570177116, 7107.040549525748, 7107.786766397016, 7168.713251469882, 7190.676419561237, 8563.95718021406, 8621.482711037357, 8687.739367818975, 8751.562421879007, 8775.297976162019, 8704.91295087041, 8811.60347784364, 9006.864897026418, 9017.729468115967, 9025.097490250922, 5675.177099320658, 6108.45023947829, 6353.4599559038, 6546.083548303337, 6676.83307917306, 7228.096487939008, 7256.818579535554, 7265.527740696838, 7297.963510182628, 7308.086489188851, 6420.165378500765, 6653.700583473658, 6687.832804179934, 6803.761868334783, 6836.042953986346, 6537.8692426152165, 6546.0508226307875, 6566.0, 6598.538102332791, 6622.933770662425, 6795.626240556619, 6836.28219036994, 6869.416099631388, 6885.173779146535, 6886.208086070166, 6365.490760739037, 6419.743210271537, 6420.454261387835, 6440.452561532322, 6442.162518872517, 6456.322086180883, 6467.385598368148, 6472.579282346633, 6495.382938620824, 6519.348065193442], "unit": "score", "name": "mootools.html", "value": 4506.7483654679545}, {"lowerIsBetter": false, "replicates": [325.9820709860957, 329.83013747919813, 330.8081312838554, 331.11592049228557, 338.56156277620494, 5369.973150134244, 5374.355077390714, 5376.542993845523, 5381.757820898054, 5393.217983392406, 5265.7893684252585, 5282.841514754554, 5298.841034768953, 5311.2298716686055, 5311.973440132803, 3945.881623551298, 4092.3452247640384, 4149.7302675326155, 4165.354370072636, 4188.455500784894, 4157.8544750933725, 4166.1251137261215, 4167.6457501112445, 4171.89444797129, 4182.477190351206, 4109.178164367124, 4130.318497447917, 4131.483564554431, 4133.256013917494, 4138.0, 3918.4318273850276, 4067.7966101694947, 4144.544100148981, 4146.91706165878, 4163.75017498948, 3687.8893633191046, 3691.870784522529, 3697.3529632314508, 3697.8335974881193, 3706.5366829146355, 5096.898062038738, 5111.872203194913, 5129.563987061104, 5132.640715149941, 5141.76862041209, 4825.179719447702, 4826.155422800995, 4828.324034635154, 4833.492483289274, 4833.830815921461, 5603.803866864681, 5606.831795046114, 5614.494695477427, 5617.831465056055, 5619.269494965669, 4073.4704488416614, 4075.449814275094, 4077.2864748668862, 4078.082431452929, 4085.8569950051606, 5636.971815140898, 5840.240768700084, 5854.97072514639, 5856.472917437409, 5861.706914654293, 3950.4469374287623, 3967.246223217637, 3970.0, 3980.0447892506168, 3994.580569040267, 4009.558948515661, 4026.9798651007145, 4027.8791636250958, 4037.515498140242, 4040.6565441937178, 4641.373414589055, 4644.581987621063, 4647.790849411785, 4653.069386122789, 4657.906841863144, 5546.500814926676, 5574.9442505574425, 5579.525740312119, 5585.134304182858, 5591.189277554813, 1477.416420513891, 1499.520153550875, 1500.1524138861507, 1503.646643038885, 1503.9548813535612, 966.7486453522135, 1024.2164743970868, 1037.4864442101057, 1041.146260066753, 1061.4215252687304, 4925.950740492549, 4938.802447902115, 4949.628777841676, 4953.6037117030555, 4956.157453232887, 5794.88410231793, 5808.535317174616, 5809.099589563624, 5810.680412577349, 5812.738426770806, 4929.605631549467, 4941.209406494943, 4945.9258111128365, 4948.38145231846, 4949.579285760678, 3080.4455198064115, 3111.0355789705263, 3114.408262430131, 3119.922001949924, 3120.531920211941, 5482.068048431776, 5483.917741233885, 5490.505854473036, 5492.231087647732, 5492.47821456961, 5816.796412125555, 6072.089186621954, 6082.908756368658, 6090.725917333731, 6098.664573448503, 5549.667019978814, 5550.69471179089, 5556.055470570093, 5559.694216818033, 5562.91655625174, 5876.236089308362, 5876.911846322394, 5879.764809407576, 5882.617629854046, 5890.941090589039, 5735.971320143372, 5736.42635736423, 5742.827715168552, 5798.971005144947, 5819.330776960704, 5378.112611419228, 5550.888982220252, 5557.472040156179, 5600.467955544217, 5615.7192140392, 3990.30169720292, 4029.0531725045175, 4047.615476529725, 4055.310597198424, 4073.124278280184, 5865.120231965068, 5865.853353666022, 5872.236609240771, 5873.647581145145, 5881.147233651182, 5663.943360566506, 5670.234518339971, 5673.914891276717, 5675.7445914933105, 5678.971605141948, 5657.547396208376, 5660.235868157911, 5661.688607126647, 5663.263775709132, 5682.289713785777, 5389.86525336854, 5567.025770490067, 5585.273914391266, 5587.469190426903, 5588.133839254922, 5614.6631202128, 5652.265205523256, 5675.120356344773, 5681.77272909079, 5732.082866741302, 5521.0062188804795, 5544.251526044094, 5581.302337207849, 5581.74882130297, 5591.077472217201], "unit": "score", "name": "prototype.html", "value": 4253.3849137536245}, {"lowerIsBetter": false, "replicates": [719.0966719492869, 753.6118898767136, 773.8297574533601, 778.3111945927852, 794.1264608930178, 14757.11457312562, 14911.850881491182, 15030.624234394145, 15067.321970511326, 15071.62320941977, 14215.076020058688, 14222.644433889158, 14234.857651423483, 14250.643733906658, 14295.78556321656, 651.3258777165635, 812.8049268175639, 827.9254867061964, 828.0477450931417, 829.6100832608695, 808.1635507249997, 827.8427098851229, 836.6067948064431, 837.1921096142222, 837.3970741066422, 860.0281681699671, 860.2644738748373, 860.6514361683528, 863.3007264116055, 867.7136544940155, 674.8549061951704, 840.7729912923477, 842.3724325377602, 843.8818565400818, 845.8731190321439, 633.360306090847, 633.3824521091944, 633.4045996763028, 633.9461145802612, 634.784173381048, 13293.53472628463, 13324.333783310893, 13377.598672039854, 13394.397252123677, 13399.866001339959, 11669.649910502698, 11688.707782305426, 12009.159358844885, 12077.57728479499, 12376.938115309365, 9912.89777262205, 10095.747606309827, 10207.0, 10284.074433300964, 10322.7419314517, 3241.254511462353, 3293.7859039162377, 3337.716294115003, 3372.6795954384293, 3385.407553678121, 45390.99999999967, 45513.77243113763, 45769.0, 45889.54110458886, 46045.76977115127, 9795.363301385387, 9894.455804930654, 9918.652847150315, 9986.600535978625, 10189.74525636865, 17236.396726114526, 17247.223874925658, 17263.309467621155, 17263.65472690539, 17270.13649317554, 6698.263191048981, 6871.175458944858, 6879.415249703731, 7015.088038554955, 7092.326229008236, 3735.1782607826235, 3746.1758413149064, 3806.2197249563774, 3840.558335791364, 3901.941470877939, 2876.956845647317, 2910.6070680458292, 2912.810667306618, 2918.212082737649, 2928.326484908483, 526.6603041038509, 527.8653943244448, 536.051189394769, 545.6944111297686, 548.2461615278992, 551.7985935133647, 554.6838302167806, 560.1262031231292, 574.3882764855416, 587.4888846703395, 7427.962860185773, 7643.7324693635455, 7767.883481747665, 7853.253940875607, 7867.763967080997, 436.11686335170896, 463.6870112673999, 518.4530320511897, 551.2998491915246, 555.9249501317352, 3505.9298814024087, 3526.594441639193, 3537.3986422307753, 3542.8937131886087, 3673.7061035117663, 55459.72270138704, 56213.43786562082, 56218.71890640521, 56312.43687563154, 56349.0, 46600.30099548509, 46732.53267467282, 48050.519494804605, 48082.519174808505, 48167.0, 40744.0, 40757.38863917044, 41380.1723965525, 41460.37809432861, 41524.37713434301, 7954.284114429729, 8116.594170291343, 8152.0, 8233.135520770233, 8260.0, 31906.52140217852, 31985.0, 32504.187395315308, 32854.34291314208, 33238.16904577405, 37251.0, 39062.0, 39884.40173397459, 43826.78086609547, 43832.0, 9377.1091746284, 9380.81238375215, 9394.389364691546, 10005.699829005142, 10038.16317876836, 11018.39398833072, 11126.221164518405, 11163.497642606264, 11337.26307789991, 11339.092872570009, 8941.239994600532, 9716.3198576099, 9952.800943980936, 10408.635697750542, 10667.786644267226, 8786.0, 8849.955750221208, 10218.0, 10307.484625768831, 10411.115055220089, 9844.751232093535, 10174.084332410119, 10174.898251017396, 10514.78970420572, 10685.465726713477, 9358.4384936904, 9457.668981585612, 9627.663031793854, 9668.274879384215, 9887.604495820087, 8947.0, 8964.282857371525, 9009.23421509179, 9093.272538196796, 9129.360944733804], "unit": "score", "name": "yui.html", "value": 5939.722757187953}], "name": "dromaeo_css", "value": 6413.7896709100205}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 113.0, 106.0, 112.0, 113.0, 114.0, 101.0, 112.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [159.0, 129.0, 151.0, 174.0, 130.0, 150.0, 149.0, 137.0, 184.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 149.9}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 156.0, 73.0, 74.0, 73.0, 77.0, 154.0, 73.0], "unit": "score", "name": "audio-fft", "value": 90.0}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 145.0, 93.0, 93.0, 93.0, 138.0, 93.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 117.0, 117.0, 118.0, 117.0, 116.0, 116.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 73.0, 62.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 65.0}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [81.0, 89.0, 81.0, 83.0, 93.0, 89.0, 82.0, 89.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [122.0, 114.0, 118.0, 115.0, 126.0, 115.0, 122.0, 115.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.7}, {"lowerIsBetter": true, "replicates": [134.0, 155.0, 141.0, 139.0, 141.0, 132.0, 140.0, 138.0, 140.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.3}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 66.0, 66.0, 65.0, 66.0, 66.0, 72.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1516.1}]} 09:08:26 INFO - Return code: 0 09:08:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:08:26 ERROR - # TBPL SUCCESS # 09:08:26 INFO - Running post-action listener: _resource_record_post_action 09:08:26 INFO - Running post-run listener: _resource_record_post_run 09:08:27 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521785344; Read time: 4; Write time: 509520 09:08:27 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232599552; Read time: 0; Write time: 282632 09:08:27 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289185792; Read time: 4; Write time: 226888 09:08:27 INFO - Running post-run listener: _upload_blobber_files 09:08:27 INFO - Blob upload gear active. 09:08:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:08:27 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 09:08:27 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'] 09:08:27 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 09:08:27 INFO - (blobuploader) - INFO - Open directory for files ... 09:08:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:08:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:08:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:28 INFO - (blobuploader) - INFO - Done attempting. 09:08:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:08:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:08:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:29 INFO - (blobuploader) - INFO - Done attempting. 09:08:29 INFO - (blobuploader) - INFO - Iteration through files over. 09:08:29 INFO - Return code: 0 09:08:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:08:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:08:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0568f598b88f7527a51939a8305d00b528a699d780985f1353a507982cc28e609bf00246d057cfe406bd008a4ebd40990b1d49967c063e75cc94ac651c5e2d56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a65b231bc19b01d4ff14b5d3fec374da4a6de40d2f3b726cafaad5691517fca968e64b9f6d8e93782119586ba6c5290859ee48da5964af02adbb1e946a21083"} 09:08:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:08:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:08:29 INFO - Contents: 09:08:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0568f598b88f7527a51939a8305d00b528a699d780985f1353a507982cc28e609bf00246d057cfe406bd008a4ebd40990b1d49967c063e75cc94ac651c5e2d56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a65b231bc19b01d4ff14b5d3fec374da4a6de40d2f3b726cafaad5691517fca968e64b9f6d8e93782119586ba6c5290859ee48da5964af02adbb1e946a21083"} 09:08:29 INFO - Running post-run listener: copy_logs_to_upload_dir 09:08:29 INFO - Copying logs to upload dir... 09:08:29 INFO - mkdir: /builds/slave/test/build/upload/logs 09:08:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.311922 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-03-18 09:08:29.040063) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:29.047402) ========= 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=1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0568f598b88f7527a51939a8305d00b528a699d780985f1353a507982cc28e609bf00246d057cfe406bd008a4ebd40990b1d49967c063e75cc94ac651c5e2d56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a65b231bc19b01d4ff14b5d3fec374da4a6de40d2f3b726cafaad5691517fca968e64b9f6d8e93782119586ba6c5290859ee48da5964af02adbb1e946a21083"} build_url:https://queue.taskcluster.net/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/FzfVE5z5QvWTBhJ7dan7Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0568f598b88f7527a51939a8305d00b528a699d780985f1353a507982cc28e609bf00246d057cfe406bd008a4ebd40990b1d49967c063e75cc94ac651c5e2d56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a65b231bc19b01d4ff14b5d3fec374da4a6de40d2f3b726cafaad5691517fca968e64b9f6d8e93782119586ba6c5290859ee48da5964af02adbb1e946a21083"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:29.071979) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:29.072320) ========= 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=1b9da9da7504fe468691862d000001b9-1458311955.222697-495565313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:08:29.154832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 09:08:29.155165) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 09:08:29.155494) ========= ========= Total master_lag: 0.27 =========