builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1457695804.31 results: success (0) buildid: 20160311024912 builduid: c2c0d08c11c0419b8109ef455df5dc71 revision: b015db3afa462d65b3bd58ab6cc080401f85bafa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:04.308858) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:04.309439) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:04.309771) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005907 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:04.333048) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:04.333411) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:04.369127) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:04.369434) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:04.419873) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:04.420237) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:04.420736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:04.421077) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 03:30:04-- 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% 83.0M=0s 2016-03-11 03:30:04 (83.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093689 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:04.527979) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:04.529697) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022203 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:04.582240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:04.582655) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b015db3afa462d65b3bd58ab6cc080401f85bafa --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 b015db3afa462d65b3bd58ab6cc080401f85bafa --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=78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 03:30:04,935 truncating revision to first 12 chars 2016-03-11 03:30:04,936 Setting DEBUG logging. 2016-03-11 03:30:04,936 attempt 1/10 2016-03-11 03:30:04,936 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b015db3afa46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 03:30:05,211 unpacking tar archive at: fx-team-b015db3afa46/testing/mozharness/ program finished with exit code 0 elapsedTime=0.556927 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:05.156990) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:05.157430) ========= echo b015db3afa462d65b3bd58ab6cc080401f85bafa in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b015db3afa462d65b3bd58ab6cc080401f85bafa'] 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=78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b015db3afa462d65b3bd58ab6cc080401f85bafa program finished with exit code 0 elapsedTime=0.004687 script_repo_revision: 'b015db3afa462d65b3bd58ab6cc080401f85bafa' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:05.212351) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:05.212729) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:05.237812) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-11 03:30:05.238148) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:05 INFO - MultiFileLogger online at 20160311 03:30:05 in /builds/slave/test 03:30:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:30:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:05 INFO - {'append_to_log': False, 03:30:05 INFO - 'base_work_dir': '/builds/slave/test', 03:30:05 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:30:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:05 INFO - 'branch': 'Fx-Team-Non-PGO', 03:30:05 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:05 INFO - 'config_files': ('talos/linux_config.py',), 03:30:05 INFO - 'default_actions': ('clobber', 03:30:05 INFO - 'read-buildbot-config', 03:30:05 INFO - 'download-and-extract', 03:30:05 INFO - 'populate-webroot', 03:30:05 INFO - 'create-virtualenv', 03:30:05 INFO - 'install', 03:30:05 INFO - 'run-tests'), 03:30:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:05 INFO - 'download_minidump_stackwalk': True, 03:30:05 INFO - 'download_symbols': 'ondemand', 03:30:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:30:05 INFO - 'tooltool.py': '/tools/tooltool.py', 03:30:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:30:05 INFO - '/tools/misc-python/virtualenv.py')}, 03:30:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:05 INFO - 'installer_path': 'installer.exe', 03:30:05 INFO - 'log_level': 'info', 03:30:05 INFO - 'log_name': 'talos', 03:30:05 INFO - 'log_to_console': True, 03:30:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:05 INFO - 'opt_config_files': (), 03:30:05 INFO - 'pip_index': False, 03:30:05 INFO - 'sps_profile': False, 03:30:05 INFO - 'sps_profile_interval': 0, 03:30:05 INFO - 'suite': 'dromaeojs-e10s', 03:30:05 INFO - 'system_bits': '32', 03:30:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:05 INFO - 'title': 'talos-linux64-ix-019', 03:30:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:05 INFO - 'use_talos_json': True, 03:30:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:05 INFO - 'work_dir': 'build'} 03:30:05 INFO - ##### 03:30:05 INFO - ##### Running clobber step. 03:30:05 INFO - ##### 03:30:05 INFO - Running pre-action listener: _resource_record_pre_action 03:30:05 INFO - Running main action method: clobber 03:30:05 INFO - rmtree: /builds/slave/test/build 03:30:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:06 INFO - Running post-action listener: _resource_record_post_action 03:30:06 INFO - ##### 03:30:06 INFO - ##### Running read-buildbot-config step. 03:30:06 INFO - ##### 03:30:06 INFO - Running pre-action listener: _resource_record_pre_action 03:30:06 INFO - Running main action method: read_buildbot_config 03:30:06 INFO - Using buildbot properties: 03:30:06 INFO - { 03:30:06 INFO - "project": "", 03:30:06 INFO - "product": "firefox", 03:30:06 INFO - "script_repo_revision": "production", 03:30:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:30:06 INFO - "repository": "", 03:30:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:30:06 INFO - "buildid": "20160311024912", 03:30:06 INFO - "pgo_build": "False", 03:30:06 INFO - "basedir": "/builds/slave/test", 03:30:06 INFO - "buildnumber": 1008, 03:30:06 INFO - "slavename": "talos-linux64-ix-019", 03:30:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:30:06 INFO - "platform": "ubuntu64_hw", 03:30:06 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:30:06 INFO - "branch": "fx-team", 03:30:06 INFO - "repo_path": "integration/fx-team", 03:30:06 INFO - "revision": "b015db3afa462d65b3bd58ab6cc080401f85bafa", 03:30:06 INFO - "stage_platform": "linux64", 03:30:06 INFO - "builduid": "c2c0d08c11c0419b8109ef455df5dc71", 03:30:06 INFO - "slavebuilddir": "test" 03:30:06 INFO - } 03:30:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 03:30:06 INFO - Running post-action listener: _resource_record_post_action 03:30:06 INFO - ##### 03:30:06 INFO - ##### Running download-and-extract step. 03:30:06 INFO - ##### 03:30:06 INFO - Running pre-action listener: _resource_record_pre_action 03:30:06 INFO - Running main action method: download_and_extract 03:30:06 INFO - mkdir: /builds/slave/test/build/tests 03:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:06 INFO - https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:30:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:30:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:30:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:06 INFO - Downloaded 1361 bytes. 03:30:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:30:06 INFO - Using the following test package requirements: 03:30:06 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:30:06 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:30:06 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:30:06 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:06 INFO - u'jsshell-linux-x86_64.zip'], 03:30:06 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:30:06 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:30:06 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:30:06 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:30:06 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:30:06 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:30:06 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:06 INFO - https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:30:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:30:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:08 INFO - Downloaded 22093190 bytes. 03:30:08 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'] 03:30:08 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 03:30:09 INFO - Return code: 0 03:30:09 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 03:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:09 INFO - https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:30:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:30:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:11 INFO - Downloaded 22093190 bytes. 03:30:11 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'] 03:30:11 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 03:30:12 INFO - Return code: 0 03:30:12 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')]} 03:30:12 INFO - https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:30:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:30:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:30:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:13 INFO - Downloaded 10845161 bytes. 03:30:13 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'] 03:30:13 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 03:30:13 INFO - Return code: 0 03:30: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')]} 03:30:13 INFO - https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:30:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:30:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:30:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:14 INFO - Downloaded 54456406 bytes. 03:30:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:30:14 INFO - mkdir: /builds/slave/test/properties 03:30:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:30:14 INFO - Writing to file /builds/slave/test/properties/build_url 03:30:14 INFO - Contents: 03:30:14 INFO - build_url:https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:30:15 INFO - Running post-action listener: _resource_record_post_action 03:30:15 INFO - Running post-action listener: set_extra_try_arguments 03:30:15 INFO - ##### 03:30:15 INFO - ##### Running populate-webroot step. 03:30:15 INFO - ##### 03:30:15 INFO - Running pre-action listener: _resource_record_pre_action 03:30:15 INFO - Running main action method: populate_webroot 03:30:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:30:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:30:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:30:15 INFO - '--tppagecycles', 03:30:15 INFO - '7'], 03:30:15 INFO - 'tests': ['tsvgm']}}, 03:30:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:30:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:30:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:30:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:30:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:30:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:30:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:15 INFO - 'talos_options': ['--e10s'], 03:30:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:15 INFO - 'tests': ['damp', 'tps']}, 03:30:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:15 INFO - 'talos_options': ['--e10s'], 03:30:15 INFO - 'tests': ['damp', 'tps']}, 03:30:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:30:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:30:15 INFO - 'other': {'tests': ['a11yr', 03:30:15 INFO - 'ts_paint', 03:30:15 INFO - 'tpaint', 03:30:15 INFO - 'sessionrestore', 03:30:15 INFO - 'sessionrestore_no_auto_restore', 03:30:15 INFO - 'tabpaint']}, 03:30:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:30:15 INFO - 'tests': ['a11yr', 03:30:15 INFO - 'ts_paint', 03:30:15 INFO - 'tpaint', 03:30:15 INFO - 'sessionrestore', 03:30:15 INFO - 'sessionrestore_no_auto_restore', 03:30:15 INFO - 'tabpaint']}, 03:30:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:30:15 INFO - 'tests': ['a11yr', 03:30:15 INFO - 'ts_paint', 03:30:15 INFO - 'tpaint', 03:30:15 INFO - 'sessionrestore', 03:30:15 INFO - 'sessionrestore_no_auto_restore', 03:30:15 INFO - 'tabpaint']}, 03:30:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:30:15 INFO - 'tests': ['a11yr', 03:30:15 INFO - 'ts_paint', 03:30:15 INFO - 'tpaint', 03:30:15 INFO - 'sessionrestore', 03:30:15 INFO - 'sessionrestore_no_auto_restore', 03:30:15 INFO - 'tabpaint']}, 03:30:15 INFO - 'other_l64': {'tests': ['a11yr', 03:30:15 INFO - 'ts_paint', 03:30:15 INFO - 'tpaint', 03:30:15 INFO - 'sessionrestore', 03:30:15 INFO - 'sessionrestore_no_auto_restore', 03:30:15 INFO - 'tabpaint']}, 03:30:15 INFO - 'other_nol64': {'tests': ['a11yr', 03:30:15 INFO - 'ts_paint', 03:30:15 INFO - 'tpaint', 03:30:15 INFO - 'sessionrestore', 03:30:15 INFO - 'sessionrestore_no_auto_restore', 03:30:15 INFO - 'tabpaint']}, 03:30:15 INFO - 'svgr': {'tests': ['tsvgx', 03:30:15 INFO - 'tsvgr_opacity', 03:30:15 INFO - 'tart', 03:30:15 INFO - 'tscrollx', 03:30:15 INFO - 'cart']}, 03:30:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:30:15 INFO - 'tests': ['tsvgx', 03:30:15 INFO - 'tsvgr_opacity', 03:30:15 INFO - 'tart', 03:30:15 INFO - 'tscrollx', 03:30:15 INFO - 'cart']}, 03:30:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:15 INFO - 'tests': ['tp5o']}, 03:30:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:15 INFO - 'talos_options': ['--e10s'], 03:30:15 INFO - 'tests': ['tp5o']}, 03:30:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:15 INFO - 'talos_options': ['--xperf_path', 03:30:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:15 INFO - 'tests': ['tp5n']}, 03:30:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:15 INFO - 'talos_options': ['--e10s', 03:30:15 INFO - '--xperf_path', 03:30:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:15 INFO - 'tests': ['tp5n']}}, 03:30:15 INFO - 'talos.zip': {'path': '', 03:30:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:30:15 INFO - Running post-action listener: _resource_record_post_action 03:30:15 INFO - ##### 03:30:15 INFO - ##### Running create-virtualenv step. 03:30:15 INFO - ##### 03:30:15 INFO - Running pre-action listener: _resource_record_pre_action 03:30:15 INFO - Running main action method: create_virtualenv 03:30:15 INFO - Creating virtualenv /builds/slave/test/build/venv 03:30:15 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 03:30:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:30:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:30:15 INFO - Using real prefix '/usr' 03:30:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:30:16 INFO - Installing distribute.............................................................................................................................................................................................done. 03:30:18 INFO - Installing pip.................done. 03:30:18 INFO - Return code: 0 03:30:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:18 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 0x7f171ec25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920160>, '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 0x2921060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29214f0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', '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 03:30:18 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 03:30:18 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 03:30:18 INFO - Using env: {'DISPLAY': ':0', 03:30:18 INFO - 'HOME': '/home/cltbld', 03:30:18 INFO - 'LANG': 'en_US.UTF-8', 03:30:18 INFO - 'LANGUAGE': 'en_US:en', 03:30:18 INFO - 'LOGNAME': 'cltbld', 03:30:18 INFO - 'MAIL': '/var/mail/cltbld', 03:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:18 INFO - 'MOZ_NO_REMOTE': '1', 03:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:18 INFO - 'NO_EM_RESTART': '1', 03:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:18 INFO - 'PWD': '/builds/slave/test', 03:30:18 INFO - 'SHELL': '/bin/bash', 03:30:18 INFO - 'SHLVL': '1', 03:30:18 INFO - 'TERM': 'linux', 03:30:18 INFO - 'TMOUT': '86400', 03:30:18 INFO - 'USER': 'cltbld', 03:30:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', 03:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:18 INFO - '_': '/tools/buildbot/bin/python'} 03:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:18 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 03:30:18 INFO - Cleaning up... 03:30:18 INFO - Return code: 0 03:30:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:18 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 0x7f171ec25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920160>, '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 0x2921060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29214f0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', '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 03:30:18 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 03:30:18 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 03:30:18 INFO - Using env: {'DISPLAY': ':0', 03:30:18 INFO - 'HOME': '/home/cltbld', 03:30:18 INFO - 'LANG': 'en_US.UTF-8', 03:30:18 INFO - 'LANGUAGE': 'en_US:en', 03:30:18 INFO - 'LOGNAME': 'cltbld', 03:30:18 INFO - 'MAIL': '/var/mail/cltbld', 03:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:18 INFO - 'MOZ_NO_REMOTE': '1', 03:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:18 INFO - 'NO_EM_RESTART': '1', 03:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:18 INFO - 'PWD': '/builds/slave/test', 03:30:18 INFO - 'SHELL': '/bin/bash', 03:30:18 INFO - 'SHLVL': '1', 03:30:18 INFO - 'TERM': 'linux', 03:30:18 INFO - 'TMOUT': '86400', 03:30:18 INFO - 'USER': 'cltbld', 03:30:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', 03:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:18 INFO - '_': '/tools/buildbot/bin/python'} 03:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:18 INFO - Downloading/unpacking psutil>=0.7.1 03:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:20 INFO - Installing collected packages: psutil 03:30:20 INFO - Running setup.py install for psutil 03:30:20 INFO - building 'psutil._psutil_linux' extension 03:30:20 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 03:30:21 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 03:30:21 INFO - building 'psutil._psutil_posix' extension 03:30:21 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 03:30:21 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 03:30:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:21 INFO - Successfully installed psutil 03:30:21 INFO - Cleaning up... 03:30:21 INFO - Return code: 0 03:30:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:30:21 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')]} 03:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:21 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')]} 03:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:21 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 0x7f171ec25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920160>, '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 0x2921060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29214f0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', '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 03:30:21 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 03:30:21 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 03:30:21 INFO - Using env: {'DISPLAY': ':0', 03:30:21 INFO - 'HOME': '/home/cltbld', 03:30:21 INFO - 'LANG': 'en_US.UTF-8', 03:30:21 INFO - 'LANGUAGE': 'en_US:en', 03:30:21 INFO - 'LOGNAME': 'cltbld', 03:30:21 INFO - 'MAIL': '/var/mail/cltbld', 03:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:21 INFO - 'MOZ_NO_REMOTE': '1', 03:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:21 INFO - 'NO_EM_RESTART': '1', 03:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:21 INFO - 'PWD': '/builds/slave/test', 03:30:21 INFO - 'SHELL': '/bin/bash', 03:30:21 INFO - 'SHLVL': '1', 03:30:21 INFO - 'TERM': 'linux', 03:30:21 INFO - 'TMOUT': '86400', 03:30:21 INFO - 'USER': 'cltbld', 03:30:21 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', 03:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:21 INFO - '_': '/tools/buildbot/bin/python'} 03:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:30:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:30:23 INFO - Installing collected packages: mozsystemmonitor 03:30:23 INFO - Running setup.py install for mozsystemmonitor 03:30:23 INFO - Successfully installed mozsystemmonitor 03:30:23 INFO - Cleaning up... 03:30:23 INFO - Return code: 0 03:30:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30:23 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')]} 03:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:23 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')]} 03:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:23 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 0x7f171ec25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920160>, '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 0x2921060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29214f0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', '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 03:30:23 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 03:30:23 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 03:30:23 INFO - Using env: {'DISPLAY': ':0', 03:30:23 INFO - 'HOME': '/home/cltbld', 03:30:23 INFO - 'LANG': 'en_US.UTF-8', 03:30:23 INFO - 'LANGUAGE': 'en_US:en', 03:30:23 INFO - 'LOGNAME': 'cltbld', 03:30:23 INFO - 'MAIL': '/var/mail/cltbld', 03:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:23 INFO - 'MOZ_NO_REMOTE': '1', 03:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:23 INFO - 'NO_EM_RESTART': '1', 03:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:23 INFO - 'PWD': '/builds/slave/test', 03:30:23 INFO - 'SHELL': '/bin/bash', 03:30:23 INFO - 'SHLVL': '1', 03:30:23 INFO - 'TERM': 'linux', 03:30:23 INFO - 'TMOUT': '86400', 03:30:23 INFO - 'USER': 'cltbld', 03:30:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', 03:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:23 INFO - '_': '/tools/buildbot/bin/python'} 03:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:23 INFO - Downloading/unpacking blobuploader==1.2.4 03:30:23 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 03:30:23 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 03:30:23 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 03:30:23 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 03:30:23 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 03:30:23 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 03:30:25 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30:25 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 03:30:25 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 03:30:25 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 03:30:25 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 03:30:25 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 03:30:25 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 03:30:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:26 INFO - Downloading docopt-0.6.1.tar.gz 03:30:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:26 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:26 INFO - Running setup.py install for blobuploader 03:30:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:26 INFO - Running setup.py install for requests 03:30:26 INFO - Running setup.py install for docopt 03:30:26 INFO - Successfully installed blobuploader requests docopt 03:30:26 INFO - Cleaning up... 03:30:26 INFO - Return code: 0 03:30:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:26 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 0x7f171ec25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920160>, '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 0x2921060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29214f0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', '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 03:30:26 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 03:30:26 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 03:30:26 INFO - Using env: {'DISPLAY': ':0', 03:30:26 INFO - 'HOME': '/home/cltbld', 03:30:26 INFO - 'LANG': 'en_US.UTF-8', 03:30:26 INFO - 'LANGUAGE': 'en_US:en', 03:30:26 INFO - 'LOGNAME': 'cltbld', 03:30:27 INFO - 'MAIL': '/var/mail/cltbld', 03:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:27 INFO - 'MOZ_NO_REMOTE': '1', 03:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:27 INFO - 'NO_EM_RESTART': '1', 03:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:27 INFO - 'PWD': '/builds/slave/test', 03:30:27 INFO - 'SHELL': '/bin/bash', 03:30:27 INFO - 'SHLVL': '1', 03:30:27 INFO - 'TERM': 'linux', 03:30:27 INFO - 'TMOUT': '86400', 03:30:27 INFO - 'USER': 'cltbld', 03:30:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', 03:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:27 INFO - '_': '/tools/buildbot/bin/python'} 03:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:27 INFO - Running setup.py (path:/tmp/pip-6iEFsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:27 INFO - Running setup.py (path:/tmp/pip-RUkPf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:27 INFO - Running setup.py (path:/tmp/pip-YnJbhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:27 INFO - Running setup.py (path:/tmp/pip-A1dgSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:27 INFO - Running setup.py (path:/tmp/pip-DE2r6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:27 INFO - Running setup.py (path:/tmp/pip-ZZCcVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:27 INFO - Running setup.py (path:/tmp/pip-1kj5aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:27 INFO - Running setup.py (path:/tmp/pip-ZXPAmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:27 INFO - Running setup.py (path:/tmp/pip-NK3_7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:27 INFO - Running setup.py (path:/tmp/pip-6rtgs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:27 INFO - Running setup.py (path:/tmp/pip-1NOqWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:28 INFO - Running setup.py (path:/tmp/pip-JCVFm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:28 INFO - Running setup.py (path:/tmp/pip-EVVaNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:28 INFO - Running setup.py (path:/tmp/pip-T8wueI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:28 INFO - Running setup.py (path:/tmp/pip-_8P3tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:28 INFO - Running setup.py (path:/tmp/pip-duyd9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:28 INFO - Running setup.py (path:/tmp/pip-yfVXql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:28 INFO - Running setup.py install for manifestparser 03:30:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:30:28 INFO - Running setup.py install for mozcrash 03:30:28 INFO - Running setup.py install for mozdebug 03:30:28 INFO - Running setup.py install for mozdevice 03:30:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:30:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:30:28 INFO - Running setup.py install for mozfile 03:30:28 INFO - Running setup.py install for mozhttpd 03:30:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:30:29 INFO - Running setup.py install for mozinfo 03:30:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:30:29 INFO - Running setup.py install for mozInstall 03:30:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:30:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:30:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:30:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:30:29 INFO - Running setup.py install for mozleak 03:30:29 INFO - Running setup.py install for mozlog 03:30:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:30:29 INFO - Running setup.py install for moznetwork 03:30:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:30:29 INFO - Running setup.py install for mozprocess 03:30:29 INFO - Running setup.py install for mozprofile 03:30:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:30:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:30:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:30:29 INFO - Running setup.py install for mozrunner 03:30:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:30:29 INFO - Running setup.py install for mozscreenshot 03:30:30 INFO - Running setup.py install for moztest 03:30:30 INFO - Running setup.py install for mozversion 03:30:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:30:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:30 INFO - Cleaning up... 03:30:30 INFO - Return code: 0 03:30:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:30 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')]} 03:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:30 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')]} 03:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:30 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 0x7f171ec25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920160>, '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 0x2921060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29214f0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', '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 03:30:30 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 03:30:30 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 03:30:30 INFO - Using env: {'DISPLAY': ':0', 03:30:30 INFO - 'HOME': '/home/cltbld', 03:30:30 INFO - 'LANG': 'en_US.UTF-8', 03:30:30 INFO - 'LANGUAGE': 'en_US:en', 03:30:30 INFO - 'LOGNAME': 'cltbld', 03:30:30 INFO - 'MAIL': '/var/mail/cltbld', 03:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:30 INFO - 'MOZ_NO_REMOTE': '1', 03:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:30 INFO - 'NO_EM_RESTART': '1', 03:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:30 INFO - 'PWD': '/builds/slave/test', 03:30:30 INFO - 'SHELL': '/bin/bash', 03:30:30 INFO - 'SHLVL': '1', 03:30:30 INFO - 'TERM': 'linux', 03:30:30 INFO - 'TMOUT': '86400', 03:30:30 INFO - 'USER': 'cltbld', 03:30:30 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', 03:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:30 INFO - '_': '/tools/buildbot/bin/python'} 03:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:30 INFO - Running setup.py (path:/tmp/pip-DxOXvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:30 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)) 03:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:30 INFO - Running setup.py (path:/tmp/pip-8yuddg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:30 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)) 03:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:30 INFO - Running setup.py (path:/tmp/pip-uRGJcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:30 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)) 03:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:30 INFO - Running setup.py (path:/tmp/pip-ZXke91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:30 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)) 03:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:30 INFO - Running setup.py (path:/tmp/pip-LNvNGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:30 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)) 03:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:30 INFO - Running setup.py (path:/tmp/pip-orWCBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:30 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)) 03:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:30 INFO - Running setup.py (path:/tmp/pip-envWyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:30 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)) 03:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:30 INFO - Running setup.py (path:/tmp/pip-Le3ICL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:31 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)) 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:31 INFO - Running setup.py (path:/tmp/pip-fHJlL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:31 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)) 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:31 INFO - Running setup.py (path:/tmp/pip-fN9Wjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:31 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)) 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:31 INFO - Running setup.py (path:/tmp/pip-cB8Up7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:31 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)) 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:31 INFO - Running setup.py (path:/tmp/pip-tNxsUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:31 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)) 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:31 INFO - Running setup.py (path:/tmp/pip-T2un2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:31 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)) 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:31 INFO - Running setup.py (path:/tmp/pip-XJbu3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:31 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)) 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:31 INFO - Running setup.py (path:/tmp/pip-jIxXCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:31 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)) 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:31 INFO - Running setup.py (path:/tmp/pip-8Qe3OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:31 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)) 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:31 INFO - Running setup.py (path:/tmp/pip-gHUkaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:31 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)) 03:30:31 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)) 03:30:31 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)) 03:30:31 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)) 03:30:31 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)) 03:30:31 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)) 03:30:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30:31 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 03:30:31 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 03:30:31 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 03:30:31 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 03:30:31 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 03:30:31 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 03:30:33 INFO - Downloading blessings-1.6.tar.gz 03:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:33 INFO - Installing collected packages: blessings 03:30:33 INFO - Running setup.py install for blessings 03:30:33 INFO - Successfully installed blessings 03:30:33 INFO - Cleaning up... 03:30:33 INFO - Return code: 0 03:30:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:30:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:33 INFO - Reading from file tmpfile_stdout 03:30:33 INFO - Current package versions: 03:30:33 INFO - argparse == 1.2.1 03:30:33 INFO - blessings == 1.6 03:30:33 INFO - blobuploader == 1.2.4 03:30:33 INFO - docopt == 0.6.1 03:30:33 INFO - manifestparser == 1.1 03:30:33 INFO - mozInstall == 1.12 03:30:33 INFO - mozcrash == 0.17 03:30:33 INFO - mozdebug == 0.1 03:30:33 INFO - mozdevice == 0.48 03:30:33 INFO - mozfile == 1.2 03:30:33 INFO - mozhttpd == 0.7 03:30:33 INFO - mozinfo == 0.9 03:30:33 INFO - mozleak == 0.1 03:30:33 INFO - mozlog == 3.1 03:30:33 INFO - moznetwork == 0.27 03:30:33 INFO - mozprocess == 0.22 03:30:33 INFO - mozprofile == 0.28 03:30:33 INFO - mozrunner == 6.11 03:30:33 INFO - mozscreenshot == 0.1 03:30:33 INFO - mozsystemmonitor == 0.0 03:30:33 INFO - moztest == 0.7 03:30:33 INFO - mozversion == 1.4 03:30:33 INFO - psutil == 3.1.1 03:30:33 INFO - requests == 1.2.3 03:30:33 INFO - wsgiref == 0.1.2 03:30:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:33 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')]} 03:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:33 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')]} 03:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:33 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 0x7f171ec25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920160>, '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 0x2921060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29214f0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', '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 03:30:33 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 03:30:33 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 03:30:33 INFO - Using env: {'DISPLAY': ':0', 03:30:33 INFO - 'HOME': '/home/cltbld', 03:30:33 INFO - 'LANG': 'en_US.UTF-8', 03:30:34 INFO - 'LANGUAGE': 'en_US:en', 03:30:34 INFO - 'LOGNAME': 'cltbld', 03:30:34 INFO - 'MAIL': '/var/mail/cltbld', 03:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:34 INFO - 'MOZ_NO_REMOTE': '1', 03:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:34 INFO - 'NO_EM_RESTART': '1', 03:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:34 INFO - 'PWD': '/builds/slave/test', 03:30:34 INFO - 'SHELL': '/bin/bash', 03:30:34 INFO - 'SHLVL': '1', 03:30:34 INFO - 'TERM': 'linux', 03:30:34 INFO - 'TMOUT': '86400', 03:30:34 INFO - 'USER': 'cltbld', 03:30:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', 03:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:34 INFO - '_': '/tools/buildbot/bin/python'} 03:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:34 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)) 03:30:34 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)) 03:30:34 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)) 03:30:34 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)) 03:30:34 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)) 03:30:34 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)) 03:30:34 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)) 03:30:34 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)) 03:30:34 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)) 03:30:34 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)) 03:30:34 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)) 03:30:34 INFO - Cleaning up... 03:30:34 INFO - Return code: 0 03:30:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:34 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 0x7f171ec25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920160>, '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 0x2921060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29214f0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', '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 03:30:34 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 03:30:34 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 03:30:34 INFO - Using env: {'DISPLAY': ':0', 03:30:34 INFO - 'HOME': '/home/cltbld', 03:30:34 INFO - 'LANG': 'en_US.UTF-8', 03:30:34 INFO - 'LANGUAGE': 'en_US:en', 03:30:34 INFO - 'LOGNAME': 'cltbld', 03:30:34 INFO - 'MAIL': '/var/mail/cltbld', 03:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:34 INFO - 'MOZ_NO_REMOTE': '1', 03:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:34 INFO - 'NO_EM_RESTART': '1', 03:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:34 INFO - 'PWD': '/builds/slave/test', 03:30:34 INFO - 'SHELL': '/bin/bash', 03:30:34 INFO - 'SHLVL': '1', 03:30:34 INFO - 'TERM': 'linux', 03:30:34 INFO - 'TMOUT': '86400', 03:30:34 INFO - 'USER': 'cltbld', 03:30:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', 03:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:34 INFO - '_': '/tools/buildbot/bin/python'} 03:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:34 INFO - Downloading/unpacking jsonschema 03:30:34 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 03:30:34 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 03:30:34 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 03:30:34 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 03:30:34 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 03:30:34 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 03:30:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:30:36 INFO - Downloading/unpacking functools32 (from jsonschema) 03:30:36 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 03:30:36 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 03:30:36 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 03:30:36 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 03:30:36 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 03:30:36 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 03:30:36 INFO - Downloading functools32-3.2.3-2.tar.gz 03:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:30:36 INFO - warning: no files found matching '*.txt' 03:30:36 INFO - no previously-included directories found matching 'build' 03:30:36 INFO - no previously-included directories found matching 'dist' 03:30:36 INFO - no previously-included directories found matching '.git*' 03:30:36 INFO - Installing collected packages: jsonschema, functools32 03:30:36 INFO - Running setup.py install for functools32 03:30:36 INFO - warning: no files found matching '*.txt' 03:30:36 INFO - no previously-included directories found matching 'build' 03:30:36 INFO - no previously-included directories found matching 'dist' 03:30:36 INFO - no previously-included directories found matching '.git*' 03:30:36 INFO - Successfully installed jsonschema functools32 03:30:36 INFO - Cleaning up... 03:30:36 INFO - Return code: 0 03:30:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:30:36 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')]} 03:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:36 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')]} 03:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:36 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 0x7f171ec25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2891410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920160>, '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 0x2921060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29214f0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', '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 03:30:36 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 03:30:36 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 03:30:36 INFO - Using env: {'DISPLAY': ':0', 03:30:36 INFO - 'HOME': '/home/cltbld', 03:30:36 INFO - 'LANG': 'en_US.UTF-8', 03:30:36 INFO - 'LANGUAGE': 'en_US:en', 03:30:36 INFO - 'LOGNAME': 'cltbld', 03:30:36 INFO - 'MAIL': '/var/mail/cltbld', 03:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:36 INFO - 'MOZ_NO_REMOTE': '1', 03:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:36 INFO - 'NO_EM_RESTART': '1', 03:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:36 INFO - 'PWD': '/builds/slave/test', 03:30:36 INFO - 'SHELL': '/bin/bash', 03:30:36 INFO - 'SHLVL': '1', 03:30:36 INFO - 'TERM': 'linux', 03:30:36 INFO - 'TMOUT': '86400', 03:30:36 INFO - 'USER': 'cltbld', 03:30:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', 03:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:36 INFO - '_': '/tools/buildbot/bin/python'} 03:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:36 INFO - Downloading/unpacking flake8 03:30:36 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 03:30:36 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 03:30:36 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 03:30:36 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 03:30:36 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 03:30:36 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 03:30:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:30:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:30:38 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 03:30:38 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 03:30:38 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 03:30:38 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 03:30:38 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 03:30:38 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 03:30:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:30:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:30:38 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 03:30:38 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 03:30:38 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 03:30:38 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 03:30:38 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 03:30:38 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 03:30:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:30:39 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 03:30:39 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 03:30:39 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 03:30:39 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 03:30:39 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 03:30:39 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 03:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:30:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:30:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:30:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:30:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:30:39 INFO - no previously-included directories found matching 'docs/_build' 03:30:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:30:39 INFO - Running setup.py install for pep8 03:30:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:30:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:30:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:30:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:30:39 INFO - no previously-included directories found matching 'docs/_build' 03:30:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:30:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:30:39 INFO - Cleaning up... 03:30:39 INFO - Return code: 0 03:30:39 INFO - Running post-action listener: _resource_record_post_action 03:30:39 INFO - Running post-action listener: _start_resource_monitoring 03:30:39 INFO - Starting resource monitoring. 03:30:39 INFO - ##### 03:30:39 INFO - ##### Running install step. 03:30:39 INFO - ##### 03:30:39 INFO - Running pre-action listener: _resource_record_pre_action 03:30:39 INFO - Running main action method: install 03:30:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:39 INFO - Reading from file tmpfile_stdout 03:30:39 INFO - Detecting whether we're running mozinstall >=1.0... 03:30:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:30:40 INFO - Reading from file tmpfile_stdout 03:30:40 INFO - Output received: 03:30:40 INFO - Usage: mozinstall [options] installer 03:30:40 INFO - Options: 03:30:40 INFO - -h, --help show this help message and exit 03:30:40 INFO - -d DEST, --destination=DEST 03:30:40 INFO - Directory to install application into. [default: 03:30:40 INFO - "/builds/slave/test"] 03:30:40 INFO - --app=APP Application being installed. [default: firefox] 03:30:40 INFO - mkdir: /builds/slave/test/build/application 03:30:40 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'] 03:30:40 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 03:30:55 INFO - Reading from file tmpfile_stdout 03:30:55 INFO - Output received: 03:30:55 INFO - /builds/slave/test/build/application/firefox/firefox 03:30:55 INFO - Running post-action listener: _resource_record_post_action 03:30:55 INFO - ##### 03:30:55 INFO - ##### Running run-tests step. 03:30:55 INFO - ##### 03:30:55 INFO - Running pre-action listener: _resource_record_pre_action 03:30:55 INFO - Running main action method: run_tests 03:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:30:55 INFO - Python 2.7.3 03:30:55 INFO - Return code: 0 03:30:55 INFO - grabbing minidump binary from tooltool 03:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:55 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 0x2920160>, '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 0x2921060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29214f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:30:55 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 03:30:55 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 03:30:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:30:55 INFO - Return code: 0 03:30:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:30:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:30:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:30:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:30:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:30:56 INFO - Return code: 0 03:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:30:56 INFO - Using env: {'DISPLAY': ':0', 03:30:56 INFO - 'HOME': '/home/cltbld', 03:30:56 INFO - 'LANG': 'en_US.UTF-8', 03:30:56 INFO - 'LANGUAGE': 'en_US:en', 03:30:56 INFO - 'LOGNAME': 'cltbld', 03:30:56 INFO - 'MAIL': '/var/mail/cltbld', 03:30:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:30:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:56 INFO - 'MOZ_NO_REMOTE': '1', 03:30:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:56 INFO - 'NO_EM_RESTART': '1', 03:30:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:56 INFO - 'PWD': '/builds/slave/test', 03:30:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:30:56 INFO - 'SHELL': '/bin/bash', 03:30:56 INFO - 'SHLVL': '1', 03:30:56 INFO - 'TERM': 'linux', 03:30:56 INFO - 'TMOUT': '86400', 03:30:56 INFO - 'USER': 'cltbld', 03:30:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008', 03:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:56 INFO - '_': '/tools/buildbot/bin/python'} 03:30:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:30:57 INFO - mozversion application_buildid: 20160311024912 03:30:57 INFO - mozversion application_changeset: b015db3afa462d65b3bd58ab6cc080401f85bafa 03:30:57 INFO - mozversion application_display_name: Nightly 03:30:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:30:57 INFO - mozversion application_name: Firefox 03:30:57 INFO - mozversion application_remotingname: firefox 03:30:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:30:57 INFO - mozversion application_vendor: Mozilla 03:30:57 INFO - mozversion application_version: 48.0a1 03:30:57 INFO - mozversion platform_buildid: 20160311024912 03:30:57 INFO - mozversion platform_changeset: b015db3afa462d65b3bd58ab6cc080401f85bafa 03:30:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:30:57 INFO - mozversion platform_version: 48.0a1 03:30:57 INFO - using testdate: 1457695857 03:30:57 INFO - actual date: 1457695857 03:30:57 INFO - starting webserver on 'localhost:50509' 03:30:57 INFO - SUITE-START | Running 2 tests 03:30:57 INFO - TEST-START | dromaeo_css 03:30:57 INFO - operating with platform_type : linux_ 03:30:57 INFO - Initialising browser for dromaeo_css test... 03:30:57 INFO - TEST-INFO | started process 5057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyXUZMA/profile http://localhost:50509/getInfo.html) 03:31:01 INFO - PROCESS | 5057 | 03:31:01 INFO - PROCESS | 5057 | (process:5135): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:31:02 INFO - PROCESS | 5057 | __metrics Screen width/height:1600/1200 03:31:02 INFO - PROCESS | 5057 | colorDepth:24 03:31:02 INFO - PROCESS | 5057 | Browser inner width/height: 1024/697 03:31:02 INFO - PROCESS | 5057 | __metrics 03:31:03 ERROR - PROCESS | 5057 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 03:31:04 INFO - TEST-INFO | 5057: exit 0 03:31:04 INFO - Browser initialized. 03:31:04 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:04 INFO - TEST-INFO | started process 5187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyXUZMA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:05 INFO - PROCESS | 5187 | 03:31:05 INFO - PROCESS | 5187 | (process:5247): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:31:16 INFO - PROCESS | 5187 | RSS: Main: 165646336 03:31:16 INFO - PROCESS | 5187 | 03:32:05 INFO - PROCESS | 5187 | 1457695925585 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] 03:34:17 INFO - PROCESS | 5187 | Cycle 1(1): loaded http://localhost:50509/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50509/tests/dromaeo/cssquery-ext.html) 03:34:18 INFO - PROCESS | 5187 | RSS: Main: 168570880 03:34:18 INFO - PROCESS | 5187 | 03:37:20 INFO - PROCESS | 5187 | Cycle 1(1): loaded http://localhost:50509/tests/dromaeo/cssquery-ext.html (next: http://localhost:50509/tests/dromaeo/cssquery-jquery.html) 03:37:20 INFO - PROCESS | 5187 | RSS: Main: 169005056 03:37:20 INFO - PROCESS | 5187 | 03:40:22 INFO - PROCESS | 5187 | Cycle 1(1): loaded http://localhost:50509/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50509/tests/dromaeo/cssquery-mootools.html) 03:40:23 INFO - PROCESS | 5187 | RSS: Main: 170196992 03:40:23 INFO - PROCESS | 5187 | 03:43:25 INFO - PROCESS | 5187 | Cycle 1(1): loaded http://localhost:50509/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50509/tests/dromaeo/cssquery-prototype.html) 03:43:25 INFO - PROCESS | 5187 | RSS: Main: 168284160 03:43:25 INFO - PROCESS | 5187 | 03:46:28 INFO - PROCESS | 5187 | Cycle 1(1): loaded http://localhost:50509/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50509/tests/dromaeo/cssquery-yui.html) 03:46:29 INFO - PROCESS | 5187 | RSS: Main: 167952384 03:46:29 INFO - PROCESS | 5187 | 03:49:31 INFO - PROCESS | 5187 | Cycle 1(1): loaded http://localhost:50509/tests/dromaeo/cssquery-yui.html (next: http://localhost:50509/tests/dromaeo/cssquery-dojo.html) 03:49:31 INFO - PROCESS | 5187 | RSS: Main: 171683840 03:49:31 INFO - PROCESS | 5187 | 03:49:31 INFO - PROCESS | 5187 | __start_tp_report 03:49:31 INFO - PROCESS | 5187 | _x_x_mozilla_page_load 03:49:31 INFO - PROCESS | 5187 | _x_x_mozilla_page_load_details 03:49:31 INFO - PROCESS | 5187 | |i|pagename|runs| 03:49:31 INFO - PROCESS | 5187 | |0;dojo.html;2586.1724248240557;2634.5257853586354;2652.6286319915203;2680.236132702179;2684.4765270772195;4518.751468669226;4573.245414506607;4584.656150788692;4610.654200934927;4623.260278355464;4463.933041004379;4560.4527456705155;4578.130155270496;4614.676972611918;4638.4665763437215;4188.392683060954;4193.43388642534;4241.4274073000215;4245.851395201169;4292.484901811771;4200.264953633117;4220.472440944882;4247.320428731404;4257.87226383209;4299.226139294926;4156.4181014657825;4198.517170525398;4218.240716670998;4235.407043013981;4246.723962942398;4216.810243539048;4223.97888010561;4229.217594744982;4245.87262382129;4264.147170565868;4043;4141.254574176647;4212.220739163234;4215.725977811432;4238.08881090564;4454.265046267395;4475.619572336355;4479.73121612701;4532.9320060199125;4533.455985281787;4804.711717296938;4811.278308253755;4838.346823178861;4846.369971903665;4860.198067318888;4829.9275510867365;4865.099956508057;4869.659123861331;4892.926606100911;4981.352424184833;4552.499225085238;4557.886052848706;4560.9771951140365;4587.197240482936;4608.493065762764;5015.04714104319;5018.096742586369;5018.974905125524;5024.346834911511;5069.290299358093;4676.18166820805;4798.640101992364;4845.345878306454;4863;4871.391076115486;4689.249720044776;4791.928121078186;4853.247746599212;4862.465128835825;4952.603791696728;4826.300186472942;4840.540148685869;4846.055019271279;4854.271859221074;4890.510948905152;4672.976635116803;4752.667313288106;4767.547083027107;4852.296417019513;4890.657653964259;4039.5960403959957;4041.7170798044444;4053.6757059435176;4074.1444296698023;4078.163976384834;3575.249197668467;3577.69589584883;3595.5617752899047;3610.2959922815326;3612.9277414451562;4149.8962525937095;4156.355764856452;4219.599138081878;4223.155368926227;4282.186384586918;4839.346688197048;4868.318435419044;4882.853514394574;4887.608991280689;4918.5573298403315;4203.70574059819;4226.112516371596;4237.766922819213;4241.384999175102;4289.1207302503535;4270.807813648331;4345.782710864444;4381.9342709859375;4397.450318710161;4418.469783625921;4605.332226827091;4612.215923293115;4620.8151673933335;4624.398828152319;4674.275487299474;4736.928946065881;4898.990652717966;4917.655764096479;4918.95081049185;4919.2129259318335;4596.195665758412;4606.378138951332;4616.376789133424;4662.160811054043;4663.836765713184;4779.211430114131;4796.904061918673;4814.301926220608;4818.590419814355;4856.732879691651;4769.546893045155;4839.612830973584;4880.463149053672;4900.95099049005;4906;4675.812967481399;4716.339712440193;4731.763411829464;4748.857534273978;4810.062037902715;4757.690750101232;4767.952320476751;4769.976150119227;4770.284457331428;4820.68665536739;4553.089382123522;4664.743439110882;4683.758803916897;4702.106599746037;4752;4731.266653668687;4787.3776409068;4789.1858384075485;4821.831235906727;4834.806607735652;4534.727916325031;4570.108828778356;4618.191816432044;4618.4919658836825;4672.065586882705 03:49:31 INFO - PROCESS | 5187 | |1;ext.html;481.03312342192186;488.12869028783626;541.8103663717699;543.9428859969703;554.4898693202254;32971.175720606996;33045.33909321812;33362;33435.331293374176;33445.83277083614;36818.26363472729;37233.44149837755;37419.25161496768;37433.25133497328;37490.250194996086;7685.615719214031;7805.765827025199;7823.10034346049;7842.607869606497;7887.763367098996;7713.6914523419;7719.575423351714;7802.141764405911;7974.082980457264;7984.321332686729;7955.602219889011;8005.959970200141;8019.759407217793;8036.8392632147325;8045.396595255379;7948.2051794820345;8003.879941800848;8017.118117007125;8032.1164671886045;8042.115367309591;7891.842163156704;8016.438849280553;8018.6391612377;8024.478408903403;8044.517328960281;36721.081972950626;37155.814220928994;37391;37499;37510.8124459376;2275.7155355580553;2779.374640705845;2839.900603478868;2873.813202141875;3163.9525407118913;24349.63475547868;24775.132870349633;24816.5036699265;25225.87387063053;25460.618090728654;3259.869605215812;3268.4933835255574;3279.797462310198;3310.619278782947;3412.2493051528622;141500;142317.2884135583;142647.28676356655;142912;142993;51134;51153.48846511562;51509.227361589605;51549;51717;60483.09275360873;60848.08727869086;60919.69540152271;61476.69261653663;61519.077213841825;13111.344432778324;13114.737705245841;13225.27261000635;13254.40355184019;13285.468581256642;11305.71735706614;11306.434678266054;11320.207585468937;11342.829857552144;11350.602728904449;19352.612947740967;19524.12141453638;19582.804171958098;19600.509987250432;19626.21495140207;7827.608619569112;7962.3630109591095;8062.475939063942;8102.959485202537;8236.258736713724;776.8213310938515;856.648774002656;972.6158167523788;1043.6555936540924;1062.7024433158729;26394.208173754818;26571.73428265731;26606.46787064248;26688.59967100495;26868;904.615538396179;940.9623615055458;976.5800705696477;994.6717583197527;1014.0619926567895;13430.836440703413;13600.183988960694;13907.513237036655;14127.594463819074;14248.216348100954;264047;265633;266130;267656;268320;45252.54747452549;45781;45846.77076614596;45935;45990.770046149555;1194.7789658912955;1196.629044996054;1212.1575505023923;1215.5563219425023;1238.721287710258;25155.87422062878;25729.356766080247;26248.60627090557;26378.86810565935;26439.471210575295;35395.82302088473;35492.46761298531;35531.28937421289;35585.82207088948;35855;248459;249095;249333;249538;251084;29459.11622651324;29715;30320.241993950327;30336.84831575828;30421.391572168875;39152.80423597864;39429.408558871066;39616.60383396129;39652.2069558613;40009.399859001554;33904;34134.65865341414;34136;34160.14599635029;34207;33335.33329333351;33612.327753445286;33743.49384759182;34303.65696343104;34639.4804077934;27738.861305693343;33031.33937321288;33463.33073338471;34081;34480.31039379148;26739;26808.463830722885;26899.86550067237;26933.326666833487;27751.722482774912;22768.20311289097;22879.31362059141;23224.767752322936;23342;23433.648495272242 03:49:31 INFO - PROCESS | 5187 | |2;jquery.html;302.80923018498345;314.910250578585;318.32991552781385;324.3852898756857;329.7016200338693;11538.192326537124;14757.852421475796;15344.156071416082;15397.690346448024;15541;14750.26248687564;15013.249337533107;15093.92453037736;15149.772753408708;15297.388104475835;4744.525547445253;4918.262260660912;4951.331570238008;4973.0551195272965;4989.2017277235645;4746.596539294164;4862.367892174012;4916.385451818523;4926.655134140611;4949.950500494985;4955.752212389384;4962.379702537183;4968.056069346812;4997.60019198465;4997.750112494379;4920.532549407801;4954.207326827726;4960.479149689285;4962.627802914778;4968.925466117993;4763.095011947719;4957.03337849116;4972;4981.5267549583095;4999.8000079996755;12044.638660840188;12284.324362160078;15325.46360877364;19480;19544.413667589994;1783.7146056630877;1845.0682405385328;1865.4590168851016;1875.5779949511386;2343.3790045637747;8754.255888249507;8925.955370223108;9148.222401095914;11916.642500724993;11927.866852648984;1732.8786984911062;1757.8593712503098;1761.4803632928317;1780.6794776940146;1832.1938347127355;41250.38124428136;48726.51273487255;48958.51041489611;54707.179392309146;60420;9336.673216437392;9464.722262494613;9665.420074795535;9687.70936871895;9842.065003824626;12223.08326875488;12229.205101668364;12321.876781232253;12352.75294494105;12376.443060062318;7184.640767961581;7201.279872012861;7236.38490728294;7329.267073292628;7396.852062958818;7036.859262814715;7163.641817909083;7167.3549380556;7215.747448839265;7339.926600734031;3825.2731980923536;3854.325493038707;3873.61263873616;3902.083010492532;3903.2193561287854;1667.3080671521425;1737.7480265361705;1744.1017875793975;1747.5281673948218;1767.0457952705651;821.2444551013082;845.2984023260678;862.4911302331654;876.3033388456192;930.5347326336831;15495.612609684847;15718.528444146694;15725.370985160695;15850.286737096858;15933.521994340188;820.8071103290722;850.3452341696982;855.153398135841;908.1327332397544;947.4930911962205;8808.295336373203;9062.909370906338;9069.002409735056;9090.909090909006;9305.674301399418;359945;361720;366475.1676241655;366849;370123;65663.67168164128;65703.34296657068;67231;67742.32257677459;68144;852.5609311204735;885.349268287808;887.0287035695902;908.9227415669742;914.9725508234764;13807.51673691416;13837.446502139801;13935.651608709863;13936.4425422986;14313.785293220819;28782.280442989093;30509.847450763493;31902.202444939063;32208.516872247405;32409.675903240666;42332.788336058125;42384;42638.78680606577;42659.36010959776;42833.35749963815;7134.857302854018;7223.386012189023;7287.344139027301;7323.7436689715605;7324.560526368435;8164.469309494863;10542.894571054192;10749.570017199225;10985;11244.60643877493;9283.071692830663;9390.154886060287;9442.575084121368;9470.337076404585;9710.22318214527;9150.954245228997;9442.622295108118;9487.857682134912;9650.276229282692;9658.517074146404;9446.574904129468;9474.763130921781;9619.5671194795;9719.319647624598;9842.114209720872;7228.63856807147;7263.201047884834;7317.634118294171;7324.377427918686;7529.774106776806;8286.171382861665;9116.544172791466;9124.31567632417;9152.725418237464;9536.809263814823 03:49:31 INFO - PROCESS | 5187 | |3;mootools.html;1351.9797203041953;1369.1100784490084;1476.23235917323;1671.2479384277078;1690.7886514185718;6311.147995020671;7024.121984751906;7074.39867611253;7292.708291668334;7340.632968351581;7055.823604409879;7198.640067996593;7204.495685302031;7227.783166505;7244;2075.9065842037107;2102.8212601928853;2104.884231367274;2105.221068204766;2107.283523601975;2082.804923535994;2085.3222702621633;2092.246791155183;2098.3390232076845;2123.278085450954;2087.332053742803;2088.6449303618347;2092.7697953225133;2098.7271654684946;2133.8263954824783;2100.2019232691478;2105.663093904968;2122.5224324526935;2123.4479035450818;2127.0322003488454;2017.183040868436;2021.4542073640034;2025.4227545149708;2040.8877511736848;2041.7345745053196;7227.747028854017;7332.120145582511;7336.816579585499;7337.816554586125;7355.080614923135;4149.91700165995;4248.1078973415315;4252.425922500484;4263.808128634188;4275.636570891478;2722.618833363331;2773.1126039667315;2789.232960935759;2849.0455697341417;2857.7568757590307;913.2283220678516;922.8523436250168;936.293098710476;941.181172380027;947.7725345916999;9583;9584.808303833954;9610.615575376976;9686.854697179548;9725.708228753148;3824;3947.546032206333;3952.782596957195;4003.219372222447;4009.7393669411395;8321.958390208132;8345.998480182296;8374.204450577185;8388.538630375388;8396;4360.389545463638;4362.8691139265875;4374.518802931675;4381.627561657231;4383.49589797171;3381.458966565338;3878.166194268246;3951.9604803952166;3968.8809335719975;3972.3644216925154;3297.0603378037144;3351.2794749129052;3358.177246574605;3385.9830700846337;3387.9836049185146;1058.7564860082225;1073.592035026685;1082.826747720361;1083.8807731149568;1086.3481910853425;861.2464093917822;865.6580650643086;865.6667183134413;868.7046404222468;1091.317926296065;6847.691853866588;6865.794026179223;6878.65606719672;6890.069840571559;6904.689288982008;433.29373121811244;440.47143427886664;442.64146041706323;445.15642856786206;454.81579960116204;5237.973810131001;5269.077911365495;5271.341082364705;5284.9735751320995;5289.920651190235;8747.256483198998;8819.647214111365;8927.375083744206;8970.327225458117;8977.326700497359;8831.205191532792;8870.467771933705;8876.600552975131;8896.332775041898;8906.86639700405;6838.829029274209;6933.618650974144;7007.684654190573;7065.717371305193;7116.537425067354;6510.837229069311;6577.671116444254;6585.736570537125;6602.0096985452565;6607.438367738796;7792.117299834182;7826.099998500245;8120.634571444417;8129.512229266263;8200.917990820255;7646.847063058819;7744.225577442211;7807.297343239135;7854.253845884632;8307.08622051586;5325.414204437587;5815.098659707752;5819.5053420459735;5907.734151963258;5918.822435326947;6495.188101487314;6586.901196481961;6603.240627327918;6606.43845273138;6619.470442364695;5929.9757123866275;6102.816915492543;6180.907286390798;6226.128342032029;6332.335104813928;5880.470757631833;5929.436703513159;6044.879102418015;6098.268207814913;6101.054336577838;6234.937650623617;6382.712777924911;6408.070829729756;6408.807735767934;6408.807735767934;5759.827205183851;5826.359100499027;5841.211436456024;5857.4435428634215;5878.353381127987;5838.416158384298;5861.9706901465215;5911.113333000085;6056.333803281724;6091.451769340781 03:49:31 INFO - PROCESS | 5187 | |4;prototype.html;301.47242325929625;306.03598664207755;307.1997446651473;307.403636944328;308.7283190792103;5498.615096943216;5585.972070139649;5591.384947655754;5661.773529058843;5682.772689092441;5496.615236933416;5558.471945165213;5559.749811258493;5634;5649.774009039644;4021.7989100545;4183.979080104596;4252.128313695685;4267.359896015607;4303.24693178694;4266.146770645868;4280.3793449949735;4284.078923031548;4288.914221715564;4293.527711951699;4240.957590424103;4242.406063151161;4244.129953359554;4252.936205956913;4323.4163387942535;4329.783510824446;4335.804888780012;4338.132373525307;4338.392625032498;4350.12997400518;3800.923981520382;3821.7706937583557;3824.1204522959597;3828.1195325075387;3831.080540670247;5395.514403703646;5424.1321388577635;5426.294581704393;5427.023135835548;5433.347998240197;4880.511948805127;4965.230389289666;4977.800887964477;4993.051320249141;4993.101241776479;5815.069588865761;5845.09401042839;5866.384029676865;5872.17789509469;5875.030619947704;4105.096878686684;4113.4035564843225;4114.280000999843;4115.567865374122;4135.338345864678;6075.665838378887;6186.597871138361;6196.256449226076;6227.221597300338;6227.283862355842;4219.0507135894795;4221.852235171816;4223.408722778813;4231.132617813341;4243.405923170759;4289.892752681208;4298.957010429918;4320.243957307459;4326.870193894189;4332.393464914914;4698.060387922361;4864.270359446112;4916.115099282092;4942.950570494249;4950.356453661001;5812.186293918855;5854.975379308604;5878.500327472213;5878.941210587839;5882.323532793698;1454.7308747881464;1499.6475828180369;1501.4519700309309;1503.0680977793838;1505.0217358716923;1028.0644613401769;1031.886492485826;1046.1055797293204;1059.9894001060045;1068.6046162919613;5066.847994560169;5078.619103567174;5090.949090509122;5101.387833459934;5105;6050.727717252734;6080.513558915276;6095.634261944298;6098.390160983955;6102.572819902564;4887.169181239198;5064.544191022752;5068.113080210948;5075;5098.923516147261;3197.7761556690807;3281.4585593376823;3298.6701329866823;3300.0924745695124;3304.686054824788;5700.543956483471;5716.114002329646;5717.542596592262;5732.598718089777;5738.024535828919;6253.53098517613;6261.373862613702;6273.498120150468;6292.968535157295;6298.496120310364;5674.2623458950075;5718.199452076629;5718.228039214736;5719.885602287931;5730.255066841284;5816.41835816415;5953.166556682155;5996.130561068708;6082.817515474366;6151.0773383992755;6006.33930267679;6014;6017.976943919457;6025;6029.78895738647;5730.484256416776;5741.25363702716;5797.449242321973;5806.6806325650805;5815.273090863642;4229.851955181677;4264.488261408651;4265.253580623441;4269.444972153724;4271.444712187395;5842.415758424124;6090.116933044772;6108.541859360655;6122.755089796358;6125.601835880653;5670.09278515452;5711;5802.564807639528;5810.883782324246;5815.912761308499;5798.739056742373;5809.50619197373;5867.383924687846;5887.970560147171;5900.232969713909;5717.542596592346;5769.79805706815;5771.451712087345;5779.479846813807;5793.91309130355;5890.617109887844;5901.527877769854;5922.1412895130825;5924.437178468039;5946.910796338145;5469.15228139639;5630.549556035426;5652.5477961762135;5705.857353566194;5739.684317362585 03:49:31 INFO - PROCESS | 5187 | |5;yui.html;752.2252080357232;753.2919056087275;755.2900273742681;758.0713625808386;762.7597306848343;11585;11762.823557646641;11788.29270243785;11810.940945295282;11858.288502689833;11251.662450126489;11602.245854019482;11652.592159274427;11764.882351176486;11806.468708908098;773.640257280366;791;793.8610743119959;794.3327604811985;796.1322158846856;797.8125140591957;800.8918795962558;805.1827395193883;805.375833728859;806.4919100966413;831.78789408701;832.1553623072587;834.3200291762195;834.8580741273968;836.640244694781;824.2458150792048;829.6432534010373;830.6054624053587;832.305025303872;832.7751507093111;608.9147519347295;610.7099127914249;613.5030625193563;613.923259592551;616.6515918506029;11059.059979901638;11091.83362249567;11101.167412444018;11150.60972865954;11154.832677509843;9889.307748457612;10376.429296388696;10479.94760026195;10516.316439431488;10532.947335263274;8847.513386763725;9008.189262966365;9020.233280171193;9221.400608960463;9238.722838314861;3117.392108538836;3130.139211716796;3161.731252843511;3181.1569933967517;3194.0417874637747;38234.80882595569;38845.41731873996;38893.61106388928;39083.80458097691;40490;9544.95227523858;9597.760055998657;9615.855762163434;9638.75903102414;9707.126358627616;15678.843211567966;15688.372465101496;15720.60698482547;15812.130332831804;15814.051156930622;6486.156799616019;6548.869022619521;6571.3757193066585;6584.736610535525;6624.7681331154145;3649.726270529668;3706.369917114097;3715.925681486355;3722.739408241451;3730.0488375464624;2711.1324376199427;2728.3451971526692;2738.602902579115;2742.040285899959;2746.231055304518;507.3556583139392;514.1028904561564;514.8532668189548;514.9716765577854;520.3755493407925;491.8819483324048;540.2301720048914;547.8383876756367;560.5375565158761;633.0788702437942;7673.309402153722;7737.5744334062165;7854.60726963661;8080.636371363303;8139.226773456512;562.131506821961;578.6470253145578;588.632104934416;593.2969431224013;604.4016423740466;3605.188832512664;3704.8518059277867;3721.9441708374397;3724.329620668306;3765.1151979284846;42462.78768606137;47751.5224847754;48238.51761482411;48289.27566086512;48317;41371;42589.57410425856;42675;43220;43232.56767432348;36989.815050924575;37488.25023499515;38150.61849381526;39312.410313845314;39348;7701.80745481345;7901.565413902291;7939.166387529226;8144.55204963709;8172.387070969582;30584.541231881984;30915.536266955565;31360.843195783877;31849.36301273915;31871.36257274888;35418.29163416666;35471;35530.28939421249;37887.43168852414;39428.2114357717;10029.648962286285;10537.157027437634;10542.262041657317;10567.89432105669;10726.463676816284;11000.669979900616;11032.558697652325;11099.445027748741;11139.164562657996;11200.159988000769;10457.738556536147;10482.68551943443;10597.523111460157;10687.412192329186;10705.9464702676;10712.517936692711;10961.177911656498;11107.111431085332;11391.715207119889;11412.31526108436;10046.899531004889;10216.438095904796;10303.124234440156;10584.629537966135;10805.891941080488;8336.333093352396;8870.246029087342;8895.688650897187;9100.271978241857;9225.677101301422;9188.40275382098;9342.579583918605;9383;9449.795173432933;9644.807103858024 03:49:31 INFO - PROCESS | 5187 | __end_tp_report 03:49:31 INFO - PROCESS | 5187 | __start_cc_report 03:49:31 INFO - PROCESS | 5187 | _x_x_mozilla_cycle_collect,380 03:49:31 INFO - PROCESS | 5187 | __end_cc_report 03:49:31 INFO - PROCESS | 5187 | __startTimestamp1457696971643__endTimestamp 03:49:31 INFO - PROCESS | 5187 | 03:49:31 INFO - PROCESS | 5187 | ------- Summary: start ------- 03:49:31 INFO - PROCESS | 5187 | Number of tests: 6 03:49:31 INFO - PROCESS | 5187 | 03:49:31 INFO - PROCESS | 5187 | [#0] dojo.html Cycles:165 Average:4506.68 Median:4618.49 stddev:457.29 (9.9%) stddev-sans-first:433.16 03:49:31 INFO - PROCESS | 5187 | Values: 2586.2 2634.5 2652.6 2680.2 2684.5 4518.8 4573.2 4584.7 4610.7 4623.3 4463.9 4560.5 4578.1 4614.7 4638.5 4188.4 4193.4 4241.4 4245.9 4292.5 4200.3 4220.5 4247.3 4257.9 4299.2 4156.4 4198.5 4218.2 4235.4 4246.7 4216.8 4224.0 4229.2 4245.9 4264.1 4043.0 4141.3 4212.2 4215.7 4238.1 4454.3 4475.6 4479.7 4532.9 4533.5 4804.7 4811.3 4838.3 4846.4 4860.2 4829.9 4865.1 4869.7 4892.9 4981.4 4552.5 4557.9 4561.0 4587.2 4608.5 5015.0 5018.1 5019.0 5024.3 5069.3 4676.2 4798.6 4845.3 4863.0 4871.4 4689.2 4791.9 4853.2 4862.5 4952.6 4826.3 4840.5 4846.1 4854.3 4890.5 4673.0 4752.7 4767.5 4852.3 4890.7 4039.6 4041.7 4053.7 4074.1 4078.2 3575.2 3577.7 3595.6 3610.3 3612.9 4149.9 4156.4 4219.6 4223.2 4282.2 4839.3 4868.3 4882.9 4887.6 4918.6 4203.7 4226.1 4237.8 4241.4 4289.1 4270.8 4345.8 4381.9 4397.5 4418.5 4605.3 4612.2 4620.8 4624.4 4674.3 4736.9 4899.0 4917.7 4919.0 4919.2 4596.2 4606.4 4616.4 4662.2 4663.8 4779.2 4796.9 4814.3 4818.6 4856.7 4769.5 4839.6 4880.5 4901.0 4906.0 4675.8 4716.3 4731.8 4748.9 4810.1 4757.7 4768.0 4770.0 4770.3 4820.7 4553.1 4664.7 4683.8 4702.1 4752.0 4731.3 4787.4 4789.2 4821.8 4834.8 4534.7 4570.1 4618.2 4618.5 4672.1 03:49:31 INFO - PROCESS | 5187 | 03:49:31 INFO - PROCESS | 5187 | [#1] ext.html Cycles:180 Average:38144.28 Median:33537.83 stddev:59121.49 (176.3%) stddev-sans-first:59219.70 03:49:31 INFO - PROCESS | 5187 | Values: 481.0 488.1 541.8 543.9 554.5 32971.2 33045.3 33362.0 33435.3 33445.8 36818.3 37233.4 37419.3 37433.3 37490.3 7685.6 7805.8 7823.1 7842.6 7887.8 7713.7 7719.6 7802.1 7974.1 7984.3 7955.6 8006.0 8019.8 8036.8 8045.4 7948.2 8003.9 8017.1 8032.1 8042.1 7891.8 8016.4 8018.6 8024.5 8044.5 36721.1 37155.8 37391.0 37499.0 37510.8 2275.7 2779.4 2839.9 2873.8 3164.0 24349.6 24775.1 24816.5 25225.9 25460.6 3259.9 3268.5 3279.8 3310.6 3412.2 141500.0 142317.3 142647.3 142912.0 142993.0 51134.0 51153.5 51509.2 51549.0 51717.0 60483.1 60848.1 60919.7 61476.7 61519.1 13111.3 13114.7 13225.3 13254.4 13285.5 11305.7 11306.4 11320.2 11342.8 11350.6 19352.6 19524.1 19582.8 19600.5 19626.2 7827.6 7962.4 8062.5 8103.0 8236.3 776.8 856.6 972.6 1043.7 1062.7 26394.2 26571.7 26606.5 26688.6 26868.0 904.6 941.0 976.6 994.7 1014.1 13430.8 13600.2 13907.5 14127.6 14248.2 264047.0 265633.0 266130.0 267656.0 268320.0 45252.5 45781.0 45846.8 45935.0 45990.8 1194.8 1196.6 1212.2 1215.6 1238.7 25155.9 25729.4 26248.6 26378.9 26439.5 35395.8 35492.5 35531.3 35585.8 35855.0 248459.0 249095.0 249333.0 249538.0 251084.0 29459.1 29715.0 30320.2 30336.8 30421.4 39152.8 39429.4 39616.6 39652.2 40009.4 33904.0 34134.7 34136.0 34160.1 34207.0 33335.3 33612.3 33743.5 34303.7 34639.5 27738.9 33031.3 33463.3 34081.0 34480.3 26739.0 26808.5 26899.9 26933.3 27751.7 22768.2 22879.3 23224.8 23342.0 23433.6 03:49:31 INFO - PROCESS | 5187 | 03:49:31 INFO - PROCESS | 5187 | [#2] jquery.html Cycles:180 Average:21847.36 Median:4956.39 stddev:59876.62 (1208.1%) stddev-sans-first:60022.74 03:49:31 INFO - PROCESS | 5187 | Values: 302.8 314.9 318.3 324.4 329.7 11538.2 14757.9 15344.2 15397.7 15541.0 14750.3 15013.2 15093.9 15149.8 15297.4 4744.5 4918.3 4951.3 4973.1 4989.2 4746.6 4862.4 4916.4 4926.7 4950.0 4955.8 4962.4 4968.1 4997.6 4997.8 4920.5 4954.2 4960.5 4962.6 4968.9 4763.1 4957.0 4972.0 4981.5 4999.8 12044.6 12284.3 15325.5 19480.0 19544.4 1783.7 1845.1 1865.5 1875.6 2343.4 8754.3 8926.0 9148.2 11916.6 11927.9 1732.9 1757.9 1761.5 1780.7 1832.2 41250.4 48726.5 48958.5 54707.2 60420.0 9336.7 9464.7 9665.4 9687.7 9842.1 12223.1 12229.2 12321.9 12352.8 12376.4 7184.6 7201.3 7236.4 7329.3 7396.9 7036.9 7163.6 7167.4 7215.7 7339.9 3825.3 3854.3 3873.6 3902.1 3903.2 1667.3 1737.7 1744.1 1747.5 1767.0 821.2 845.3 862.5 876.3 930.5 15495.6 15718.5 15725.4 15850.3 15933.5 820.8 850.3 855.2 908.1 947.5 8808.3 9062.9 9069.0 9090.9 9305.7 359945.0 361720.0 366475.2 366849.0 370123.0 65663.7 65703.3 67231.0 67742.3 68144.0 852.6 885.3 887.0 908.9 915.0 13807.5 13837.4 13935.7 13936.4 14313.8 28782.3 30509.8 31902.2 32208.5 32409.7 42332.8 42384.0 42638.8 42659.4 42833.4 7134.9 7223.4 7287.3 7323.7 7324.6 8164.5 10542.9 10749.6 10985.0 11244.6 9283.1 9390.2 9442.6 9470.3 9710.2 9151.0 9442.6 9487.9 9650.3 9658.5 9446.6 9474.8 9619.6 9719.3 9842.1 7228.6 7263.2 7317.6 7324.4 7529.8 8286.2 9116.5 9124.3 9152.7 9536.8 03:49:31 INFO - PROCESS | 5187 | 03:49:31 INFO - PROCESS | 5187 | [#3] mootools.html Cycles:180 Average:4983.36 Median:5929.71 stddev:2636.61 (44.5%) stddev-sans-first:2629.88 03:49:31 INFO - PROCESS | 5187 | Values: 1352.0 1369.1 1476.2 1671.2 1690.8 6311.1 7024.1 7074.4 7292.7 7340.6 7055.8 7198.6 7204.5 7227.8 7244.0 2075.9 2102.8 2104.9 2105.2 2107.3 2082.8 2085.3 2092.2 2098.3 2123.3 2087.3 2088.6 2092.8 2098.7 2133.8 2100.2 2105.7 2122.5 2123.4 2127.0 2017.2 2021.5 2025.4 2040.9 2041.7 7227.7 7332.1 7336.8 7337.8 7355.1 4149.9 4248.1 4252.4 4263.8 4275.6 2722.6 2773.1 2789.2 2849.0 2857.8 913.2 922.9 936.3 941.2 947.8 9583.0 9584.8 9610.6 9686.9 9725.7 3824.0 3947.5 3952.8 4003.2 4009.7 8322.0 8346.0 8374.2 8388.5 8396.0 4360.4 4362.9 4374.5 4381.6 4383.5 3381.5 3878.2 3952.0 3968.9 3972.4 3297.1 3351.3 3358.2 3386.0 3388.0 1058.8 1073.6 1082.8 1083.9 1086.3 861.2 865.7 865.7 868.7 1091.3 6847.7 6865.8 6878.7 6890.1 6904.7 433.3 440.5 442.6 445.2 454.8 5238.0 5269.1 5271.3 5285.0 5289.9 8747.3 8819.6 8927.4 8970.3 8977.3 8831.2 8870.5 8876.6 8896.3 8906.9 6838.8 6933.6 7007.7 7065.7 7116.5 6510.8 6577.7 6585.7 6602.0 6607.4 7792.1 7826.1 8120.6 8129.5 8200.9 7646.8 7744.2 7807.3 7854.3 8307.1 5325.4 5815.1 5819.5 5907.7 5918.8 6495.2 6586.9 6603.2 6606.4 6619.5 5930.0 6102.8 6180.9 6226.1 6332.3 5880.5 5929.4 6044.9 6098.3 6101.1 6234.9 6382.7 6408.1 6408.8 6408.8 5759.8 5826.4 5841.2 5857.4 5878.4 5838.4 5862.0 5911.1 6056.3 6091.5 03:49:31 INFO - PROCESS | 5187 | 03:49:31 INFO - PROCESS | 5187 | [#4] prototype.html Cycles:180 Average:4861.23 Median:5482.88 stddev:1425.56 (26.0%) stddev-sans-first:1387.87 03:49:31 INFO - PROCESS | 5187 | Values: 301.5 306.0 307.2 307.4 308.7 5498.6 5586.0 5591.4 5661.8 5682.8 5496.6 5558.5 5559.7 5634.0 5649.8 4021.8 4184.0 4252.1 4267.4 4303.2 4266.1 4280.4 4284.1 4288.9 4293.5 4241.0 4242.4 4244.1 4252.9 4323.4 4329.8 4335.8 4338.1 4338.4 4350.1 3800.9 3821.8 3824.1 3828.1 3831.1 5395.5 5424.1 5426.3 5427.0 5433.3 4880.5 4965.2 4977.8 4993.1 4993.1 5815.1 5845.1 5866.4 5872.2 5875.0 4105.1 4113.4 4114.3 4115.6 4135.3 6075.7 6186.6 6196.3 6227.2 6227.3 4219.1 4221.9 4223.4 4231.1 4243.4 4289.9 4299.0 4320.2 4326.9 4332.4 4698.1 4864.3 4916.1 4943.0 4950.4 5812.2 5855.0 5878.5 5878.9 5882.3 1454.7 1499.6 1501.5 1503.1 1505.0 1028.1 1031.9 1046.1 1060.0 1068.6 5066.8 5078.6 5090.9 5101.4 5105.0 6050.7 6080.5 6095.6 6098.4 6102.6 4887.2 5064.5 5068.1 5075.0 5098.9 3197.8 3281.5 3298.7 3300.1 3304.7 5700.5 5716.1 5717.5 5732.6 5738.0 6253.5 6261.4 6273.5 6293.0 6298.5 5674.3 5718.2 5718.2 5719.9 5730.3 5816.4 5953.2 5996.1 6082.8 6151.1 6006.3 6014.0 6018.0 6025.0 6029.8 5730.5 5741.3 5797.4 5806.7 5815.3 4229.9 4264.5 4265.3 4269.4 4271.4 5842.4 6090.1 6108.5 6122.8 6125.6 5670.1 5711.0 5802.6 5810.9 5815.9 5798.7 5809.5 5867.4 5888.0 5900.2 5717.5 5769.8 5771.5 5779.5 5793.9 5890.6 5901.5 5922.1 5924.4 5946.9 5469.2 5630.5 5652.5 5705.9 5739.7 03:49:31 INFO - PROCESS | 5187 | 03:49:31 INFO - PROCESS | 5187 | [#5] yui.html Cycles:180 Average:11897.42 Median:42526.18 stddev:13111.51 (30.8%) stddev-sans-first:13121.57 03:49:31 INFO - PROCESS | 5187 | Values: 752.2 753.3 755.3 758.1 762.8 11585.0 11762.8 11788.3 11810.9 11858.3 11251.7 11602.2 11652.6 11764.9 11806.5 773.6 791.0 793.9 794.3 796.1 797.8 800.9 805.2 805.4 806.5 831.8 832.2 834.3 834.9 836.6 824.2 829.6 830.6 832.3 832.8 608.9 610.7 613.5 613.9 616.7 11059.1 11091.8 11101.2 11150.6 11154.8 9889.3 10376.4 10479.9 10516.3 10532.9 8847.5 9008.2 9020.2 9221.4 9238.7 3117.4 3130.1 3161.7 3181.2 3194.0 38234.8 38845.4 38893.6 39083.8 40490.0 9545.0 9597.8 9615.9 9638.8 9707.1 15678.8 15688.4 15720.6 15812.1 15814.1 6486.2 6548.9 6571.4 6584.7 6624.8 3649.7 3706.4 3715.9 3722.7 3730.0 2711.1 2728.3 2738.6 2742.0 2746.2 507.4 514.1 514.9 515.0 520.4 491.9 540.2 547.8 560.5 633.1 7673.3 7737.6 7854.6 8080.6 8139.2 562.1 578.6 588.6 593.3 604.4 3605.2 3704.9 3721.9 3724.3 3765.1 42462.8 47751.5 48238.5 48289.3 48317.0 41371.0 42589.6 42675.0 43220.0 43232.6 36989.8 37488.3 38150.6 39312.4 39348.0 7701.8 7901.6 7939.2 8144.6 8172.4 30584.5 30915.5 31360.8 31849.4 31871.4 35418.3 35471.0 35530.3 37887.4 39428.2 10029.6 10537.2 10542.3 10567.9 10726.5 11000.7 11032.6 11099.4 11139.2 11200.2 10457.7 10482.7 10597.5 10687.4 10705.9 10712.5 10961.2 11107.1 11391.7 11412.3 10046.9 10216.4 10303.1 10584.6 10805.9 8336.3 8870.2 8895.7 9100.3 9225.7 9188.4 9342.6 9383.0 9449.8 9644.8 03:49:31 INFO - PROCESS | 5187 | -------- Summary: end -------- 03:49:31 INFO - PROCESS | 5187 | 03:49:32 INFO - TEST-INFO | 5187: exit 0 03:49:32 INFO - TEST-OK | dromaeo_css | took 1115308ms 03:49:32 INFO - TEST-START | kraken 03:49:32 INFO - operating with platform_type : linux_ 03:49:32 INFO - Initialising browser for kraken test... 03:49:32 INFO - TEST-INFO | started process 5421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAIb2ae/profile http://localhost:50509/getInfo.html) 03:49:36 INFO - PROCESS | 5421 | 03:49:36 INFO - PROCESS | 5421 | (process:5490): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:49:37 INFO - PROCESS | 5421 | __metrics Screen width/height:1600/1200 03:49:37 INFO - PROCESS | 5421 | colorDepth:24 03:49:37 INFO - PROCESS | 5421 | Browser inner width/height: 1024/697 03:49:37 INFO - PROCESS | 5421 | __metrics 03:49:38 ERROR - PROCESS | 5421 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 03:49:39 INFO - TEST-INFO | 5421: exit 0 03:49:39 INFO - Browser initialized. 03:49:39 INFO - Running cycle 1/1 for kraken test... 03:49:39 INFO - TEST-INFO | started process 5543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAIb2ae/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:41 INFO - PROCESS | 5543 | 03:49:41 INFO - PROCESS | 5543 | (process:5607): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:49:51 INFO - PROCESS | 5543 | RSS: Main: 165879808 03:49:51 INFO - PROCESS | 5543 | 03:49:53 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:50509/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50509/tests/kraken/driver.html?testName=audio-beat-detection) 03:49:54 INFO - PROCESS | 5543 | RSS: Main: 169762816 03:49:54 INFO - PROCESS | 5543 | 03:49:57 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:50509/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50509/tests/kraken/driver.html?testName=audio-dft) 03:49:57 INFO - PROCESS | 5543 | RSS: Main: 170967040 03:49:57 INFO - PROCESS | 5543 | 03:50:00 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:50509/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50509/tests/kraken/driver.html?testName=audio-fft) 03:50:01 INFO - PROCESS | 5543 | RSS: Main: 165122048 03:50:01 INFO - PROCESS | 5543 | 03:50:03 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:50509/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50509/tests/kraken/driver.html?testName=audio-oscillator) 03:50:03 INFO - PROCESS | 5543 | RSS: Main: 165728256 03:50:03 INFO - PROCESS | 5543 | 03:50:06 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:50509/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50509/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:06 INFO - PROCESS | 5543 | RSS: Main: 167202816 03:50:06 INFO - PROCESS | 5543 | 03:50:09 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:50509/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50509/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:10 INFO - PROCESS | 5543 | RSS: Main: 168300544 03:50:10 INFO - PROCESS | 5543 | 03:50:14 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:50509/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50509/tests/kraken/driver.html?testName=imaging-desaturate) 03:50:14 INFO - PROCESS | 5543 | RSS: Main: 168513536 03:50:14 INFO - PROCESS | 5543 | 03:50:17 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:50509/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50509/tests/kraken/driver.html?testName=json-parse-financial) 03:50:18 INFO - PROCESS | 5543 | RSS: Main: 168964096 03:50:18 INFO - PROCESS | 5543 | 03:50:20 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:50509/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50509/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:50:20 INFO - PROCESS | 5543 | RSS: Main: 167768064 03:50:20 INFO - PROCESS | 5543 | 03:50:22 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:50509/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50509/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:50:23 INFO - PROCESS | 5543 | RSS: Main: 168722432 03:50:23 INFO - PROCESS | 5543 | 03:50:25 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:50509/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50509/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:50:26 INFO - PROCESS | 5543 | RSS: Main: 168693760 03:50:26 INFO - PROCESS | 5543 | 03:50:28 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:50509/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:50:29 INFO - PROCESS | 5543 | RSS: Main: 169181184 03:50:29 INFO - PROCESS | 5543 | 03:50:32 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:50509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:50:32 INFO - PROCESS | 5543 | RSS: Main: 168730624 03:50:32 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:50509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50509/tests/kraken/driver.html?testName=ai-astar) 03:50:34 INFO - PROCESS | 5543 | RSS: Main: 169918464 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | __start_tp_report 03:50:34 INFO - PROCESS | 5543 | _x_x_mozilla_page_load 03:50:34 INFO - PROCESS | 5543 | _x_x_mozilla_page_load_details 03:50:34 INFO - PROCESS | 5543 | |i|pagename|runs| 03:50:34 INFO - PROCESS | 5543 | |0;ai-astar;118;113;115;115;117;127;116;114;115;115 03:50:34 INFO - PROCESS | 5543 | |1;audio-beat-detection;162;133;154;170;137;152;153;134;172;134 03:50:34 INFO - PROCESS | 5543 | |2;audio-dft;164;163;163;164;164;176;163;163;165;161 03:50:34 INFO - PROCESS | 5543 | |3;audio-fft;74;75;75;74;74;74;73;133;74;77 03:50:34 INFO - PROCESS | 5543 | |4;audio-oscillator;95;96;133;96;96;94;140;96;94;143 03:50:34 INFO - PROCESS | 5543 | |5;imaging-gaussian-blur;117;118;118;118;118;119;117;117;118;119 03:50:34 INFO - PROCESS | 5543 | |6;imaging-darkroom;148;151;147;147;147;148;147;147;148;147 03:50:34 INFO - PROCESS | 5543 | |7;imaging-desaturate;97;97;97;97;96;97;96;96;96;97 03:50:34 INFO - PROCESS | 5543 | |8;json-parse-financial;71;66;67;68;67;67;69;67;67;68 03:50:34 INFO - PROCESS | 5543 | |9;json-stringify-tinderbox;68;70;70;70;69;70;70;70;69;70 03:50:34 INFO - PROCESS | 5543 | |10;stanford-crypto-aes;93;92;85;86;85;85;85;85;84;89 03:50:34 INFO - PROCESS | 5543 | |11;stanford-crypto-ccm;121;120;122;120;133;125;130;133;123;129 03:50:34 INFO - PROCESS | 5543 | |12;stanford-crypto-pbkdf2;141;153;155;154;155;139;150;153;164;139 03:50:34 INFO - PROCESS | 5543 | |13;stanford-crypto-sha256-iterative;72;72;73;72;73;71;83;72;73;71 03:50:34 INFO - PROCESS | 5543 | __end_tp_report 03:50:34 INFO - PROCESS | 5543 | __start_cc_report 03:50:34 INFO - PROCESS | 5543 | _x_x_mozilla_cycle_collect,913 03:50:34 INFO - PROCESS | 5543 | __end_cc_report 03:50:34 INFO - PROCESS | 5543 | __startTimestamp1457697034661__endTimestamp 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | ------- Summary: start ------- 03:50:34 INFO - PROCESS | 5543 | Number of tests: 14 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | [#0] ai-astar Cycles:10 Average:116.50 Median:115.50 stddev:3.95 (3.4%) stddev-sans-first:4.15 03:50:34 INFO - PROCESS | 5543 | Values: 118.0 113.0 115.0 115.0 117.0 127.0 116.0 114.0 115.0 115.0 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:153.50 stddev:15.01 (9.8%) stddev-sans-first:15.29 03:50:34 INFO - PROCESS | 5543 | Values: 162.0 133.0 154.0 170.0 137.0 152.0 153.0 134.0 172.0 134.0 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:4.14 (2.5%) stddev-sans-first:4.39 03:50:34 INFO - PROCESS | 5543 | Values: 164.0 163.0 163.0 164.0 164.0 176.0 163.0 163.0 165.0 161.0 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | [#3] audio-fft Cycles:10 Average:80.30 Median:74.00 stddev:18.55 (25.1%) stddev-sans-first:19.53 03:50:34 INFO - PROCESS | 5543 | Values: 74.0 75.0 75.0 74.0 74.0 74.0 73.0 133.0 74.0 77.0 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:95.50 stddev:21.11 (22.1%) stddev-sans-first:21.83 03:50:34 INFO - PROCESS | 5543 | Values: 95.0 96.0 133.0 96.0 96.0 94.0 140.0 96.0 94.0 143.0 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 03:50:34 INFO - PROCESS | 5543 | Values: 117.0 118.0 118.0 118.0 118.0 119.0 117.0 117.0 118.0 119.0 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 03:50:34 INFO - PROCESS | 5543 | Values: 148.0 151.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 147.0 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:50:34 INFO - PROCESS | 5543 | Values: 97.0 97.0 97.0 97.0 96.0 97.0 96.0 96.0 96.0 97.0 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:67.50 stddev:1.42 (2.1%) stddev-sans-first:0.87 03:50:34 INFO - PROCESS | 5543 | Values: 71.0 66.0 67.0 68.0 67.0 67.0 69.0 67.0 67.0 68.0 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.70 (1.0%) stddev-sans-first:0.44 03:50:34 INFO - PROCESS | 5543 | Values: 68.0 70.0 70.0 70.0 69.0 70.0 70.0 70.0 69.0 70.0 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:85.50 stddev:3.25 (3.8%) stddev-sans-first:2.59 03:50:34 INFO - PROCESS | 5543 | Values: 93.0 92.0 85.0 86.0 85.0 85.0 85.0 85.0 84.0 89.0 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:127.00 stddev:5.21 (4.1%) stddev-sans-first:5.25 03:50:34 INFO - PROCESS | 5543 | Values: 121.0 120.0 122.0 120.0 133.0 125.0 130.0 133.0 123.0 129.0 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:153.50 stddev:8.18 (5.3%) stddev-sans-first:7.95 03:50:34 INFO - PROCESS | 5543 | Values: 141.0 153.0 155.0 154.0 155.0 139.0 150.0 153.0 164.0 139.0 03:50:34 INFO - PROCESS | 5543 | 03:50:34 INFO - PROCESS | 5543 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:72.50 stddev:3.52 (4.9%) stddev-sans-first:3.71 03:50:34 INFO - PROCESS | 5543 | Values: 72.0 72.0 73.0 72.0 73.0 71.0 83.0 72.0 73.0 71.0 03:50:34 INFO - PROCESS | 5543 | -------- Summary: end -------- 03:50:34 INFO - PROCESS | 5543 | 03:50:35 INFO - TEST-INFO | 5543: exit 0 03:50:35 INFO - TEST-OK | kraken | took 63357ms 03:50:35 INFO - SUITE-END | took 1178s 03:50:35 INFO - Completed test suite (00:19:38) 03:50:35 INFO - javascript benchmark 03:50:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2586.1724248240557, 2634.5257853586354, 2652.6286319915203, 2680.236132702179, 2684.4765270772195, 4518.751468669226, 4573.245414506607, 4584.656150788692, 4610.654200934927, 4623.260278355464, 4463.933041004379, 4560.4527456705155, 4578.130155270496, 4614.676972611918, 4638.4665763437215, 4188.392683060954, 4193.43388642534, 4241.4274073000215, 4245.851395201169, 4292.484901811771, 4200.264953633117, 4220.472440944882, 4247.320428731404, 4257.87226383209, 4299.226139294926, 4156.4181014657825, 4198.517170525398, 4218.240716670998, 4235.407043013981, 4246.723962942398, 4216.810243539048, 4223.97888010561, 4229.217594744982, 4245.87262382129, 4264.147170565868, 4043.0, 4141.254574176647, 4212.220739163234, 4215.725977811432, 4238.08881090564, 4454.265046267395, 4475.619572336355, 4479.73121612701, 4532.9320060199125, 4533.455985281787, 4804.711717296938, 4811.278308253755, 4838.346823178861, 4846.369971903665, 4860.198067318888, 4829.9275510867365, 4865.099956508057, 4869.659123861331, 4892.926606100911, 4981.352424184833, 4552.499225085238, 4557.886052848706, 4560.9771951140365, 4587.197240482936, 4608.493065762764, 5015.04714104319, 5018.096742586369, 5018.974905125524, 5024.346834911511, 5069.290299358093, 4676.18166820805, 4798.640101992364, 4845.345878306454, 4863.0, 4871.391076115486, 4689.249720044776, 4791.928121078186, 4853.247746599212, 4862.465128835825, 4952.603791696728, 4826.300186472942, 4840.540148685869, 4846.055019271279, 4854.271859221074, 4890.510948905152, 4672.976635116803, 4752.667313288106, 4767.547083027107, 4852.296417019513, 4890.657653964259, 4039.5960403959957, 4041.7170798044444, 4053.6757059435176, 4074.1444296698023, 4078.163976384834, 3575.249197668467, 3577.69589584883, 3595.5617752899047, 3610.2959922815326, 3612.9277414451562, 4149.8962525937095, 4156.355764856452, 4219.599138081878, 4223.155368926227, 4282.186384586918, 4839.346688197048, 4868.318435419044, 4882.853514394574, 4887.608991280689, 4918.5573298403315, 4203.70574059819, 4226.112516371596, 4237.766922819213, 4241.384999175102, 4289.1207302503535, 4270.807813648331, 4345.782710864444, 4381.9342709859375, 4397.450318710161, 4418.469783625921, 4605.332226827091, 4612.215923293115, 4620.8151673933335, 4624.398828152319, 4674.275487299474, 4736.928946065881, 4898.990652717966, 4917.655764096479, 4918.95081049185, 4919.2129259318335, 4596.195665758412, 4606.378138951332, 4616.376789133424, 4662.160811054043, 4663.836765713184, 4779.211430114131, 4796.904061918673, 4814.301926220608, 4818.590419814355, 4856.732879691651, 4769.546893045155, 4839.612830973584, 4880.463149053672, 4900.95099049005, 4906.0, 4675.812967481399, 4716.339712440193, 4731.763411829464, 4748.857534273978, 4810.062037902715, 4757.690750101232, 4767.952320476751, 4769.976150119227, 4770.284457331428, 4820.68665536739, 4553.089382123522, 4664.743439110882, 4683.758803916897, 4702.106599746037, 4752.0, 4731.266653668687, 4787.3776409068, 4789.1858384075485, 4821.831235906727, 4834.806607735652, 4534.727916325031, 4570.108828778356, 4618.191816432044, 4618.4919658836825, 4672.065586882705], "unit": "score", "name": "dojo.html", "value": 4478.945194618581}, {"lowerIsBetter": false, "replicates": [481.03312342192186, 488.12869028783626, 541.8103663717699, 543.9428859969703, 554.4898693202254, 32971.175720606996, 33045.33909321812, 33362.0, 33435.331293374176, 33445.83277083614, 36818.26363472729, 37233.44149837755, 37419.25161496768, 37433.25133497328, 37490.250194996086, 7685.615719214031, 7805.765827025199, 7823.10034346049, 7842.607869606497, 7887.763367098996, 7713.6914523419, 7719.575423351714, 7802.141764405911, 7974.082980457264, 7984.321332686729, 7955.602219889011, 8005.959970200141, 8019.759407217793, 8036.8392632147325, 8045.396595255379, 7948.2051794820345, 8003.879941800848, 8017.118117007125, 8032.1164671886045, 8042.115367309591, 7891.842163156704, 8016.438849280553, 8018.6391612377, 8024.478408903403, 8044.517328960281, 36721.081972950626, 37155.814220928994, 37391.0, 37499.0, 37510.8124459376, 2275.7155355580553, 2779.374640705845, 2839.900603478868, 2873.813202141875, 3163.9525407118913, 24349.63475547868, 24775.132870349633, 24816.5036699265, 25225.87387063053, 25460.618090728654, 3259.869605215812, 3268.4933835255574, 3279.797462310198, 3310.619278782947, 3412.2493051528622, 141500.0, 142317.2884135583, 142647.28676356655, 142912.0, 142993.0, 51134.0, 51153.48846511562, 51509.227361589605, 51549.0, 51717.0, 60483.09275360873, 60848.08727869086, 60919.69540152271, 61476.69261653663, 61519.077213841825, 13111.344432778324, 13114.737705245841, 13225.27261000635, 13254.40355184019, 13285.468581256642, 11305.71735706614, 11306.434678266054, 11320.207585468937, 11342.829857552144, 11350.602728904449, 19352.612947740967, 19524.12141453638, 19582.804171958098, 19600.509987250432, 19626.21495140207, 7827.608619569112, 7962.3630109591095, 8062.475939063942, 8102.959485202537, 8236.258736713724, 776.8213310938515, 856.648774002656, 972.6158167523788, 1043.6555936540924, 1062.7024433158729, 26394.208173754818, 26571.73428265731, 26606.46787064248, 26688.59967100495, 26868.0, 904.615538396179, 940.9623615055458, 976.5800705696477, 994.6717583197527, 1014.0619926567895, 13430.836440703413, 13600.183988960694, 13907.513237036655, 14127.594463819074, 14248.216348100954, 264047.0, 265633.0, 266130.0, 267656.0, 268320.0, 45252.54747452549, 45781.0, 45846.77076614596, 45935.0, 45990.770046149555, 1194.7789658912955, 1196.629044996054, 1212.1575505023923, 1215.5563219425023, 1238.721287710258, 25155.87422062878, 25729.356766080247, 26248.60627090557, 26378.86810565935, 26439.471210575295, 35395.82302088473, 35492.46761298531, 35531.28937421289, 35585.82207088948, 35855.0, 248459.0, 249095.0, 249333.0, 249538.0, 251084.0, 29459.11622651324, 29715.0, 30320.241993950327, 30336.84831575828, 30421.391572168875, 39152.80423597864, 39429.408558871066, 39616.60383396129, 39652.2069558613, 40009.399859001554, 33904.0, 34134.65865341414, 34136.0, 34160.14599635029, 34207.0, 33335.33329333351, 33612.327753445286, 33743.49384759182, 34303.65696343104, 34639.4804077934, 27738.861305693343, 33031.33937321288, 33463.33073338471, 34081.0, 34480.31039379148, 26739.0, 26808.463830722885, 26899.86550067237, 26933.326666833487, 27751.722482774912, 22768.20311289097, 22879.31362059141, 23224.767752322936, 23342.0, 23433.648495272242], "unit": "score", "name": "ext.html", "value": 16436.96003310682}, {"lowerIsBetter": false, "replicates": [302.80923018498345, 314.910250578585, 318.32991552781385, 324.3852898756857, 329.7016200338693, 11538.192326537124, 14757.852421475796, 15344.156071416082, 15397.690346448024, 15541.0, 14750.26248687564, 15013.249337533107, 15093.92453037736, 15149.772753408708, 15297.388104475835, 4744.525547445253, 4918.262260660912, 4951.331570238008, 4973.0551195272965, 4989.2017277235645, 4746.596539294164, 4862.367892174012, 4916.385451818523, 4926.655134140611, 4949.950500494985, 4955.752212389384, 4962.379702537183, 4968.056069346812, 4997.60019198465, 4997.750112494379, 4920.532549407801, 4954.207326827726, 4960.479149689285, 4962.627802914778, 4968.925466117993, 4763.095011947719, 4957.03337849116, 4972.0, 4981.5267549583095, 4999.8000079996755, 12044.638660840188, 12284.324362160078, 15325.46360877364, 19480.0, 19544.413667589994, 1783.7146056630877, 1845.0682405385328, 1865.4590168851016, 1875.5779949511386, 2343.3790045637747, 8754.255888249507, 8925.955370223108, 9148.222401095914, 11916.642500724993, 11927.866852648984, 1732.8786984911062, 1757.8593712503098, 1761.4803632928317, 1780.6794776940146, 1832.1938347127355, 41250.38124428136, 48726.51273487255, 48958.51041489611, 54707.179392309146, 60420.0, 9336.673216437392, 9464.722262494613, 9665.420074795535, 9687.70936871895, 9842.065003824626, 12223.08326875488, 12229.205101668364, 12321.876781232253, 12352.75294494105, 12376.443060062318, 7184.640767961581, 7201.279872012861, 7236.38490728294, 7329.267073292628, 7396.852062958818, 7036.859262814715, 7163.641817909083, 7167.3549380556, 7215.747448839265, 7339.926600734031, 3825.2731980923536, 3854.325493038707, 3873.61263873616, 3902.083010492532, 3903.2193561287854, 1667.3080671521425, 1737.7480265361705, 1744.1017875793975, 1747.5281673948218, 1767.0457952705651, 821.2444551013082, 845.2984023260678, 862.4911302331654, 876.3033388456192, 930.5347326336831, 15495.612609684847, 15718.528444146694, 15725.370985160695, 15850.286737096858, 15933.521994340188, 820.8071103290722, 850.3452341696982, 855.153398135841, 908.1327332397544, 947.4930911962205, 8808.295336373203, 9062.909370906338, 9069.002409735056, 9090.909090909006, 9305.674301399418, 359945.0, 361720.0, 366475.1676241655, 366849.0, 370123.0, 65663.67168164128, 65703.34296657068, 67231.0, 67742.32257677459, 68144.0, 852.5609311204735, 885.349268287808, 887.0287035695902, 908.9227415669742, 914.9725508234764, 13807.51673691416, 13837.446502139801, 13935.651608709863, 13936.4425422986, 14313.785293220819, 28782.280442989093, 30509.847450763493, 31902.202444939063, 32208.516872247405, 32409.675903240666, 42332.788336058125, 42384.0, 42638.78680606577, 42659.36010959776, 42833.35749963815, 7134.857302854018, 7223.386012189023, 7287.344139027301, 7323.7436689715605, 7324.560526368435, 8164.469309494863, 10542.894571054192, 10749.570017199225, 10985.0, 11244.60643877493, 9283.071692830663, 9390.154886060287, 9442.575084121368, 9470.337076404585, 9710.22318214527, 9150.954245228997, 9442.622295108118, 9487.857682134912, 9650.276229282692, 9658.517074146404, 9446.574904129468, 9474.763130921781, 9619.5671194795, 9719.319647624598, 9842.114209720872, 7228.63856807147, 7263.201047884834, 7317.634118294171, 7324.377427918686, 7529.774106776806, 8286.171382861665, 9116.544172791466, 9124.31567632417, 9152.725418237464, 9536.809263814823], "unit": "score", "name": "jquery.html", "value": 7569.038805033024}, {"lowerIsBetter": false, "replicates": [1351.9797203041953, 1369.1100784490084, 1476.23235917323, 1671.2479384277078, 1690.7886514185718, 6311.147995020671, 7024.121984751906, 7074.39867611253, 7292.708291668334, 7340.632968351581, 7055.823604409879, 7198.640067996593, 7204.495685302031, 7227.783166505, 7244.0, 2075.9065842037107, 2102.8212601928853, 2104.884231367274, 2105.221068204766, 2107.283523601975, 2082.804923535994, 2085.3222702621633, 2092.246791155183, 2098.3390232076845, 2123.278085450954, 2087.332053742803, 2088.6449303618347, 2092.7697953225133, 2098.7271654684946, 2133.8263954824783, 2100.2019232691478, 2105.663093904968, 2122.5224324526935, 2123.4479035450818, 2127.0322003488454, 2017.183040868436, 2021.4542073640034, 2025.4227545149708, 2040.8877511736848, 2041.7345745053196, 7227.747028854017, 7332.120145582511, 7336.816579585499, 7337.816554586125, 7355.080614923135, 4149.91700165995, 4248.1078973415315, 4252.425922500484, 4263.808128634188, 4275.636570891478, 2722.618833363331, 2773.1126039667315, 2789.232960935759, 2849.0455697341417, 2857.7568757590307, 913.2283220678516, 922.8523436250168, 936.293098710476, 941.181172380027, 947.7725345916999, 9583.0, 9584.808303833954, 9610.615575376976, 9686.854697179548, 9725.708228753148, 3824.0, 3947.546032206333, 3952.782596957195, 4003.219372222447, 4009.7393669411395, 8321.958390208132, 8345.998480182296, 8374.204450577185, 8388.538630375388, 8396.0, 4360.389545463638, 4362.8691139265875, 4374.518802931675, 4381.627561657231, 4383.49589797171, 3381.458966565338, 3878.166194268246, 3951.9604803952166, 3968.8809335719975, 3972.3644216925154, 3297.0603378037144, 3351.2794749129052, 3358.177246574605, 3385.9830700846337, 3387.9836049185146, 1058.7564860082225, 1073.592035026685, 1082.826747720361, 1083.8807731149568, 1086.3481910853425, 861.2464093917822, 865.6580650643086, 865.6667183134413, 868.7046404222468, 1091.317926296065, 6847.691853866588, 6865.794026179223, 6878.65606719672, 6890.069840571559, 6904.689288982008, 433.29373121811244, 440.47143427886664, 442.64146041706323, 445.15642856786206, 454.81579960116204, 5237.973810131001, 5269.077911365495, 5271.341082364705, 5284.9735751320995, 5289.920651190235, 8747.256483198998, 8819.647214111365, 8927.375083744206, 8970.327225458117, 8977.326700497359, 8831.205191532792, 8870.467771933705, 8876.600552975131, 8896.332775041898, 8906.86639700405, 6838.829029274209, 6933.618650974144, 7007.684654190573, 7065.717371305193, 7116.537425067354, 6510.837229069311, 6577.671116444254, 6585.736570537125, 6602.0096985452565, 6607.438367738796, 7792.117299834182, 7826.099998500245, 8120.634571444417, 8129.512229266263, 8200.917990820255, 7646.847063058819, 7744.225577442211, 7807.297343239135, 7854.253845884632, 8307.08622051586, 5325.414204437587, 5815.098659707752, 5819.5053420459735, 5907.734151963258, 5918.822435326947, 6495.188101487314, 6586.901196481961, 6603.240627327918, 6606.43845273138, 6619.470442364695, 5929.9757123866275, 6102.816915492543, 6180.907286390798, 6226.128342032029, 6332.335104813928, 5880.470757631833, 5929.436703513159, 6044.879102418015, 6098.268207814913, 6101.054336577838, 6234.937650623617, 6382.712777924911, 6408.070829729756, 6408.807735767934, 6408.807735767934, 5759.827205183851, 5826.359100499027, 5841.211436456024, 5857.4435428634215, 5878.353381127987, 5838.416158384298, 5861.9706901465215, 5911.113333000085, 6056.333803281724, 6091.451769340781], "unit": "score", "name": "mootools.html", "value": 4004.3130552907064}, {"lowerIsBetter": false, "replicates": [301.47242325929625, 306.03598664207755, 307.1997446651473, 307.403636944328, 308.7283190792103, 5498.615096943216, 5585.972070139649, 5591.384947655754, 5661.773529058843, 5682.772689092441, 5496.615236933416, 5558.471945165213, 5559.749811258493, 5634.0, 5649.774009039644, 4021.7989100545, 4183.979080104596, 4252.128313695685, 4267.359896015607, 4303.24693178694, 4266.146770645868, 4280.3793449949735, 4284.078923031548, 4288.914221715564, 4293.527711951699, 4240.957590424103, 4242.406063151161, 4244.129953359554, 4252.936205956913, 4323.4163387942535, 4329.783510824446, 4335.804888780012, 4338.132373525307, 4338.392625032498, 4350.12997400518, 3800.923981520382, 3821.7706937583557, 3824.1204522959597, 3828.1195325075387, 3831.080540670247, 5395.514403703646, 5424.1321388577635, 5426.294581704393, 5427.023135835548, 5433.347998240197, 4880.511948805127, 4965.230389289666, 4977.800887964477, 4993.051320249141, 4993.101241776479, 5815.069588865761, 5845.09401042839, 5866.384029676865, 5872.17789509469, 5875.030619947704, 4105.096878686684, 4113.4035564843225, 4114.280000999843, 4115.567865374122, 4135.338345864678, 6075.665838378887, 6186.597871138361, 6196.256449226076, 6227.221597300338, 6227.283862355842, 4219.0507135894795, 4221.852235171816, 4223.408722778813, 4231.132617813341, 4243.405923170759, 4289.892752681208, 4298.957010429918, 4320.243957307459, 4326.870193894189, 4332.393464914914, 4698.060387922361, 4864.270359446112, 4916.115099282092, 4942.950570494249, 4950.356453661001, 5812.186293918855, 5854.975379308604, 5878.500327472213, 5878.941210587839, 5882.323532793698, 1454.7308747881464, 1499.6475828180369, 1501.4519700309309, 1503.0680977793838, 1505.0217358716923, 1028.0644613401769, 1031.886492485826, 1046.1055797293204, 1059.9894001060045, 1068.6046162919613, 5066.847994560169, 5078.619103567174, 5090.949090509122, 5101.387833459934, 5105.0, 6050.727717252734, 6080.513558915276, 6095.634261944298, 6098.390160983955, 6102.572819902564, 4887.169181239198, 5064.544191022752, 5068.113080210948, 5075.0, 5098.923516147261, 3197.7761556690807, 3281.4585593376823, 3298.6701329866823, 3300.0924745695124, 3304.686054824788, 5700.543956483471, 5716.114002329646, 5717.542596592262, 5732.598718089777, 5738.024535828919, 6253.53098517613, 6261.373862613702, 6273.498120150468, 6292.968535157295, 6298.496120310364, 5674.2623458950075, 5718.199452076629, 5718.228039214736, 5719.885602287931, 5730.255066841284, 5816.41835816415, 5953.166556682155, 5996.130561068708, 6082.817515474366, 6151.0773383992755, 6006.33930267679, 6014.0, 6017.976943919457, 6025.0, 6029.78895738647, 5730.484256416776, 5741.25363702716, 5797.449242321973, 5806.6806325650805, 5815.273090863642, 4229.851955181677, 4264.488261408651, 4265.253580623441, 4269.444972153724, 4271.444712187395, 5842.415758424124, 6090.116933044772, 6108.541859360655, 6122.755089796358, 6125.601835880653, 5670.09278515452, 5711.0, 5802.564807639528, 5810.883782324246, 5815.912761308499, 5798.739056742373, 5809.50619197373, 5867.383924687846, 5887.970560147171, 5900.232969713909, 5717.542596592346, 5769.79805706815, 5771.451712087345, 5779.479846813807, 5793.91309130355, 5890.617109887844, 5901.527877769854, 5922.1412895130825, 5924.437178468039, 5946.910796338145, 5469.15228139639, 5630.549556035426, 5652.5477961762135, 5705.857353566194, 5739.684317362585], "unit": "score", "name": "prototype.html", "value": 4400.137439093108}, {"lowerIsBetter": false, "replicates": [752.2252080357232, 753.2919056087275, 755.2900273742681, 758.0713625808386, 762.7597306848343, 11585.0, 11762.823557646641, 11788.29270243785, 11810.940945295282, 11858.288502689833, 11251.662450126489, 11602.245854019482, 11652.592159274427, 11764.882351176486, 11806.468708908098, 773.640257280366, 791.0, 793.8610743119959, 794.3327604811985, 796.1322158846856, 797.8125140591957, 800.8918795962558, 805.1827395193883, 805.375833728859, 806.4919100966413, 831.78789408701, 832.1553623072587, 834.3200291762195, 834.8580741273968, 836.640244694781, 824.2458150792048, 829.6432534010373, 830.6054624053587, 832.305025303872, 832.7751507093111, 608.9147519347295, 610.7099127914249, 613.5030625193563, 613.923259592551, 616.6515918506029, 11059.059979901638, 11091.83362249567, 11101.167412444018, 11150.60972865954, 11154.832677509843, 9889.307748457612, 10376.429296388696, 10479.94760026195, 10516.316439431488, 10532.947335263274, 8847.513386763725, 9008.189262966365, 9020.233280171193, 9221.400608960463, 9238.722838314861, 3117.392108538836, 3130.139211716796, 3161.731252843511, 3181.1569933967517, 3194.0417874637747, 38234.80882595569, 38845.41731873996, 38893.61106388928, 39083.80458097691, 40490.0, 9544.95227523858, 9597.760055998657, 9615.855762163434, 9638.75903102414, 9707.126358627616, 15678.843211567966, 15688.372465101496, 15720.60698482547, 15812.130332831804, 15814.051156930622, 6486.156799616019, 6548.869022619521, 6571.3757193066585, 6584.736610535525, 6624.7681331154145, 3649.726270529668, 3706.369917114097, 3715.925681486355, 3722.739408241451, 3730.0488375464624, 2711.1324376199427, 2728.3451971526692, 2738.602902579115, 2742.040285899959, 2746.231055304518, 507.3556583139392, 514.1028904561564, 514.8532668189548, 514.9716765577854, 520.3755493407925, 491.8819483324048, 540.2301720048914, 547.8383876756367, 560.5375565158761, 633.0788702437942, 7673.309402153722, 7737.5744334062165, 7854.60726963661, 8080.636371363303, 8139.226773456512, 562.131506821961, 578.6470253145578, 588.632104934416, 593.2969431224013, 604.4016423740466, 3605.188832512664, 3704.8518059277867, 3721.9441708374397, 3724.329620668306, 3765.1151979284846, 42462.78768606137, 47751.5224847754, 48238.51761482411, 48289.27566086512, 48317.0, 41371.0, 42589.57410425856, 42675.0, 43220.0, 43232.56767432348, 36989.815050924575, 37488.25023499515, 38150.61849381526, 39312.410313845314, 39348.0, 7701.80745481345, 7901.565413902291, 7939.166387529226, 8144.55204963709, 8172.387070969582, 30584.541231881984, 30915.536266955565, 31360.843195783877, 31849.36301273915, 31871.36257274888, 35418.29163416666, 35471.0, 35530.28939421249, 37887.43168852414, 39428.2114357717, 10029.648962286285, 10537.157027437634, 10542.262041657317, 10567.89432105669, 10726.463676816284, 11000.669979900616, 11032.558697652325, 11099.445027748741, 11139.164562657996, 11200.159988000769, 10457.738556536147, 10482.68551943443, 10597.523111460157, 10687.412192329186, 10705.9464702676, 10712.517936692711, 10961.177911656498, 11107.111431085332, 11391.715207119889, 11412.31526108436, 10046.899531004889, 10216.438095904796, 10303.124234440156, 10584.629537966135, 10805.891941080488, 8336.333093352396, 8870.246029087342, 8895.688650897187, 9100.271978241857, 9225.677101301422, 9188.40275382098, 9342.579583918605, 9383.0, 9449.795173432933, 9644.807103858024], "unit": "score", "name": "yui.html", "value": 5685.669947521235}], "name": "dromaeo_css", "value": 6182.196158593268}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [118.0, 113.0, 115.0, 115.0, 117.0, 127.0, 116.0, 114.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.5}, {"lowerIsBetter": true, "replicates": [162.0, 133.0, 154.0, 170.0, 137.0, 152.0, 153.0, 134.0, 172.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 163.0, 164.0, 164.0, 176.0, 163.0, 163.0, 165.0, 161.0], "unit": "score", "name": "audio-dft", "value": 164.6}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 75.0, 74.0, 74.0, 74.0, 73.0, 133.0, 74.0, 77.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 133.0, 96.0, 96.0, 94.0, 140.0, 96.0, 94.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 117.0, 117.0, 118.0, 119.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.9}, {"lowerIsBetter": true, "replicates": [148.0, 151.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [71.0, 66.0, 67.0, 68.0, 67.0, 67.0, 69.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 67.7}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 70.0, 70.0, 69.0, 70.0, 70.0, 70.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 85.0, 86.0, 85.0, 85.0, 85.0, 85.0, 84.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [121.0, 120.0, 122.0, 120.0, 133.0, 125.0, 130.0, 133.0, 123.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.6}, {"lowerIsBetter": true, "replicates": [141.0, 153.0, 155.0, 154.0, 155.0, 139.0, 150.0, 153.0, 164.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 72.0, 73.0, 71.0, 83.0, 72.0, 73.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.2}], "name": "kraken", "value": 1555.3}]} 03:50:35 INFO - Return code: 0 03:50:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:50:35 ERROR - # TBPL SUCCESS # 03:50:35 INFO - Running post-action listener: _resource_record_post_action 03:50:35 INFO - Running post-run listener: _resource_record_post_run 03:50:37 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 530960384; Read time: 0; Write time: 747612 03:50:37 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 243134464; Read time: 0; Write time: 411336 03:50:37 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287825920; Read time: 0; Write time: 336276 03:50:37 INFO - Running post-run listener: _upload_blobber_files 03:50:37 INFO - Blob upload gear active. 03:50:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:50:37 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 03:50:37 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'] 03:50:37 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 03:50:37 INFO - (blobuploader) - INFO - Open directory for files ... 03:50:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:50:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:50:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:38 INFO - (blobuploader) - INFO - Done attempting. 03:50:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:50:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:50:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:38 INFO - (blobuploader) - INFO - Done attempting. 03:50:38 INFO - (blobuploader) - INFO - Iteration through files over. 03:50:38 INFO - Return code: 0 03:50:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:50:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:50:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99a67634204a51d5ef3067a71ab64b0321a977fb6181432ff74d9ae3008086da50cf018b6eca3afd81fb34ee40e18d8cc9d3b4e572f8c94de59ca01db48d20c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d92db03209524cbbe10d9101ea358b7b56ea426b9ed89f2b32b15aed16ef6e0a23f95281e875e25347aaccf2e968d8f74efbf53f0d8b8b3b10dee4d69a193c7"} 03:50:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:50:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:50:38 INFO - Contents: 03:50:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99a67634204a51d5ef3067a71ab64b0321a977fb6181432ff74d9ae3008086da50cf018b6eca3afd81fb34ee40e18d8cc9d3b4e572f8c94de59ca01db48d20c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d92db03209524cbbe10d9101ea358b7b56ea426b9ed89f2b32b15aed16ef6e0a23f95281e875e25347aaccf2e968d8f74efbf53f0d8b8b3b10dee4d69a193c7"} 03:50:38 INFO - Running post-run listener: copy_logs_to_upload_dir 03:50:38 INFO - Copying logs to upload dir... 03:50:38 INFO - mkdir: /builds/slave/test/build/upload/logs 03:50:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.451329 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-11 03:50:38.710122) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 03:50:38.713678) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99a67634204a51d5ef3067a71ab64b0321a977fb6181432ff74d9ae3008086da50cf018b6eca3afd81fb34ee40e18d8cc9d3b4e572f8c94de59ca01db48d20c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d92db03209524cbbe10d9101ea358b7b56ea426b9ed89f2b32b15aed16ef6e0a23f95281e875e25347aaccf2e968d8f74efbf53f0d8b8b3b10dee4d69a193c7"} build_url:https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011454 build_url: 'https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99a67634204a51d5ef3067a71ab64b0321a977fb6181432ff74d9ae3008086da50cf018b6eca3afd81fb34ee40e18d8cc9d3b4e572f8c94de59ca01db48d20c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d92db03209524cbbe10d9101ea358b7b56ea426b9ed89f2b32b15aed16ef6e0a23f95281e875e25347aaccf2e968d8f74efbf53f0d8b8b3b10dee4d69a193c7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 03:50:38.739746) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:50:38.740104) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1457695721.999664-1381134008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:50:38.824602) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 03:50:38.824957) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 03:50:38.825335) ========= ========= Total master_lag: 0.29 =========