builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1457074418.24 results: success (0) buildid: 20160303222325 builduid: c8e5d23b2a5646cb9eb53ec92d99bfbd revision: ce70a1f7c40ebd826378a103617d6a531abbc572 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:38.235931) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:38.236441) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:38.236791) ========= 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-1457073601.591312-543738990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.003099 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:38.268545) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:38.268838) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:38.319040) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:38.319307) ========= 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-1457073601.591312-543738990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002192 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:38.365134) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:38.365468) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:38.365846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:38.366117) ========= 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-1457073601.591312-543738990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-03 22:53:38-- 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% 64.9M=0s 2016-03-03 22:53:38 (64.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:38.522864) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:38.523187) ========= 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-1457073601.591312-543738990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009496 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:38.571008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 22:53:38.571370) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ce70a1f7c40ebd826378a103617d6a531abbc572 --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 ce70a1f7c40ebd826378a103617d6a531abbc572 --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-1457073601.591312-543738990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-03 22:53:38,821 truncating revision to first 12 chars 2016-03-03 22:53:38,821 Setting DEBUG logging. 2016-03-03 22:53:38,821 attempt 1/10 2016-03-03 22:53:38,822 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ce70a1f7c40e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 22:53:40,293 unpacking tar archive at: fx-team-ce70a1f7c40e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.729475 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 22:53:40.310720) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:40.311067) ========= echo ce70a1f7c40ebd826378a103617d6a531abbc572 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ce70a1f7c40ebd826378a103617d6a531abbc572'] 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-1457073601.591312-543738990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ce70a1f7c40ebd826378a103617d6a531abbc572 program finished with exit code 0 elapsedTime=0.002350 script_repo_revision: 'ce70a1f7c40ebd826378a103617d6a531abbc572' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:40.359025) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:40.359344) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 22:53:40.365700) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2016-03-03 22:53:40.366012) ========= /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-1457073601.591312-543738990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:53:40 INFO - MultiFileLogger online at 20160303 22:53:40 in /builds/slave/test 22:53:40 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 22:53:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:53:40 INFO - {'append_to_log': False, 22:53:40 INFO - 'base_work_dir': '/builds/slave/test', 22:53:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:53:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:53:40 INFO - 'branch': 'Fx-Team-Non-PGO', 22:53:40 INFO - 'buildbot_json_path': 'buildprops.json', 22:53:40 INFO - 'config_files': ('talos/linux_config.py',), 22:53:40 INFO - 'default_actions': ('clobber', 22:53:40 INFO - 'read-buildbot-config', 22:53:40 INFO - 'download-and-extract', 22:53:40 INFO - 'populate-webroot', 22:53:40 INFO - 'create-virtualenv', 22:53:40 INFO - 'install', 22:53:40 INFO - 'run-tests'), 22:53:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:53:40 INFO - 'download_minidump_stackwalk': True, 22:53:40 INFO - 'download_symbols': 'ondemand', 22:53:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:53:40 INFO - 'tooltool.py': '/tools/tooltool.py', 22:53:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:53:40 INFO - '/tools/misc-python/virtualenv.py')}, 22:53:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:53:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:53:40 INFO - 'installer_path': 'installer.exe', 22:53:40 INFO - 'log_level': 'info', 22:53:40 INFO - 'log_name': 'talos', 22:53:40 INFO - 'log_to_console': True, 22:53:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:53:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:53:40 INFO - 'opt_config_files': (), 22:53:40 INFO - 'pip_index': False, 22:53:40 INFO - 'sps_profile': False, 22:53:40 INFO - 'sps_profile_interval': 0, 22:53:40 INFO - 'suite': 'dromaeojs-e10s', 22:53:40 INFO - 'system_bits': '32', 22:53:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:53:40 INFO - 'title': 'talos-linux64-ix-019', 22:53:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:53:40 INFO - 'use_talos_json': True, 22:53:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:53:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:53:40 INFO - 'work_dir': 'build'} 22:53:40 INFO - ##### 22:53:40 INFO - ##### Running clobber step. 22:53:40 INFO - ##### 22:53:40 INFO - Running pre-action listener: _resource_record_pre_action 22:53:40 INFO - Running main action method: clobber 22:53:40 INFO - rmtree: /builds/slave/test/build 22:53:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:53:41 INFO - Running post-action listener: _resource_record_post_action 22:53:41 INFO - ##### 22:53:41 INFO - ##### Running read-buildbot-config step. 22:53:41 INFO - ##### 22:53:41 INFO - Running pre-action listener: _resource_record_pre_action 22:53:41 INFO - Running main action method: read_buildbot_config 22:53:41 INFO - Using buildbot properties: 22:53:41 INFO - { 22:53:41 INFO - "project": "", 22:53:41 INFO - "product": "firefox", 22:53:41 INFO - "script_repo_revision": "production", 22:53:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:53:41 INFO - "repository": "", 22:53:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:53:41 INFO - "buildid": "20160303222325", 22:53:41 INFO - "pgo_build": "False", 22:53:41 INFO - "basedir": "/builds/slave/test", 22:53:41 INFO - "buildnumber": 956, 22:53:41 INFO - "slavename": "talos-linux64-ix-019", 22:53:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:53:41 INFO - "platform": "ubuntu64_hw", 22:53:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:53:41 INFO - "branch": "fx-team", 22:53:41 INFO - "repo_path": "integration/fx-team", 22:53:41 INFO - "revision": "ce70a1f7c40ebd826378a103617d6a531abbc572", 22:53:41 INFO - "stage_platform": "linux64", 22:53:41 INFO - "builduid": "c8e5d23b2a5646cb9eb53ec92d99bfbd", 22:53:41 INFO - "slavebuilddir": "test" 22:53:41 INFO - } 22:53:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:53:41 INFO - Running post-action listener: _resource_record_post_action 22:53:41 INFO - ##### 22:53:41 INFO - ##### Running download-and-extract step. 22:53:41 INFO - ##### 22:53:41 INFO - Running pre-action listener: _resource_record_pre_action 22:53:41 INFO - Running main action method: download_and_extract 22:53:41 INFO - mkdir: /builds/slave/test/build/tests 22:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:41 INFO - https://queue.taskcluster.net/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:53:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 22:53:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 22:53:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 22:53:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:53:43 INFO - Downloaded 1448 bytes. 22:53:43 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 22:53:43 INFO - Using the following test package requirements: 22:53:43 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:43 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:53:43 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:53:43 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'jsshell-linux-x86_64.zip'], 22:53:43 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:53:43 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:43 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:53:43 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:53:43 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:53:43 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:43 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:53:43 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:43 INFO - https://queue.taskcluster.net/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:53:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:53:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:53:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:53:56 INFO - Downloaded 22081101 bytes. 22:53:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:53:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:53:57 INFO - Return code: 0 22:53:57 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:53:57 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')]} 22:53:57 INFO - https://queue.taskcluster.net/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:53:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:53:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:53:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:53:58 INFO - Downloaded 22081101 bytes. 22:53:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:53:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:53:59 INFO - Return code: 0 22:53:59 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')]} 22:53:59 INFO - https://queue.taskcluster.net/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:53:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:54:00 INFO - Downloaded 10808282 bytes. 22:54:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:54:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:54:00 INFO - Return code: 0 22:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:00 INFO - https://queue.taskcluster.net/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:54:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:54:02 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2: [Errno 104] Connection reset by peer 22:54:02 INFO - retry: attempt #1 caught exception: [Errno 104] Connection reset by peer 22:54:02 INFO - retry: Failed, sleeping 30 seconds before retrying 22:54:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #2 22:54:33 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2: [Errno 104] Connection reset by peer 22:54:34 INFO - retry: attempt #2 caught exception: [Errno 104] Connection reset by peer 22:54:34 INFO - retry: Failed, sleeping 60 seconds before retrying 22:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #3 22:55:35 INFO - Downloaded 54352942 bytes. 22:55:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:55:35 INFO - mkdir: /builds/slave/test/properties 22:55:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:55:35 INFO - Writing to file /builds/slave/test/properties/build_url 22:55:35 INFO - Contents: 22:55:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:55:36 INFO - Running post-action listener: _resource_record_post_action 22:55:36 INFO - Running post-action listener: set_extra_try_arguments 22:55:36 INFO - ##### 22:55:36 INFO - ##### Running populate-webroot step. 22:55:36 INFO - ##### 22:55:36 INFO - Running pre-action listener: _resource_record_pre_action 22:55:36 INFO - Running main action method: populate_webroot 22:55:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:55:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:55:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:55:36 INFO - '--tppagecycles', 22:55:36 INFO - '7'], 22:55:36 INFO - 'tests': ['tsvgm']}}, 22:55:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:55:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:55:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:55:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:55:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:55:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:55:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:55:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:36 INFO - 'talos_options': ['--e10s'], 22:55:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:55:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:36 INFO - 'tests': ['damp', 'tps']}, 22:55:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:36 INFO - 'talos_options': ['--e10s'], 22:55:36 INFO - 'tests': ['damp', 'tps']}, 22:55:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:55:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:55:36 INFO - 'other': {'tests': ['a11yr', 22:55:36 INFO - 'ts_paint', 22:55:36 INFO - 'tpaint', 22:55:36 INFO - 'sessionrestore', 22:55:36 INFO - 'sessionrestore_no_auto_restore']}, 22:55:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:55:36 INFO - 'tests': ['a11yr', 22:55:36 INFO - 'ts_paint', 22:55:36 INFO - 'tpaint', 22:55:36 INFO - 'sessionrestore', 22:55:36 INFO - 'sessionrestore_no_auto_restore']}, 22:55:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:55:36 INFO - 'tests': ['a11yr', 22:55:36 INFO - 'ts_paint', 22:55:36 INFO - 'tpaint', 22:55:36 INFO - 'sessionrestore', 22:55:36 INFO - 'sessionrestore_no_auto_restore']}, 22:55:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:55:36 INFO - 'tests': ['a11yr', 22:55:36 INFO - 'ts_paint', 22:55:36 INFO - 'tpaint', 22:55:36 INFO - 'sessionrestore', 22:55:36 INFO - 'sessionrestore_no_auto_restore']}, 22:55:36 INFO - 'other_l64': {'tests': ['a11yr', 22:55:36 INFO - 'ts_paint', 22:55:36 INFO - 'tpaint', 22:55:36 INFO - 'sessionrestore', 22:55:36 INFO - 'sessionrestore_no_auto_restore']}, 22:55:36 INFO - 'other_nol64': {'tests': ['a11yr', 22:55:36 INFO - 'ts_paint', 22:55:36 INFO - 'tpaint', 22:55:36 INFO - 'sessionrestore', 22:55:36 INFO - 'sessionrestore_no_auto_restore']}, 22:55:36 INFO - 'svgr': {'tests': ['tsvgx', 22:55:36 INFO - 'tsvgr_opacity', 22:55:36 INFO - 'tart', 22:55:36 INFO - 'tscrollx', 22:55:36 INFO - 'cart']}, 22:55:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:55:36 INFO - 'tests': ['tsvgx', 22:55:36 INFO - 'tsvgr_opacity', 22:55:36 INFO - 'tart', 22:55:36 INFO - 'tscrollx', 22:55:36 INFO - 'cart']}, 22:55:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:36 INFO - 'tests': ['tp5o']}, 22:55:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:36 INFO - 'talos_options': ['--e10s'], 22:55:36 INFO - 'tests': ['tp5o']}, 22:55:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:36 INFO - 'talos_options': ['--xperf_path', 22:55:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:55:36 INFO - 'tests': ['tp5n']}, 22:55:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:36 INFO - 'talos_options': ['--e10s', 22:55:36 INFO - '--xperf_path', 22:55:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:55:36 INFO - 'tests': ['tp5n']}}, 22:55:36 INFO - 'talos.zip': {'path': '', 22:55:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:55:36 INFO - Running post-action listener: _resource_record_post_action 22:55:36 INFO - ##### 22:55:36 INFO - ##### Running create-virtualenv step. 22:55:36 INFO - ##### 22:55:36 INFO - Running pre-action listener: _resource_record_pre_action 22:55:36 INFO - Running main action method: create_virtualenv 22:55:36 INFO - Creating virtualenv /builds/slave/test/build/venv 22:55:36 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 22:55:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:55:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:55:36 INFO - Using real prefix '/usr' 22:55:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:55:37 INFO - Installing distribute.............................................................................................................................................................................................done. 22:55:39 INFO - Installing pip.................done. 22:55:39 INFO - Return code: 0 22:55:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:39 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 0x7fb389952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c160>, '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 0x230d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d4f0>, '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-1457073601.591312-543738990', '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 22:55:39 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 22:55:39 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 22:55:39 INFO - Using env: {'DISPLAY': ':0', 22:55:39 INFO - 'HOME': '/home/cltbld', 22:55:39 INFO - 'LANG': 'en_US.UTF-8', 22:55:39 INFO - 'LANGUAGE': 'en_US:en', 22:55:39 INFO - 'LOGNAME': 'cltbld', 22:55:39 INFO - 'MAIL': '/var/mail/cltbld', 22:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:39 INFO - 'MOZ_NO_REMOTE': '1', 22:55:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:39 INFO - 'NO_EM_RESTART': '1', 22:55:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:39 INFO - 'PWD': '/builds/slave/test', 22:55:39 INFO - 'SHELL': '/bin/bash', 22:55:39 INFO - 'SHLVL': '1', 22:55:39 INFO - 'TERM': 'linux', 22:55:39 INFO - 'TMOUT': '86400', 22:55:39 INFO - 'USER': 'cltbld', 22:55:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457073601.591312-543738990', 22:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:39 INFO - '_': '/tools/buildbot/bin/python'} 22:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:39 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 22:55:39 INFO - Cleaning up... 22:55:39 INFO - Return code: 0 22:55:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:39 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 0x7fb389952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c160>, '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 0x230d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d4f0>, '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-1457073601.591312-543738990', '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 22:55:39 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 22:55:39 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 22:55:39 INFO - Using env: {'DISPLAY': ':0', 22:55:39 INFO - 'HOME': '/home/cltbld', 22:55:39 INFO - 'LANG': 'en_US.UTF-8', 22:55:39 INFO - 'LANGUAGE': 'en_US:en', 22:55:39 INFO - 'LOGNAME': 'cltbld', 22:55:39 INFO - 'MAIL': '/var/mail/cltbld', 22:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:39 INFO - 'MOZ_NO_REMOTE': '1', 22:55:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:39 INFO - 'NO_EM_RESTART': '1', 22:55:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:39 INFO - 'PWD': '/builds/slave/test', 22:55:39 INFO - 'SHELL': '/bin/bash', 22:55:39 INFO - 'SHLVL': '1', 22:55:39 INFO - 'TERM': 'linux', 22:55:39 INFO - 'TMOUT': '86400', 22:55:39 INFO - 'USER': 'cltbld', 22:55:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457073601.591312-543738990', 22:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:39 INFO - '_': '/tools/buildbot/bin/python'} 22:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:39 INFO - Downloading/unpacking psutil>=0.7.1 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:55:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:55:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:55:41 INFO - Installing collected packages: psutil 22:55:41 INFO - Running setup.py install for psutil 22:55:41 INFO - building 'psutil._psutil_linux' extension 22:55:41 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 22:55:41 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 22:55:41 INFO - building 'psutil._psutil_posix' extension 22:55:41 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 22:55:41 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 22:55:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:55:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:55:41 INFO - Successfully installed psutil 22:55:41 INFO - Cleaning up... 22:55:41 INFO - Return code: 0 22:55:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:41 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 0x7fb389952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c160>, '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 0x230d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d4f0>, '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-1457073601.591312-543738990', '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 22:55:41 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 22:55:41 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 22:55:41 INFO - Using env: {'DISPLAY': ':0', 22:55:41 INFO - 'HOME': '/home/cltbld', 22:55:41 INFO - 'LANG': 'en_US.UTF-8', 22:55:41 INFO - 'LANGUAGE': 'en_US:en', 22:55:41 INFO - 'LOGNAME': 'cltbld', 22:55:41 INFO - 'MAIL': '/var/mail/cltbld', 22:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:41 INFO - 'MOZ_NO_REMOTE': '1', 22:55:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:41 INFO - 'NO_EM_RESTART': '1', 22:55:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:41 INFO - 'PWD': '/builds/slave/test', 22:55:41 INFO - 'SHELL': '/bin/bash', 22:55:41 INFO - 'SHLVL': '1', 22:55:41 INFO - 'TERM': 'linux', 22:55:41 INFO - 'TMOUT': '86400', 22:55:41 INFO - 'USER': 'cltbld', 22:55:41 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457073601.591312-543738990', 22:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:41 INFO - '_': '/tools/buildbot/bin/python'} 22:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:55:42 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 22:55:42 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 22:55:42 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 22:55:42 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 22:55:42 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 22:55:42 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 22:55:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:55:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:55:44 INFO - Installing collected packages: mozsystemmonitor 22:55:44 INFO - Running setup.py install for mozsystemmonitor 22:55:44 INFO - Successfully installed mozsystemmonitor 22:55:44 INFO - Cleaning up... 22:55:44 INFO - Return code: 0 22:55:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:44 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 0x7fb389952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c160>, '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 0x230d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d4f0>, '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-1457073601.591312-543738990', '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 22:55:44 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 22:55:44 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 22:55:44 INFO - Using env: {'DISPLAY': ':0', 22:55:44 INFO - 'HOME': '/home/cltbld', 22:55:44 INFO - 'LANG': 'en_US.UTF-8', 22:55:44 INFO - 'LANGUAGE': 'en_US:en', 22:55:44 INFO - 'LOGNAME': 'cltbld', 22:55:44 INFO - 'MAIL': '/var/mail/cltbld', 22:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:44 INFO - 'MOZ_NO_REMOTE': '1', 22:55:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:44 INFO - 'NO_EM_RESTART': '1', 22:55:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:44 INFO - 'PWD': '/builds/slave/test', 22:55:44 INFO - 'SHELL': '/bin/bash', 22:55:44 INFO - 'SHLVL': '1', 22:55:44 INFO - 'TERM': 'linux', 22:55:44 INFO - 'TMOUT': '86400', 22:55:44 INFO - 'USER': 'cltbld', 22:55:44 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457073601.591312-543738990', 22:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:44 INFO - '_': '/tools/buildbot/bin/python'} 22:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:44 INFO - Downloading/unpacking blobuploader==1.2.4 22:55:44 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 22:55:44 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 22:55:44 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 22:55:44 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 22:55:44 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 22:55:44 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 22:55:46 INFO - Downloading blobuploader-1.2.4.tar.gz 22:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:55:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:55:46 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 22:55:46 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 22:55:46 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 22:55:46 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 22:55:46 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 22:55:46 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 22:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:55:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:55:46 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 22:55:46 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 22:55:46 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 22:55:46 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 22:55:46 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 22:55:46 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 22:55:46 INFO - Downloading docopt-0.6.1.tar.gz 22:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:55:46 INFO - Installing collected packages: blobuploader, requests, docopt 22:55:46 INFO - Running setup.py install for blobuploader 22:55:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:55:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:55:46 INFO - Running setup.py install for requests 22:55:47 INFO - Running setup.py install for docopt 22:55:47 INFO - Successfully installed blobuploader requests docopt 22:55:47 INFO - Cleaning up... 22:55:47 INFO - Return code: 0 22:55:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:55:47 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')]} 22:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:47 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')]} 22:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:47 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 0x7fb389952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c160>, '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 0x230d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d4f0>, '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-1457073601.591312-543738990', '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 22:55:47 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 22:55:47 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 22:55:47 INFO - Using env: {'DISPLAY': ':0', 22:55:47 INFO - 'HOME': '/home/cltbld', 22:55:47 INFO - 'LANG': 'en_US.UTF-8', 22:55:47 INFO - 'LANGUAGE': 'en_US:en', 22:55:47 INFO - 'LOGNAME': 'cltbld', 22:55:47 INFO - 'MAIL': '/var/mail/cltbld', 22:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:47 INFO - 'MOZ_NO_REMOTE': '1', 22:55:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:47 INFO - 'NO_EM_RESTART': '1', 22:55:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:47 INFO - 'PWD': '/builds/slave/test', 22:55:47 INFO - 'SHELL': '/bin/bash', 22:55:47 INFO - 'SHLVL': '1', 22:55:47 INFO - 'TERM': 'linux', 22:55:47 INFO - 'TMOUT': '86400', 22:55:47 INFO - 'USER': 'cltbld', 22:55:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457073601.591312-543738990', 22:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:47 INFO - '_': '/tools/buildbot/bin/python'} 22:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:55:47 INFO - Running setup.py (path:/tmp/pip-dU2iun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:55:47 INFO - Running setup.py (path:/tmp/pip-tP_w5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:55:47 INFO - Running setup.py (path:/tmp/pip-tfGqPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:55:47 INFO - Running setup.py (path:/tmp/pip-kJzaoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:55:47 INFO - Running setup.py (path:/tmp/pip-571wqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:55:47 INFO - Running setup.py (path:/tmp/pip-keI1b6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:55:47 INFO - Running setup.py (path:/tmp/pip-1LNjZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:55:47 INFO - Running setup.py (path:/tmp/pip-R5nCeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:55:48 INFO - Running setup.py (path:/tmp/pip-4MQvTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:55:48 INFO - Running setup.py (path:/tmp/pip-OGT9wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:55:48 INFO - Running setup.py (path:/tmp/pip-9mpMmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:55:48 INFO - Running setup.py (path:/tmp/pip-hOz50V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:55:48 INFO - Running setup.py (path:/tmp/pip-n7pKTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:55:48 INFO - Running setup.py (path:/tmp/pip-pNCFRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:55:48 INFO - Running setup.py (path:/tmp/pip-6dgj8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:55:48 INFO - Running setup.py (path:/tmp/pip-AlOq7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:55:48 INFO - Running setup.py (path:/tmp/pip-HxpBHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:55:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:55:48 INFO - Running setup.py install for manifestparser 22:55:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:55:48 INFO - Running setup.py install for mozcrash 22:55:48 INFO - Running setup.py install for mozdebug 22:55:48 INFO - Running setup.py install for mozdevice 22:55:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:55:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:55:48 INFO - Running setup.py install for mozfile 22:55:49 INFO - Running setup.py install for mozhttpd 22:55:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:55:49 INFO - Running setup.py install for mozinfo 22:55:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:55:49 INFO - Running setup.py install for mozInstall 22:55:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:55:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:55:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:55:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:55:49 INFO - Running setup.py install for mozleak 22:55:49 INFO - Running setup.py install for mozlog 22:55:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:55:49 INFO - Running setup.py install for moznetwork 22:55:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:55:49 INFO - Running setup.py install for mozprocess 22:55:49 INFO - Running setup.py install for mozprofile 22:55:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:55:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:55:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:55:49 INFO - Running setup.py install for mozrunner 22:55:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:55:49 INFO - Running setup.py install for mozscreenshot 22:55:49 INFO - Running setup.py install for moztest 22:55:50 INFO - Running setup.py install for mozversion 22:55:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:55:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:55:50 INFO - Cleaning up... 22:55:50 INFO - Return code: 0 22:55:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:50 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 0x7fb389952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c160>, '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 0x230d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d4f0>, '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-1457073601.591312-543738990', '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 22:55:50 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 22:55:50 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 22:55:50 INFO - Using env: {'DISPLAY': ':0', 22:55:50 INFO - 'HOME': '/home/cltbld', 22:55:50 INFO - 'LANG': 'en_US.UTF-8', 22:55:50 INFO - 'LANGUAGE': 'en_US:en', 22:55:50 INFO - 'LOGNAME': 'cltbld', 22:55:50 INFO - 'MAIL': '/var/mail/cltbld', 22:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:50 INFO - 'MOZ_NO_REMOTE': '1', 22:55:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:50 INFO - 'NO_EM_RESTART': '1', 22:55:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:50 INFO - 'PWD': '/builds/slave/test', 22:55:50 INFO - 'SHELL': '/bin/bash', 22:55:50 INFO - 'SHLVL': '1', 22:55:50 INFO - 'TERM': 'linux', 22:55:50 INFO - 'TMOUT': '86400', 22:55:50 INFO - 'USER': 'cltbld', 22:55:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457073601.591312-543738990', 22:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:50 INFO - '_': '/tools/buildbot/bin/python'} 22:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:55:50 INFO - Running setup.py (path:/tmp/pip-edMOif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:55:50 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)) 22:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:55:50 INFO - Running setup.py (path:/tmp/pip-2bGU49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 22:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:55:50 INFO - Running setup.py (path:/tmp/pip-NnYdQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:55:50 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)) 22:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:55:50 INFO - Running setup.py (path:/tmp/pip-etIRfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:55:50 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)) 22:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:55:50 INFO - Running setup.py (path:/tmp/pip-73VM1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:55:50 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)) 22:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:55:50 INFO - Running setup.py (path:/tmp/pip-ZEPFIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:55:50 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)) 22:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:55:50 INFO - Running setup.py (path:/tmp/pip-nAc5AJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:55:50 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)) 22:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:55:50 INFO - Running setup.py (path:/tmp/pip-plV2l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:55:50 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)) 22:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:55:50 INFO - Running setup.py (path:/tmp/pip-dQJdth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:55:50 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)) 22:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:55:50 INFO - Running setup.py (path:/tmp/pip-QtCnBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:55:50 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)) 22:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:55:50 INFO - Running setup.py (path:/tmp/pip-v6SK2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:55:50 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)) 22:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:55:51 INFO - Running setup.py (path:/tmp/pip-jCTAzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:55:51 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)) 22:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:55:51 INFO - Running setup.py (path:/tmp/pip-DkH6Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:55:51 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)) 22:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:55:51 INFO - Running setup.py (path:/tmp/pip-IC2F49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:55:51 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)) 22:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:55:51 INFO - Running setup.py (path:/tmp/pip-iV_JXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:55:51 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)) 22:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:55:51 INFO - Running setup.py (path:/tmp/pip-C0hv4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:55:51 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)) 22:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:55:51 INFO - Running setup.py (path:/tmp/pip-i2AwiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:55:51 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)) 22:55:51 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:55:51 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:55:51 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)) 22:55:51 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)) 22:55:51 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)) 22:55:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:53 INFO - Downloading blessings-1.6.tar.gz 22:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:55:53 INFO - Installing collected packages: blessings 22:55:53 INFO - Running setup.py install for blessings 22:55:53 INFO - Successfully installed blessings 22:55:53 INFO - Cleaning up... 22:55:53 INFO - Return code: 0 22:55:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:55:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:55:53 INFO - Reading from file tmpfile_stdout 22:55:53 INFO - Current package versions: 22:55:53 INFO - argparse == 1.2.1 22:55:53 INFO - blessings == 1.6 22:55:53 INFO - blobuploader == 1.2.4 22:55:53 INFO - docopt == 0.6.1 22:55:53 INFO - manifestparser == 1.1 22:55:53 INFO - mozInstall == 1.12 22:55:53 INFO - mozcrash == 0.16 22:55:53 INFO - mozdebug == 0.1 22:55:53 INFO - mozdevice == 0.48 22:55:53 INFO - mozfile == 1.2 22:55:53 INFO - mozhttpd == 0.7 22:55:53 INFO - mozinfo == 0.9 22:55:53 INFO - mozleak == 0.1 22:55:53 INFO - mozlog == 3.1 22:55:53 INFO - moznetwork == 0.27 22:55:53 INFO - mozprocess == 0.22 22:55:53 INFO - mozprofile == 0.28 22:55:53 INFO - mozrunner == 6.11 22:55:53 INFO - mozscreenshot == 0.1 22:55:53 INFO - mozsystemmonitor == 0.0 22:55:53 INFO - moztest == 0.7 22:55:53 INFO - mozversion == 1.4 22:55:53 INFO - psutil == 3.1.1 22:55:53 INFO - requests == 1.2.3 22:55:53 INFO - wsgiref == 0.1.2 22:55:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:55:53 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')]} 22:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:53 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')]} 22:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:53 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 0x7fb389952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c160>, '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 0x230d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d4f0>, '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-1457073601.591312-543738990', '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 22:55:53 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 22:55:53 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 22:55:53 INFO - Using env: {'DISPLAY': ':0', 22:55:53 INFO - 'HOME': '/home/cltbld', 22:55:53 INFO - 'LANG': 'en_US.UTF-8', 22:55:53 INFO - 'LANGUAGE': 'en_US:en', 22:55:53 INFO - 'LOGNAME': 'cltbld', 22:55:53 INFO - 'MAIL': '/var/mail/cltbld', 22:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:53 INFO - 'MOZ_NO_REMOTE': '1', 22:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:53 INFO - 'NO_EM_RESTART': '1', 22:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:53 INFO - 'PWD': '/builds/slave/test', 22:55:53 INFO - 'SHELL': '/bin/bash', 22:55:53 INFO - 'SHLVL': '1', 22:55:53 INFO - 'TERM': 'linux', 22:55:53 INFO - 'TMOUT': '86400', 22:55:53 INFO - 'USER': 'cltbld', 22:55:53 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457073601.591312-543738990', 22:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:53 INFO - '_': '/tools/buildbot/bin/python'} 22:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:53 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)) 22:55:53 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)) 22:55:53 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)) 22:55:53 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)) 22:55:53 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)) 22:55:53 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)) 22:55:53 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)) 22:55:53 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)) 22:55:53 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)) 22:55:53 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)) 22:55:53 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)) 22:55:53 INFO - Cleaning up... 22:55:53 INFO - Return code: 0 22:55:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:55:53 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')]} 22:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:53 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')]} 22:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:53 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 0x7fb389952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c160>, '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 0x230d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d4f0>, '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-1457073601.591312-543738990', '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 22:55:53 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 22:55:53 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 22:55:53 INFO - Using env: {'DISPLAY': ':0', 22:55:53 INFO - 'HOME': '/home/cltbld', 22:55:53 INFO - 'LANG': 'en_US.UTF-8', 22:55:53 INFO - 'LANGUAGE': 'en_US:en', 22:55:53 INFO - 'LOGNAME': 'cltbld', 22:55:53 INFO - 'MAIL': '/var/mail/cltbld', 22:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:53 INFO - 'MOZ_NO_REMOTE': '1', 22:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:53 INFO - 'NO_EM_RESTART': '1', 22:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:53 INFO - 'PWD': '/builds/slave/test', 22:55:53 INFO - 'SHELL': '/bin/bash', 22:55:53 INFO - 'SHLVL': '1', 22:55:53 INFO - 'TERM': 'linux', 22:55:53 INFO - 'TMOUT': '86400', 22:55:53 INFO - 'USER': 'cltbld', 22:55:53 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457073601.591312-543738990', 22:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:53 INFO - '_': '/tools/buildbot/bin/python'} 22:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:54 INFO - Downloading/unpacking jsonschema 22:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:55:55 INFO - Downloading/unpacking functools32 (from jsonschema) 22:55:55 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 22:55:55 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 22:55:55 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 22:55:55 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 22:55:55 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 22:55:55 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 22:55:56 INFO - Downloading functools32-3.2.3-2.tar.gz 22:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:55:56 INFO - warning: no files found matching '*.txt' 22:55:56 INFO - no previously-included directories found matching 'build' 22:55:56 INFO - no previously-included directories found matching 'dist' 22:55:56 INFO - no previously-included directories found matching '.git*' 22:55:56 INFO - Installing collected packages: jsonschema, functools32 22:55:56 INFO - Running setup.py install for functools32 22:55:56 INFO - warning: no files found matching '*.txt' 22:55:56 INFO - no previously-included directories found matching 'build' 22:55:56 INFO - no previously-included directories found matching 'dist' 22:55:56 INFO - no previously-included directories found matching '.git*' 22:55:56 INFO - Successfully installed jsonschema functools32 22:55:56 INFO - Cleaning up... 22:55:56 INFO - Return code: 0 22:55:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb389952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c160>, '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 0x230d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d4f0>, '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-1457073601.591312-543738990', '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 22:55:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:55:56 INFO - Using env: {'DISPLAY': ':0', 22:55:56 INFO - 'HOME': '/home/cltbld', 22:55:56 INFO - 'LANG': 'en_US.UTF-8', 22:55:56 INFO - 'LANGUAGE': 'en_US:en', 22:55:56 INFO - 'LOGNAME': 'cltbld', 22:55:56 INFO - 'MAIL': '/var/mail/cltbld', 22:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:56 INFO - 'MOZ_NO_REMOTE': '1', 22:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:56 INFO - 'NO_EM_RESTART': '1', 22:55:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:56 INFO - 'PWD': '/builds/slave/test', 22:55:56 INFO - 'SHELL': '/bin/bash', 22:55:56 INFO - 'SHLVL': '1', 22:55:56 INFO - 'TERM': 'linux', 22:55:56 INFO - 'TMOUT': '86400', 22:55:56 INFO - 'USER': 'cltbld', 22:55:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457073601.591312-543738990', 22:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:56 INFO - '_': '/tools/buildbot/bin/python'} 22:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:56 INFO - Downloading/unpacking flake8 22:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:55:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:55:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:55:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:55:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:55:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:55:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:55:59 INFO - no previously-included directories found matching 'docs/_build' 22:55:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:55:59 INFO - Running setup.py install for pep8 22:55:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:55:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:55:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:55:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:55:59 INFO - no previously-included directories found matching 'docs/_build' 22:55:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:55:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:55:59 INFO - Cleaning up... 22:55:59 INFO - Return code: 0 22:55:59 INFO - Running post-action listener: _resource_record_post_action 22:55:59 INFO - Running post-action listener: _start_resource_monitoring 22:55:59 INFO - Starting resource monitoring. 22:55:59 INFO - ##### 22:55:59 INFO - ##### Running install step. 22:55:59 INFO - ##### 22:55:59 INFO - Running pre-action listener: _resource_record_pre_action 22:55:59 INFO - Running main action method: install 22:55:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:55:59 INFO - Reading from file tmpfile_stdout 22:55:59 INFO - Detecting whether we're running mozinstall >=1.0... 22:55:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:55:59 INFO - Reading from file tmpfile_stdout 22:55:59 INFO - Output received: 22:55:59 INFO - Usage: mozinstall [options] installer 22:55:59 INFO - Options: 22:55:59 INFO - -h, --help show this help message and exit 22:55:59 INFO - -d DEST, --destination=DEST 22:55:59 INFO - Directory to install application into. [default: 22:55:59 INFO - "/builds/slave/test"] 22:55:59 INFO - --app=APP Application being installed. [default: firefox] 22:55:59 INFO - mkdir: /builds/slave/test/build/application 22:55:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:56:15 INFO - Reading from file tmpfile_stdout 22:56:15 INFO - Output received: 22:56:15 INFO - /builds/slave/test/build/application/firefox/firefox 22:56:15 INFO - Running post-action listener: _resource_record_post_action 22:56:15 INFO - ##### 22:56:15 INFO - ##### Running run-tests step. 22:56:15 INFO - ##### 22:56:15 INFO - Running pre-action listener: _resource_record_pre_action 22:56:15 INFO - Running main action method: run_tests 22:56:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:56:15 INFO - Python 2.7.3 22:56:15 INFO - Return code: 0 22:56:15 INFO - grabbing minidump binary from tooltool 22:56:15 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')]} 22:56:15 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 0x230c160>, '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 0x230d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:56:15 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 22:56:15 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 22:56:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:56:15 INFO - Return code: 0 22:56:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:56:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:56:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:56:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:56:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:56:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:56:16 INFO - Return code: 0 22:56:16 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/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.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 22:56:16 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/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.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 22:56:16 INFO - Using env: {'DISPLAY': ':0', 22:56:16 INFO - 'HOME': '/home/cltbld', 22:56:16 INFO - 'LANG': 'en_US.UTF-8', 22:56:16 INFO - 'LANGUAGE': 'en_US:en', 22:56:16 INFO - 'LOGNAME': 'cltbld', 22:56:16 INFO - 'MAIL': '/var/mail/cltbld', 22:56:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:56:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:16 INFO - 'MOZ_NO_REMOTE': '1', 22:56:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:56:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:16 INFO - 'NO_EM_RESTART': '1', 22:56:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:16 INFO - 'PWD': '/builds/slave/test', 22:56:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:56:16 INFO - 'SHELL': '/bin/bash', 22:56:16 INFO - 'SHLVL': '1', 22:56:16 INFO - 'TERM': 'linux', 22:56:16 INFO - 'TMOUT': '86400', 22:56:16 INFO - 'USER': 'cltbld', 22:56:16 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457073601.591312-543738990', 22:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:16 INFO - '_': '/tools/buildbot/bin/python'} 22:56:16 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/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.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 22:56:16 INFO - mozversion application_buildid: 20160303222325 22:56:16 INFO - mozversion application_changeset: ce70a1f7c40ebd826378a103617d6a531abbc572 22:56:16 INFO - mozversion application_display_name: Nightly 22:56:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:56:16 INFO - mozversion application_name: Firefox 22:56:16 INFO - mozversion application_remotingname: firefox 22:56:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:56:16 INFO - mozversion application_vendor: Mozilla 22:56:16 INFO - mozversion application_version: 47.0a1 22:56:16 INFO - mozversion platform_buildid: 20160303222325 22:56:16 INFO - mozversion platform_changeset: ce70a1f7c40ebd826378a103617d6a531abbc572 22:56:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:56:16 INFO - mozversion platform_version: 47.0a1 22:56:16 INFO - using testdate: 1457074576 22:56:16 INFO - actual date: 1457074576 22:56:16 INFO - starting webserver on 'localhost:59700' 22:56:16 INFO - SUITE-START | Running 2 tests 22:56:16 INFO - TEST-START | dromaeo_css 22:56:16 INFO - operating with platform_type : linux_ 22:56:16 INFO - Initialising browser for dromaeo_css test... 22:56:16 INFO - TEST-INFO | started process 18297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4DvdEg/profile http://localhost:59700/getInfo.html) 22:56:20 INFO - PROCESS | 18297 | 22:56:20 INFO - PROCESS | 18297 | (process:18375): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:56:21 INFO - PROCESS | 18297 | __metrics Screen width/height:1600/1200 22:56:21 INFO - PROCESS | 18297 | colorDepth:24 22:56:21 INFO - PROCESS | 18297 | Browser inner width/height: 1024/697 22:56:21 INFO - PROCESS | 18297 | __metrics 22:56:22 ERROR - PROCESS | 18297 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 22:56:22 INFO - TEST-INFO | 18297: exit 0 22:56:22 INFO - Browser initialized. 22:56:22 INFO - Running cycle 1/1 for dromaeo_css test... 22:56:22 INFO - TEST-INFO | started process 18426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4DvdEg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:56:23 INFO - PROCESS | 18426 | 22:56:23 INFO - PROCESS | 18426 | (process:18482): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:56:34 INFO - PROCESS | 18426 | RSS: Main: 160129024 22:56:34 INFO - PROCESS | 18426 | 22:57:24 INFO - PROCESS | 18426 | 1457074644089 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] 22:59:34 INFO - PROCESS | 18426 | Cycle 1(1): loaded http://localhost:59700/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59700/tests/dromaeo/cssquery-ext.html) 22:59:35 INFO - PROCESS | 18426 | RSS: Main: 170303488 22:59:35 INFO - PROCESS | 18426 | 23:02:37 INFO - PROCESS | 18426 | Cycle 1(1): loaded http://localhost:59700/tests/dromaeo/cssquery-ext.html (next: http://localhost:59700/tests/dromaeo/cssquery-jquery.html) 23:02:38 INFO - PROCESS | 18426 | RSS: Main: 164380672 23:02:38 INFO - PROCESS | 18426 | 23:05:39 INFO - PROCESS | 18426 | Cycle 1(1): loaded http://localhost:59700/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59700/tests/dromaeo/cssquery-mootools.html) 23:05:40 INFO - PROCESS | 18426 | RSS: Main: 166072320 23:05:40 INFO - PROCESS | 18426 | 23:08:42 INFO - PROCESS | 18426 | Cycle 1(1): loaded http://localhost:59700/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59700/tests/dromaeo/cssquery-prototype.html) 23:08:42 INFO - PROCESS | 18426 | RSS: Main: 163397632 23:08:42 INFO - PROCESS | 18426 | 23:11:45 INFO - PROCESS | 18426 | Cycle 1(1): loaded http://localhost:59700/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59700/tests/dromaeo/cssquery-yui.html) 23:11:46 INFO - PROCESS | 18426 | RSS: Main: 163893248 23:11:46 INFO - PROCESS | 18426 | 23:14:48 INFO - PROCESS | 18426 | Cycle 1(1): loaded http://localhost:59700/tests/dromaeo/cssquery-yui.html (next: http://localhost:59700/tests/dromaeo/cssquery-dojo.html) 23:14:48 INFO - PROCESS | 18426 | RSS: Main: 167809024 23:14:48 INFO - PROCESS | 18426 | 23:14:48 INFO - PROCESS | 18426 | __start_tp_report 23:14:48 INFO - PROCESS | 18426 | _x_x_mozilla_page_load 23:14:48 INFO - PROCESS | 18426 | _x_x_mozilla_page_load_details 23:14:48 INFO - PROCESS | 18426 | |i|pagename|runs| 23:14:48 INFO - PROCESS | 18426 | |0;dojo.html;2602.843829370238;2611.360216746897;2675.224184986354;2678.3973605938677;2688.0726149478423;4486.6410687145035;4685.273782563704;4722.527747225276;4731.030138821542;4748.406449193851;4534.5465453454635;4674.719516828993;4708.317293992378;4716.575508204261;4754.833580824672;4297.419848320468;4354.238008348542;4380.408644832954;4382.342648602703;4382.430284063067;58.36521092112079;4253.510846252674;4338.544452832454;4371.956280437203;4397.516273209944;4330.631896288804;4363.869083927487;4371.016521282718;4403.867883963486;4404.581564751344;4161.687873409476;4315.8273669053515;4339.913201735948;4373.650107991353;4430.490493593245;4282.914341713179;4287.678424118204;4311.943573824402;4328;4347.847825326098;4492.415985921842;4597.862064138081;4620.191466493384;4656.674032817704;4686.156491831469;4815.15734746418;4978.004399120155;4993.126202914512;5010.874728131826;5014.24786282057;4983.950160498421;4990.72551009698;5001.024800163969;5007.148784706608;5053.898922021575;4652.674312798105;4657.836975705834;4659.5806377425515;4671.346011558385;4692.601128904047;4957.529034741694;5023.497650234947;5101.132807422747;5106.974465127651;5153.587712982952;4898.926516102261;4913.091078150554;4917.827876024322;4940.036692844933;4940.530649588283;4989.975050124726;4992.950070499322;4997.950020499821;5005.849824505271;5006.774695138727;4601.378813860153;4910.950890491121;4973.179425394842;4978.054169707744;4995.325631039763;4736.005438857809;4871.634627402888;4909.803607855717;4930.087933732271;5000.774965126578;4132.318167502389;4139.565345638664;4168.312228482328;4190.832366705297;4203.07532342884;3499.9300014000087;3550.946735798965;3650.379435495972;3692.464592634107;3722.813859307078;4324;4333.458317710286;4345.217860785026;4346.1090476452255;4380.14587155508;4990.951900101019;5035.068512325159;5049.545540901337;5063.974680126576;5087.008033433445;4190.497140343117;4317.805698743564;4356.411884395566;4389.122175564899;4398.164348773723;4427.490838553607;4442.8222871085445;4443.266860967904;4449.354843547668;4469.374287599739;4520.4575450946095;4713.6936099153445;4726.621870250372;4739.123262196574;4778.402699662543;4965.503449655005;5016;5019.874503137451;5021.096202683552;5051.772670229775;4677.391939047902;4697.976510117427;4700.8119675213975;4711;4763.976180119077;4759.428868535798;4896.387951506062;4903.239997800347;4917.213245880642;4976.0794253063295;4954.157793175241;4970.900581988412;4976.452590215146;4980.750962451935;5026.472220416804;4791.856244312677;4805.399325084364;4812.711237325771;4821.710697358169;4891.070696567641;4656.697314674535;4744.074905393415;4792.544708252711;4848.981713840133;4869.074875773592;4560.019595786922;4710.858674239778;4712.740799256074;4783.1390349737385;4796.184648609815;4812.951870481251;4914.041761856547;4928.926066108939;4942.777575009061;4959.13215187348;4804.711717296974;4812.868975790617;4820.758962051813;4861.149298872754;4905.754712264444 23:14:48 INFO - PROCESS | 18426 | |1;ext.html;438.95528641832436;448.9472187719798;460.8088092281452;482.49338194895364;498.97255650939206;32791.83604081979;33160.50259246113;33191.17022074446;33245.33509329812;33291.33417331652;35951.640483595154;36471;36544.634553654454;36587.81706091473;36681.26637467256;7608.391328693705;7783.688652453923;7806.843863122735;7807.141214466405;7832.334251588622;7525.962370188141;7667.386609071261;7688.884666730003;7701.037370328709;7728.497647652885;7836.764897053097;7890.802729931769;7906.367490600738;7924.920750792505;7935.722249721261;7844.764657060297;7848.921510784905;7887.960560197191;7889.211078892123;7914.169012253688;7816.8827467588035;7914.169012253688;7925.564093974829;7945.364370850318;7952.801179970489;36845.81577092098;37203.62796372029;37281.25437491262;37337.62662373396;37547.24905501902;2153.558520503293;2615.4899794540074;2821.661400631917;3159.526071089332;3417.2140407706365;24349.63475547868;26328.47343053128;27075.458490830075;27385.17844464669;28258.434831303464;3038.9088327350214;3059.3575349176476;3068.1255842084897;3077.1537827097504;3113.7664675149226;218471;219183;220127;220955;221057;54622;54793.72603136959;54843.17735233975;54939.45060549343;55250;56837.43162568404;57491.42508574944;57798;58050.41949580535;58103.12845307324;11399.088072954144;11479;11512.712182195344;11560.190786645022;11574.942125289488;9386.95306523463;9457.33798634089;9503.57233924475;9545;9568.091031352149;18853;19108.617827643367;19120.139593718315;19145;19154.904225478782;7417.109946806418;7601.277878601524;7652.1582625911105;7652.7704168875025;7683.8474228865;820.6266148902235;873.8776571280026;882.9028806831243;909.9590518426687;932.7668082979255;26066.478670426484;26339.868300658374;26481;26543.203703888914;28484.430311393655;924.9815003699888;958.1999030809213;969.5055521683851;999.6850991937662;1052.4632437456798;13346;13722;14013.859861401255;14070.577882663536;14076;296917;363009;365911;370174;371169;43253.56746432495;43444;43594.56405435968;43634.56365436305;43700;1204.0548169686929;1210.056156198167;1219.6341097670663;1227.79127548317;1248.2385744695728;27030;27940.860295699204;28367.29081772972;28707.138785836458;28756.568651469825;40060.79969600133;40590.39114413227;40729.796351018056;40747.38878916759;40900;243214;248574;249176;249226;250988;29539.704602953694;29896.103116906528;29965.400691986473;29969.400611988076;30011.69988300089;38620.22759544737;39124.217515650096;39381.80309098436;39637.00907477336;40178.39732404075;33033.83483082569;33976;34096.31807363888;34193.48709769405;34625.653743462244;33373.33253334968;34021;34213.31573368469;34552.30895382028;34617;26752.866235669477;32376.83811580927;32848.50727239045;34007.659923401436;34234;25954.35114122162;26306.079287224857;26436;26804.731952680224;27247.45505089927;21346.893265533574;21415.57168856583;22891.198808041638;22975.65536516987;25372 23:14:48 INFO - PROCESS | 18426 | |2;jquery.html;324.559313959028;325.87453830275336;326.73207969465034;330.1416317574306;334.4598473465351;15150.469733559314;15230.847691523082;15737.84262157378;16650.250738716757;16670.49988500344;14751.704965900675;15118.546443606681;15182.84817151831;15462.149581772997;15768.65966392855;4911.263310503436;5115.667481613683;5128.384593848743;5145.125328694131;5153.484651534835;4844.249141383074;4954.97522512387;5091.058154241458;5093.337866077405;5126.589872810185;5032.194848824189;5033.773480193382;5037.4458809530925;5056.747162641872;5068.670536415139;4889.9511004889855;4989.226669866195;5024.422191447994;5033.144365457881;5040.697558146487;4430.26900561407;4437.445319335083;4441.844535441276;4443.600075993176;4463.888402789924;18491.537711557183;18586.256549737995;18702.625947480974;19291.61416771657;19379.127939242768;1596.1221328269405;1720.60426101996;1793.1213705284447;1933.8839669619867;2537.1373732930892;8122.837543249161;8625.525596092213;8630.827383452295;9028.322875784343;9305.162535371848;1739.1391261325598;1754.8157443468508;1777.8844375115575;1786.3926265069938;1797.9640407191914;55879.72060139673;57894.710526447096;58598.70700646512;59850.401495984916;60324;9400.90599094014;9433.386829856037;9474;9483.905160948303;9579.760505987406;11814.173007889365;11931.582394616147;11942.283462992249;11974.760504789856;11978;6075.2405949256345;6093.512518998469;6251.812445626639;6353.936460635427;6364.745410183634;5771.538276937835;5778.884422311614;5784.2769653793275;5832.212651292021;5840.941590584125;3931.2137572485617;3971.4638523799495;3978.462907507507;3986.820593073319;4010.9197816044098;1623.2127418202163;1723.293449685648;1767.469759072273;1773.4679596121111;1809.9457016289532;833.2292629317857;852.5098068610449;895.1227796759213;898.60910503931;962.7304354780673;14597.270136493345;15011;15495.612609684622;15702.921485392728;16215.918920405322;816.4285000499674;821.1049955548481;835.9707410240612;840.9747707568782;843.6709683223547;8866.512341821133;8969.578213882216;9104.726858194264;9175.862362064574;9201.493917834583;354917;355496;359586;363780;367523;67000.6649966747;67375.32624673788;67528;67581;68528.6573567129;891.5898686604235;933.6135838280013;941.5527624378502;943.5895385507326;946.5835032585641;14622.122672639676;14623.92688036553;14671.119732816065;14680.486182983544;14792.11247325164;32721.382289416313;33361.83319083389;33491.162720932174;33959;34323.4851477233;46868;47447.28829067498;47485.762571186926;47662.570122896366;47681;6852.280510546321;6909.861802764017;6996.825079373057;7034.824129396806;7081.291870812877;10001.849972250568;10143.543540540546;10339.689809305733;10356.689299321033;10459.633912813015;8686.232321770065;8912.131176990093;9079.409838360485;9379.624815007597;9441.96138424759;8920.420172688755;8950;9099.135582119688;9215.769605759642;9496.287778416785;9079.909200907907;9222.815543688954;9300.488473134043;9421.717348479557;10063.949680251844;6776.186857577122;7135.179454362815;7244.384227340735;7263;7302.306280903305;6456.9354306456335;8240.299574536231;9614.71155865325;9713.660021899199;9728.22174226046 23:14:48 INFO - PROCESS | 18426 | |3;mootools.html;1330.7005923667173;1337.973240535189;1431.7422863884497;1652.0418157468669;1653.9173041347929;5965.164876917235;7102.076730025103;7118.679659415326;7304.5252058616215;7346.37555807757;7131.679074441649;7228.096487939008;7252.45606579506;7277.308655677715;7296.489245752786;2081.5628717969244;2106;2109.1457959526338;2112.6725357569526;2120.3532922458644;2076.7300250967355;2102.1591363454586;2117.5129720164373;2119.162930642395;2124.5538436928264;2086.8747875127465;2100.90545925433;2120.936371908845;2129.606022885763;2129.9467513312215;2069.317125348631;2081.6565266730972;2090.383336915598;2090.7386576677914;2092.0272073485903;2045.263705066175;2071.9482012949647;2084.801943815335;2085.238887805955;2087.5720477302116;7412.4440666950195;7422.777316680508;7430.034095567596;7446.888296675555;7495.475316727831;4041.5150181978056;4128.938065929014;4149.605787450188;4164.937525937114;4168.124693814302;2630.487055024271;2656.721044290341;2699.217227004186;2713.8236014658983;2716.904908328219;851.1871163039283;855.0594346219171;855.8446097767963;875.5665945357089;885.6103314541581;10101.444420556867;10156.339837910513;10176.796464070678;10211.234157438223;10271.691849244535;3988.4017397390626;4035.2333056719717;4099.692523060782;4116.300228961084;4120.814563344657;8657.177568131017;8659.437136586102;8669;8717.128287171232;8734.388592798443;4251.086016506466;4267.1679022590915;4273.594008569181;4282.8715138545895;4312.870613881589;3086.2901532647616;3602.7297952653657;3665.2119794244363;3838.846446142179;3838.9424158637644;3388.271521622863;3413.5050417689295;3415.316936612687;3427.537282466885;3429.605595356566;1080.9838751573495;1115.4590023838432;1125.7523344864117;1126.6338440006866;1128.0186237972853;950.6720181537358;963.6386355116831;1104.0780947908427;1109.0794640448569;1116.0457808573715;6411.679416029273;6426.903596446057;6451.806445806634;6457.806265812033;6459.289478157399;435.14928315143817;436.75105190042007;443.16242302049153;443.48998651550977;446.2324801341687;4934.1118598651865;4950.925736113961;4957.429895561984;4964.925526117111;5009.298698182258;8309.750707478664;8818.33862460318;8823.779405514784;8844.690435834715;8877.201051905231;8639.78400539979;8654.134586541422;8671.089535598798;8723.214910657944;8726.738197854074;6585.2426970898005;6739.5619284746335;6774.491913106537;6775.898361524482;6821.420179284717;6206.751729930752;6212.099245609452;6239.875202495834;6242.531810114168;6252.468540174136;7445;7663.655135519027;7760.456768026184;7780.416468764752;7814.101378341336;7812.609369531387;7826.960865195865;7974.880376794469;7978.561179135203;8012.439129260896;5403.729813509231;5934.287885453773;6100.08498725177;6201.441870231701;6282.623042617458;6610.2398224204835;6679.398854103154;6683.064370988162;6689.49828762835;6692.732290708317;5870.9412905870395;5990;6066.4540191382985;6071.392860713893;6117.480014198843;5846.386129456346;5880.176775251382;5975;5986.6707331097205;6035.78874739382;6039.849003774941;6183.134361189527;6189.690515474118;6202.751889924352;6212.130301757667;5665.745041473061;5703.857403564778;5712.34308054579;5714.428557144252;5721.771129154788;5668.5465162787705;5729.541636668973;5748.281464816898;5770.6249093808765;5838.036723940502 23:14:48 INFO - PROCESS | 18426 | |4;prototype.html;305.2490872453763;307.3330872007743;309.47080492358066;310.1919499703274;315.5534918090901;5600.887982240352;5614.326280846294;5665.4334566543375;5728;5763.769449222036;5646.20953066571;5646.971765141178;5660.2075709400715;5662.122371032487;5695.601307908438;4048.4939382577177;4170.416141740159;4248.107897341562;4266.189424009443;4330.090680957002;4311.28863737483;4325.913481730364;4337.848175313865;4344.500382456026;4348.543402942693;4298.140371925611;4299.054208074219;4304.203722311367;4306.698531102824;4312.633426158764;4291.776843599575;4309.159713855799;4313.223619748444;4317.76252306123;4322.157179350028;3760.078780698719;3768.189839184561;3773.9056523586855;3776.4712940188397;3778.8299526521373;5444.91832622511;5446.400895901447;5447.264619276387;5449.100898351767;5463.9180412293845;4667.183242932473;4846.5880400166025;4874.683145595561;4902.411710594716;4962.60299176065;5894.233749612566;5907.763689452417;5917.704114794286;5918.112283157518;5920.141579470953;3956.4658771065824;3963.3064213762764;3971.801409929521;3981.064449854282;3981.3828856527284;6166.660833654148;6259.530535209878;6266.467350275232;6286.119943207955;6365.395287447732;4105.322621767435;4109.0959988802415;4109.712320137562;4118.711690181718;4125.8968525787095;4176.916461670749;4179.226843034048;4181.121964387452;4182.079942412725;4184.623383895464;4606;4725.125851717443;4742.264948932921;4749.073930583503;4756.6670333077045;5847.912281315784;5935.554833387513;5944.524438044946;5950.940490595125;5962.701864906738;1450.0864455393034;1455.3087283540233;1458.5405597236836;1468.4493315006873;1468.949700963816;949.9192568631744;961.4567769210514;962.2494454325637;968.6851773173747;972.0668158567713;5058.898822023539;5095.108356037678;5101.51535604117;5115.232715092766;5122.206058061007;6185.474234690012;6192.845178870564;6195.287541932646;6196.380361963767;6199.411055949678;4996;5114.977004599021;5118.3090282811345;5123.769430375642;5188.584913206934;3335.766496345281;3346.782459140148;3370.511275865035;3376.74674399421;3380.6281309055985;5821.912671309934;5831.504322132666;5834.504067154255;5835.679037652885;5850.824475265749;6417.358264173546;6444.645544495004;6456.838579035468;6469.935300646934;6480.222373315138;5830.067189249699;5830.183774271605;5833.912491312633;5844.363578198111;5853.853653658693;6100.567345874437;6215.564910456224;6264.21697287839;6276.9372306276355;6279.277883043508;6071.423214794588;6089.360617135314;6094.969525152524;6113.938860611337;6123.326434092157;5798.1302804579655;5804.82585522435;5813.331466881363;5829.737661805144;5831.679257640871;3987.481627388537;4014.9197016060098;4036.656884164879;4046.2716710992304;4058.573849745734;6216.813495595139;6219.937800622117;6230.501559875109;6249.96875015622;6259.06114082873;5733.569982251432;5981.1327357532045;5996;5996.850078748066;6026.156338112755;5974.522038237017;5974.671393073423;5985.940140598538;5994.370591088047;5996.190514280691;5849.502792262705;5852.678102704393;5860.208871802252;5863.912041319299;5866.120081987736;6019.849503762441;6042.788502402394;6044.879102418015;6056;6062.18160548338;5736.942630573641;5826.184334193301;5872.647641141545;5886.970565147147;5899.705014749331 23:14:48 INFO - PROCESS | 18426 | |5;yui.html;524.6694582413079;528.2024143543249;641.4964253061346;671.3756206727743;679.7450955891541;9709.951450242757;10192.64325748599;10498.265121441502;10614.522346494397;11496.655100347003;12272.140950133495;12275.63173104806;12289;12343.691407714812;12386.690332741686;757.2730179028126;775.0234704272601;776.8601651702692;777.6345117794656;777.6617171530374;759.6505607420593;766.7738017284886;769.2807225244386;769.7382889817461;772.5441989226383;789.7670187294761;793.2345286798238;795.7732046366787;795.8647030004884;798.9241022102891;781.1134362498548;782.7416952405692;784.3333166808196;785.0932173339773;786.8308313712522;587.9647221166744;588.0238803586027;588.3263663105763;588.6997631208072;590.1767034986214;10796.67609971702;10807.83788243177;10832.566697332097;11222.102231821516;11577.479013444416;10671.893281067245;10755.462226888625;11157.497912593954;11319.094472442268;11470.885291147066;8577.656893724243;8696.869546956737;8756.255718263956;8815.77960550985;8824.911750882537;3644.8724294649824;3665.706743460517;3677.2645470905927;3704.25914817035;3710.128119891823;37003.25993480115;37012.44481332755;37163;37189;37315;8333.583320833934;8396.118407567117;8431.789205269917;8586.141385861363;8679.956600216958;14585.343659535347;15369.385224590891;15405.38378464849;15418.691626167414;15478.380864765508;6137.7851775187655;6175.783847565313;6191.1641928339095;6212.099245609361;6482.805515834532;3015.42706885691;3095.613048368954;3125.343677827682;3180.1254654970066;3494.3011397720556;2400.6879105716143;2458.3976925652973;2504.4114633061217;2515.924522264335;2548.8598127103187;482.38495917704506;483.12554276758476;488.18960525527456;488.66282265236873;494.9109160351171;517.2267460147104;529.4652401074942;532.544674303465;536.265316516375;543.5325619966825;6643.634600097041;6663.20041595002;6701.229358623723;6708.362705542965;6744.932550674529;430.4834198961259;526.5484747480303;532.6750682083925;545.26661640094;553.6456667732655;3187.1394723424546;3228.1606782236786;3274.2632907596076;3282.9343413131605;3288.57248557686;45599.08801823945;45949.77025114853;46196;46943;47690.76154619205;39107.80446097751;39683.80158099249;39860.601393985686;39908.20183596312;40040;35814.64185358165;36380.45429318563;36669;36701.63298366982;36764.63235367612;7184.389326907271;7222.6388680566815;7301.963490182515;7327.890081648886;7411.592362419903;30127.04174228668;30228.69771302259;31110.53334200034;31338.686613133577;31696.841515792272;38505.42241866318;38842.6115738839;39417.2116557673;39452.60547394604;39700.602993970846;9036.954815225881;9103.635854566008;9154.992950775542;9229.35394522377;9264.39781414206;10391.844122338322;10419.218558607983;10728.302660327054;10895.618653347095;11049.33703977764;10192.235582331206;10257.384556926609;10738.302010369302;10954.507047183055;11056.170787191153;10000;10502.062210430222;10571.471426428494;10681.51933162994;11041;9998.200143988319;10052.849207262043;10141.746456338651;10275.801598214512;10315.504251883585;8333.791655208426;8428.704995325133;8719.78200544966;8789.648414063366;8946.642134314554;8635.82728345417;8917.687880924137;8963.955180224057;8994.865077023718;9086.954565227132 23:14:48 INFO - PROCESS | 18426 | __end_tp_report 23:14:48 INFO - PROCESS | 18426 | __start_cc_report 23:14:48 INFO - PROCESS | 18426 | _x_x_mozilla_cycle_collect,302 23:14:48 INFO - PROCESS | 18426 | __end_cc_report 23:14:48 INFO - PROCESS | 18426 | __startTimestamp1457075688571__endTimestamp 23:14:48 INFO - PROCESS | 18426 | 23:14:48 INFO - PROCESS | 18426 | ------- Summary: start ------- 23:14:48 INFO - PROCESS | 18426 | Number of tests: 6 23:14:48 INFO - PROCESS | 18426 | 23:14:48 INFO - PROCESS | 18426 | [#0] dojo.html Cycles:165 Average:4581.78 Median:4726.62 stddev:592.07 (12.5%) stddev-sans-first:573.17 23:14:48 INFO - PROCESS | 18426 | Values: 2602.8 2611.4 2675.2 2678.4 2688.1 4486.6 4685.3 4722.5 4731.0 4748.4 4534.5 4674.7 4708.3 4716.6 4754.8 4297.4 4354.2 4380.4 4382.3 4382.4 58.4 4253.5 4338.5 4372.0 4397.5 4330.6 4363.9 4371.0 4403.9 4404.6 4161.7 4315.8 4339.9 4373.7 4430.5 4282.9 4287.7 4311.9 4328.0 4347.8 4492.4 4597.9 4620.2 4656.7 4686.2 4815.2 4978.0 4993.1 5010.9 5014.2 4984.0 4990.7 5001.0 5007.1 5053.9 4652.7 4657.8 4659.6 4671.3 4692.6 4957.5 5023.5 5101.1 5107.0 5153.6 4898.9 4913.1 4917.8 4940.0 4940.5 4990.0 4993.0 4998.0 5005.8 5006.8 4601.4 4911.0 4973.2 4978.1 4995.3 4736.0 4871.6 4909.8 4930.1 5000.8 4132.3 4139.6 4168.3 4190.8 4203.1 3499.9 3550.9 3650.4 3692.5 3722.8 4324.0 4333.5 4345.2 4346.1 4380.1 4991.0 5035.1 5049.5 5064.0 5087.0 4190.5 4317.8 4356.4 4389.1 4398.2 4427.5 4442.8 4443.3 4449.4 4469.4 4520.5 4713.7 4726.6 4739.1 4778.4 4965.5 5016.0 5019.9 5021.1 5051.8 4677.4 4698.0 4700.8 4711.0 4764.0 4759.4 4896.4 4903.2 4917.2 4976.1 4954.2 4970.9 4976.5 4980.8 5026.5 4791.9 4805.4 4812.7 4821.7 4891.1 4656.7 4744.1 4792.5 4849.0 4869.1 4560.0 4710.9 4712.7 4783.1 4796.2 4813.0 4914.0 4928.9 4942.8 4959.1 4804.7 4812.9 4820.8 4861.1 4905.8 23:14:48 INFO - PROCESS | 18426 | 23:14:48 INFO - PROCESS | 18426 | [#1] ext.html Cycles:180 Average:42656.97 Median:34621.33 stddev:73678.11 (212.8%) stddev-sans-first:73816.61 23:14:48 INFO - PROCESS | 18426 | Values: 439.0 448.9 460.8 482.5 499.0 32791.8 33160.5 33191.2 33245.3 33291.3 35951.6 36471.0 36544.6 36587.8 36681.3 7608.4 7783.7 7806.8 7807.1 7832.3 7526.0 7667.4 7688.9 7701.0 7728.5 7836.8 7890.8 7906.4 7924.9 7935.7 7844.8 7848.9 7888.0 7889.2 7914.2 7816.9 7914.2 7925.6 7945.4 7952.8 36845.8 37203.6 37281.3 37337.6 37547.2 2153.6 2615.5 2821.7 3159.5 3417.2 24349.6 26328.5 27075.5 27385.2 28258.4 3038.9 3059.4 3068.1 3077.2 3113.8 218471.0 219183.0 220127.0 220955.0 221057.0 54622.0 54793.7 54843.2 54939.5 55250.0 56837.4 57491.4 57798.0 58050.4 58103.1 11399.1 11479.0 11512.7 11560.2 11574.9 9387.0 9457.3 9503.6 9545.0 9568.1 18853.0 19108.6 19120.1 19145.0 19154.9 7417.1 7601.3 7652.2 7652.8 7683.8 820.6 873.9 882.9 910.0 932.8 26066.5 26339.9 26481.0 26543.2 28484.4 925.0 958.2 969.5 999.7 1052.5 13346.0 13722.0 14013.9 14070.6 14076.0 296917.0 363009.0 365911.0 370174.0 371169.0 43253.6 43444.0 43594.6 43634.6 43700.0 1204.1 1210.1 1219.6 1227.8 1248.2 27030.0 27940.9 28367.3 28707.1 28756.6 40060.8 40590.4 40729.8 40747.4 40900.0 243214.0 248574.0 249176.0 249226.0 250988.0 29539.7 29896.1 29965.4 29969.4 30011.7 38620.2 39124.2 39381.8 39637.0 40178.4 33033.8 33976.0 34096.3 34193.5 34625.7 33373.3 34021.0 34213.3 34552.3 34617.0 26752.9 32376.8 32848.5 34007.7 34234.0 25954.4 26306.1 26436.0 26804.7 27247.5 21346.9 21415.6 22891.2 22975.7 25372.0 23:14:48 INFO - PROCESS | 18426 | 23:14:48 INFO - PROCESS | 18426 | [#2] jquery.html Cycles:180 Average:22124.80 Median:5039.07 stddev:59327.91 (1177.4%) stddev-sans-first:59471.76 23:14:48 INFO - PROCESS | 18426 | Values: 324.6 325.9 326.7 330.1 334.5 15150.5 15230.8 15737.8 16650.3 16670.5 14751.7 15118.5 15182.8 15462.1 15768.7 4911.3 5115.7 5128.4 5145.1 5153.5 4844.2 4955.0 5091.1 5093.3 5126.6 5032.2 5033.8 5037.4 5056.7 5068.7 4890.0 4989.2 5024.4 5033.1 5040.7 4430.3 4437.4 4441.8 4443.6 4463.9 18491.5 18586.3 18702.6 19291.6 19379.1 1596.1 1720.6 1793.1 1933.9 2537.1 8122.8 8625.5 8630.8 9028.3 9305.2 1739.1 1754.8 1777.9 1786.4 1798.0 55879.7 57894.7 58598.7 59850.4 60324.0 9400.9 9433.4 9474.0 9483.9 9579.8 11814.2 11931.6 11942.3 11974.8 11978.0 6075.2 6093.5 6251.8 6353.9 6364.7 5771.5 5778.9 5784.3 5832.2 5840.9 3931.2 3971.5 3978.5 3986.8 4010.9 1623.2 1723.3 1767.5 1773.5 1809.9 833.2 852.5 895.1 898.6 962.7 14597.3 15011.0 15495.6 15702.9 16215.9 816.4 821.1 836.0 841.0 843.7 8866.5 8969.6 9104.7 9175.9 9201.5 354917.0 355496.0 359586.0 363780.0 367523.0 67000.7 67375.3 67528.0 67581.0 68528.7 891.6 933.6 941.6 943.6 946.6 14622.1 14623.9 14671.1 14680.5 14792.1 32721.4 33361.8 33491.2 33959.0 34323.5 46868.0 47447.3 47485.8 47662.6 47681.0 6852.3 6909.9 6996.8 7034.8 7081.3 10001.8 10143.5 10339.7 10356.7 10459.6 8686.2 8912.1 9079.4 9379.6 9442.0 8920.4 8950.0 9099.1 9215.8 9496.3 9079.9 9222.8 9300.5 9421.7 10063.9 6776.2 7135.2 7244.4 7263.0 7302.3 6456.9 8240.3 9614.7 9713.7 9728.2 23:14:48 INFO - PROCESS | 18426 | 23:14:48 INFO - PROCESS | 18426 | [#3] mootools.html Cycles:180 Average:4938.62 Median:5738.91 stddev:2636.41 (45.9%) stddev-sans-first:2629.86 23:14:48 INFO - PROCESS | 18426 | Values: 1330.7 1338.0 1431.7 1652.0 1653.9 5965.2 7102.1 7118.7 7304.5 7346.4 7131.7 7228.1 7252.5 7277.3 7296.5 2081.6 2106.0 2109.1 2112.7 2120.4 2076.7 2102.2 2117.5 2119.2 2124.6 2086.9 2100.9 2120.9 2129.6 2129.9 2069.3 2081.7 2090.4 2090.7 2092.0 2045.3 2071.9 2084.8 2085.2 2087.6 7412.4 7422.8 7430.0 7446.9 7495.5 4041.5 4128.9 4149.6 4164.9 4168.1 2630.5 2656.7 2699.2 2713.8 2716.9 851.2 855.1 855.8 875.6 885.6 10101.4 10156.3 10176.8 10211.2 10271.7 3988.4 4035.2 4099.7 4116.3 4120.8 8657.2 8659.4 8669.0 8717.1 8734.4 4251.1 4267.2 4273.6 4282.9 4312.9 3086.3 3602.7 3665.2 3838.8 3838.9 3388.3 3413.5 3415.3 3427.5 3429.6 1081.0 1115.5 1125.8 1126.6 1128.0 950.7 963.6 1104.1 1109.1 1116.0 6411.7 6426.9 6451.8 6457.8 6459.3 435.1 436.8 443.2 443.5 446.2 4934.1 4950.9 4957.4 4964.9 5009.3 8309.8 8818.3 8823.8 8844.7 8877.2 8639.8 8654.1 8671.1 8723.2 8726.7 6585.2 6739.6 6774.5 6775.9 6821.4 6206.8 6212.1 6239.9 6242.5 6252.5 7445.0 7663.7 7760.5 7780.4 7814.1 7812.6 7827.0 7974.9 7978.6 8012.4 5403.7 5934.3 6100.1 6201.4 6282.6 6610.2 6679.4 6683.1 6689.5 6692.7 5870.9 5990.0 6066.5 6071.4 6117.5 5846.4 5880.2 5975.0 5986.7 6035.8 6039.8 6183.1 6189.7 6202.8 6212.1 5665.7 5703.9 5712.3 5714.4 5721.8 5668.5 5729.5 5748.3 5770.6 5838.0 23:14:48 INFO - PROCESS | 18426 | 23:14:48 INFO - PROCESS | 18426 | [#4] prototype.html Cycles:180 Average:4899.13 Median:5663.78 stddev:1485.24 (26.2%) stddev-sans-first:1448.82 23:14:48 INFO - PROCESS | 18426 | Values: 305.2 307.3 309.5 310.2 315.6 5600.9 5614.3 5665.4 5728.0 5763.8 5646.2 5647.0 5660.2 5662.1 5695.6 4048.5 4170.4 4248.1 4266.2 4330.1 4311.3 4325.9 4337.8 4344.5 4348.5 4298.1 4299.1 4304.2 4306.7 4312.6 4291.8 4309.2 4313.2 4317.8 4322.2 3760.1 3768.2 3773.9 3776.5 3778.8 5444.9 5446.4 5447.3 5449.1 5463.9 4667.2 4846.6 4874.7 4902.4 4962.6 5894.2 5907.8 5917.7 5918.1 5920.1 3956.5 3963.3 3971.8 3981.1 3981.4 6166.7 6259.5 6266.5 6286.1 6365.4 4105.3 4109.1 4109.7 4118.7 4125.9 4176.9 4179.2 4181.1 4182.1 4184.6 4606.0 4725.1 4742.3 4749.1 4756.7 5847.9 5935.6 5944.5 5950.9 5962.7 1450.1 1455.3 1458.5 1468.4 1468.9 949.9 961.5 962.2 968.7 972.1 5058.9 5095.1 5101.5 5115.2 5122.2 6185.5 6192.8 6195.3 6196.4 6199.4 4996.0 5115.0 5118.3 5123.8 5188.6 3335.8 3346.8 3370.5 3376.7 3380.6 5821.9 5831.5 5834.5 5835.7 5850.8 6417.4 6444.6 6456.8 6469.9 6480.2 5830.1 5830.2 5833.9 5844.4 5853.9 6100.6 6215.6 6264.2 6276.9 6279.3 6071.4 6089.4 6095.0 6113.9 6123.3 5798.1 5804.8 5813.3 5829.7 5831.7 3987.5 4014.9 4036.7 4046.3 4058.6 6216.8 6219.9 6230.5 6250.0 6259.1 5733.6 5981.1 5996.0 5996.9 6026.2 5974.5 5974.7 5985.9 5994.4 5996.2 5849.5 5852.7 5860.2 5863.9 5866.1 6019.8 6042.8 6044.9 6056.0 6062.2 5736.9 5826.2 5872.6 5887.0 5899.7 23:14:48 INFO - PROCESS | 18426 | 23:14:48 INFO - PROCESS | 18426 | [#5] yui.html Cycles:180 Average:11520.62 Median:46072.89 stddev:12848.91 (27.9%) stddev-sans-first:12858.42 23:14:48 INFO - PROCESS | 18426 | Values: 524.7 528.2 641.5 671.4 679.7 9710.0 10192.6 10498.3 10614.5 11496.7 12272.1 12275.6 12289.0 12343.7 12386.7 757.3 775.0 776.9 777.6 777.7 759.7 766.8 769.3 769.7 772.5 789.8 793.2 795.8 795.9 798.9 781.1 782.7 784.3 785.1 786.8 588.0 588.0 588.3 588.7 590.2 10796.7 10807.8 10832.6 11222.1 11577.5 10671.9 10755.5 11157.5 11319.1 11470.9 8577.7 8696.9 8756.3 8815.8 8824.9 3644.9 3665.7 3677.3 3704.3 3710.1 37003.3 37012.4 37163.0 37189.0 37315.0 8333.6 8396.1 8431.8 8586.1 8680.0 14585.3 15369.4 15405.4 15418.7 15478.4 6137.8 6175.8 6191.2 6212.1 6482.8 3015.4 3095.6 3125.3 3180.1 3494.3 2400.7 2458.4 2504.4 2515.9 2548.9 482.4 483.1 488.2 488.7 494.9 517.2 529.5 532.5 536.3 543.5 6643.6 6663.2 6701.2 6708.4 6744.9 430.5 526.5 532.7 545.3 553.6 3187.1 3228.2 3274.3 3282.9 3288.6 45599.1 45949.8 46196.0 46943.0 47690.8 39107.8 39683.8 39860.6 39908.2 40040.0 35814.6 36380.5 36669.0 36701.6 36764.6 7184.4 7222.6 7302.0 7327.9 7411.6 30127.0 30228.7 31110.5 31338.7 31696.8 38505.4 38842.6 39417.2 39452.6 39700.6 9037.0 9103.6 9155.0 9229.4 9264.4 10391.8 10419.2 10728.3 10895.6 11049.3 10192.2 10257.4 10738.3 10954.5 11056.2 10000.0 10502.1 10571.5 10681.5 11041.0 9998.2 10052.8 10141.7 10275.8 10315.5 8333.8 8428.7 8719.8 8789.6 8946.6 8635.8 8917.7 8964.0 8994.9 9087.0 23:14:48 INFO - PROCESS | 18426 | -------- Summary: end -------- 23:14:48 INFO - PROCESS | 18426 | 23:14:49 INFO - TEST-INFO | 18426: exit 0 23:14:49 INFO - TEST-OK | dromaeo_css | took 1112449ms 23:14:49 INFO - TEST-START | kraken 23:14:49 INFO - operating with platform_type : linux_ 23:14:49 INFO - Initialising browser for kraken test... 23:14:49 INFO - TEST-INFO | started process 18663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjlTmWk/profile http://localhost:59700/getInfo.html) 23:14:52 INFO - PROCESS | 18663 | 23:14:52 INFO - PROCESS | 18663 | (process:18735): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:14:53 INFO - PROCESS | 18663 | __metrics Screen width/height:1600/1200 23:14:53 INFO - PROCESS | 18663 | colorDepth:24 23:14:53 INFO - PROCESS | 18663 | Browser inner width/height: 1024/697 23:14:53 INFO - PROCESS | 18663 | __metrics 23:14:54 ERROR - PROCESS | 18663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 23:14:55 INFO - TEST-INFO | 18663: exit 0 23:14:55 INFO - Browser initialized. 23:14:55 INFO - Running cycle 1/1 for kraken test... 23:14:55 INFO - TEST-INFO | started process 18786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjlTmWk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:56 INFO - PROCESS | 18786 | 23:14:56 INFO - PROCESS | 18786 | (process:18842): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:15:06 INFO - PROCESS | 18786 | RSS: Main: 159993856 23:15:06 INFO - PROCESS | 18786 | 23:15:09 INFO - PROCESS | 18786 | Cycle 1(1): loaded http://localhost:59700/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59700/tests/kraken/driver.html?testName=audio-beat-detection) 23:15:10 INFO - PROCESS | 18786 | RSS: Main: 166985728 23:15:10 INFO - PROCESS | 18786 | 23:15:12 INFO - PROCESS | 18786 | Cycle 1(1): loaded http://localhost:59700/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59700/tests/kraken/driver.html?testName=audio-dft) 23:15:13 INFO - PROCESS | 18786 | RSS: Main: 169254912 23:15:13 INFO - PROCESS | 18786 | 23:15:16 INFO - PROCESS | 18786 | Cycle 1(1): loaded http://localhost:59700/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59700/tests/kraken/driver.html?testName=audio-fft) 23:15:16 INFO - PROCESS | 18786 | RSS: Main: 164659200 23:15:16 INFO - PROCESS | 18786 | 23:15:18 INFO - PROCESS | 18786 | Cycle 1(1): loaded http://localhost:59700/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59700/tests/kraken/driver.html?testName=audio-oscillator) 23:15:19 INFO - PROCESS | 18786 | RSS: Main: 165498880 23:15:19 INFO - PROCESS | 18786 | 23:15:21 INFO - PROCESS | 18786 | Cycle 1(1): loaded http://localhost:59700/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59700/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:15:22 INFO - PROCESS | 18786 | RSS: Main: 163536896 23:15:22 INFO - PROCESS | 18786 | 23:15:25 INFO - PROCESS | 18786 | Cycle 1(1): loaded http://localhost:59700/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59700/tests/kraken/driver.html?testName=imaging-darkroom) 23:15:25 INFO - PROCESS | 18786 | RSS: Main: 165003264 23:15:25 INFO - PROCESS | 18786 | 23:15:29 INFO - PROCESS | 18786 | Cycle 1(1): loaded http://localhost:59700/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59700/tests/kraken/driver.html?testName=imaging-desaturate) 23:15:30 INFO - PROCESS | 18786 | RSS: Main: 162832384 23:15:30 INFO - PROCESS | 18786 | 23:15:32 INFO - PROCESS | 18786 | Cycle 1(1): loaded http://localhost:59700/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59700/tests/kraken/driver.html?testName=json-parse-financial) 23:15:33 INFO - PROCESS | 18786 | RSS: Main: 163233792 23:15:33 INFO - PROCESS | 18786 | 23:15:35 INFO - PROCESS | 18786 | Cycle 1(1): loaded http://localhost:59700/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59700/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:15:35 INFO - PROCESS | 18786 | RSS: Main: 162287616 23:15:35 INFO - PROCESS | 18786 | 23:15:37 INFO - PROCESS | 18786 | Cycle 1(1): loaded http://localhost:59700/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59700/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:15:38 INFO - PROCESS | 18786 | RSS: Main: 162263040 23:15:38 INFO - PROCESS | 18786 | 23:15:40 INFO - PROCESS | 18786 | Cycle 1(1): loaded http://localhost:59700/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59700/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:15:40 INFO - PROCESS | 18786 | RSS: Main: 164294656 23:15:40 INFO - PROCESS | 18786 | 23:15:43 INFO - PROCESS | 18786 | Cycle 1(1): loaded http://localhost:59700/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:15:44 INFO - PROCESS | 18786 | RSS: Main: 164130816 23:15:44 INFO - PROCESS | 18786 | 23:15:46 INFO - PROCESS | 18786 | Cycle 1(1): loaded http://localhost:59700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:15:47 INFO - PROCESS | 18786 | RSS: Main: 163602432 23:15:47 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | Cycle 1(1): loaded http://localhost:59700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59700/tests/kraken/driver.html?testName=ai-astar) 23:15:49 INFO - PROCESS | 18786 | RSS: Main: 163938304 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | __start_tp_report 23:15:49 INFO - PROCESS | 18786 | _x_x_mozilla_page_load 23:15:49 INFO - PROCESS | 18786 | _x_x_mozilla_page_load_details 23:15:49 INFO - PROCESS | 18786 | |i|pagename|runs| 23:15:49 INFO - PROCESS | 18786 | |0;ai-astar;116;112;114;115;116;126;116;115;116;124 23:15:49 INFO - PROCESS | 18786 | |1;audio-beat-detection;165;141;162;183;139;156;156;142;184;139 23:15:49 INFO - PROCESS | 18786 | |2;audio-dft;167;165;164;167;165;164;166;179;167;163 23:15:49 INFO - PROCESS | 18786 | |3;audio-fft;78;74;78;75;75;129;74;74;78;76 23:15:49 INFO - PROCESS | 18786 | |4;audio-oscillator;97;97;129;96;98;96;133;97;98;132 23:15:49 INFO - PROCESS | 18786 | |5;imaging-gaussian-blur;120;119;118;119;120;120;119;120;119;120 23:15:49 INFO - PROCESS | 18786 | |6;imaging-darkroom;150;149;149;150;149;150;149;153;150;151 23:15:49 INFO - PROCESS | 18786 | |7;imaging-desaturate;97;98;99;100;98;97;97;97;98;98 23:15:49 INFO - PROCESS | 18786 | |8;json-parse-financial;69;69;69;67;69;68;69;76;67;67 23:15:49 INFO - PROCESS | 18786 | |9;json-stringify-tinderbox;72;74;72;73;72;72;73;72;72;72 23:15:49 INFO - PROCESS | 18786 | |10;stanford-crypto-aes;87;87;88;88;90;89;89;89;88;91 23:15:49 INFO - PROCESS | 18786 | |11;stanford-crypto-ccm;128;132;150;136;135;139;133;137;133;128 23:15:49 INFO - PROCESS | 18786 | |12;stanford-crypto-pbkdf2;160;153;158;157;150;147;162;162;157;146 23:15:49 INFO - PROCESS | 18786 | |13;stanford-crypto-sha256-iterative;76;75;73;75;74;72;74;73;74;73 23:15:49 INFO - PROCESS | 18786 | __end_tp_report 23:15:49 INFO - PROCESS | 18786 | __start_cc_report 23:15:49 INFO - PROCESS | 18786 | _x_x_mozilla_cycle_collect,765 23:15:49 INFO - PROCESS | 18786 | __end_cc_report 23:15:49 INFO - PROCESS | 18786 | __startTimestamp1457075749418__endTimestamp 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | ------- Summary: start ------- 23:15:49 INFO - PROCESS | 18786 | Number of tests: 14 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | [#0] ai-astar Cycles:10 Average:117.00 Median:116.00 stddev:4.42 (3.8%) stddev-sans-first:4.68 23:15:49 INFO - PROCESS | 18786 | Values: 116.0 112.0 114.0 115.0 116.0 126.0 116.0 115.0 116.0 124.0 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | [#1] audio-beat-detection Cycles:10 Average:156.70 Median:159.00 stddev:17.08 (10.7%) stddev-sans-first:17.85 23:15:49 INFO - PROCESS | 18786 | Values: 165.0 141.0 162.0 183.0 139.0 156.0 156.0 142.0 184.0 139.0 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | [#2] audio-dft Cycles:10 Average:166.70 Median:166.50 stddev:4.55 (2.7%) stddev-sans-first:4.82 23:15:49 INFO - PROCESS | 18786 | Values: 167.0 165.0 164.0 167.0 165.0 164.0 166.0 179.0 167.0 163.0 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.50 stddev:16.91 (22.4%) stddev-sans-first:17.90 23:15:49 INFO - PROCESS | 18786 | Values: 78.0 74.0 78.0 75.0 75.0 129.0 74.0 74.0 78.0 76.0 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:97.00 stddev:16.63 (17.1%) stddev-sans-first:17.21 23:15:49 INFO - PROCESS | 18786 | Values: 97.0 97.0 129.0 96.0 98.0 96.0 133.0 97.0 98.0 132.0 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | [#5] imaging-gaussian-blur Cycles:10 Average:119.40 Median:120.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 23:15:49 INFO - PROCESS | 18786 | Values: 120.0 119.0 118.0 119.0 120.0 120.0 119.0 120.0 119.0 120.0 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 23:15:49 INFO - PROCESS | 18786 | Values: 150.0 149.0 149.0 150.0 149.0 150.0 149.0 153.0 150.0 151.0 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:98.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 23:15:49 INFO - PROCESS | 18786 | Values: 97.0 98.0 99.0 100.0 98.0 97.0 97.0 97.0 98.0 98.0 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | [#8] json-parse-financial Cycles:10 Average:69.00 Median:69.00 stddev:2.62 (3.8%) stddev-sans-first:2.78 23:15:49 INFO - PROCESS | 18786 | Values: 69.0 69.0 69.0 67.0 69.0 68.0 69.0 76.0 67.0 67.0 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:72.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 23:15:49 INFO - PROCESS | 18786 | Values: 72.0 74.0 72.0 73.0 72.0 72.0 73.0 72.0 72.0 72.0 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:89.00 stddev:1.26 (1.4%) stddev-sans-first:1.20 23:15:49 INFO - PROCESS | 18786 | Values: 87.0 87.0 88.0 88.0 90.0 89.0 89.0 89.0 88.0 91.0 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:135.50 stddev:6.33 (4.7%) stddev-sans-first:6.17 23:15:49 INFO - PROCESS | 18786 | Values: 128.0 132.0 150.0 136.0 135.0 139.0 133.0 137.0 133.0 128.0 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:157.50 stddev:5.90 (3.7%) stddev-sans-first:6.00 23:15:49 INFO - PROCESS | 18786 | Values: 160.0 153.0 158.0 157.0 150.0 147.0 162.0 162.0 157.0 146.0 23:15:49 INFO - PROCESS | 18786 | 23:15:49 INFO - PROCESS | 18786 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:74.00 stddev:1.20 (1.6%) stddev-sans-first:1.00 23:15:49 INFO - PROCESS | 18786 | Values: 76.0 75.0 73.0 75.0 74.0 72.0 74.0 73.0 74.0 73.0 23:15:49 INFO - PROCESS | 18786 | -------- Summary: end -------- 23:15:49 INFO - PROCESS | 18786 | 23:15:50 INFO - TEST-INFO | 18786: exit 0 23:15:50 INFO - TEST-OK | kraken | took 61110ms 23:15:50 INFO - SUITE-END | took 1173s 23:15:50 INFO - Completed test suite (00:19:33) 23:15:50 INFO - Working with test: dromaeo_css 23:15:50 INFO - Generating results file: dromaeo_css 23:15:50 INFO - Working with test: kraken 23:15:50 INFO - Generating results file: kraken 23:15:50 INFO - javascript benchmark 23:15:50 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:15:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 23:15:50 INFO - process_Request line: dromaeo_css 6145.38 graph.html#tests=[[72,132,43]] 23:15:50 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:15:50 INFO - process_Request line: kraken 1590.30 graph.html#tests=[[232,132,43]] 23:15:50 INFO - RETURN: dromaeo_css: 6145.38 23:15:50 INFO - RETURN: kraken: 1590.30 23:15:50 INFO - javascript benchmark 23:15:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2602.843829370238, 2611.360216746897, 2675.224184986354, 2678.3973605938677, 2688.0726149478423, 4486.6410687145035, 4685.273782563704, 4722.527747225276, 4731.030138821542, 4748.406449193851, 4534.5465453454635, 4674.719516828993, 4708.317293992378, 4716.575508204261, 4754.833580824672, 4297.419848320468, 4354.238008348542, 4380.408644832954, 4382.342648602703, 4382.430284063067, 58.36521092112079, 4253.510846252674, 4338.544452832454, 4371.956280437203, 4397.516273209944, 4330.631896288804, 4363.869083927487, 4371.016521282718, 4403.867883963486, 4404.581564751344, 4161.687873409476, 4315.8273669053515, 4339.913201735948, 4373.650107991353, 4430.490493593245, 4282.914341713179, 4287.678424118204, 4311.943573824402, 4328.0, 4347.847825326098, 4492.415985921842, 4597.862064138081, 4620.191466493384, 4656.674032817704, 4686.156491831469, 4815.15734746418, 4978.004399120155, 4993.126202914512, 5010.874728131826, 5014.24786282057, 4983.950160498421, 4990.72551009698, 5001.024800163969, 5007.148784706608, 5053.898922021575, 4652.674312798105, 4657.836975705834, 4659.5806377425515, 4671.346011558385, 4692.601128904047, 4957.529034741694, 5023.497650234947, 5101.132807422747, 5106.974465127651, 5153.587712982952, 4898.926516102261, 4913.091078150554, 4917.827876024322, 4940.036692844933, 4940.530649588283, 4989.975050124726, 4992.950070499322, 4997.950020499821, 5005.849824505271, 5006.774695138727, 4601.378813860153, 4910.950890491121, 4973.179425394842, 4978.054169707744, 4995.325631039763, 4736.005438857809, 4871.634627402888, 4909.803607855717, 4930.087933732271, 5000.774965126578, 4132.318167502389, 4139.565345638664, 4168.312228482328, 4190.832366705297, 4203.07532342884, 3499.9300014000087, 3550.946735798965, 3650.379435495972, 3692.464592634107, 3722.813859307078, 4324.0, 4333.458317710286, 4345.217860785026, 4346.1090476452255, 4380.14587155508, 4990.951900101019, 5035.068512325159, 5049.545540901337, 5063.974680126576, 5087.008033433445, 4190.497140343117, 4317.805698743564, 4356.411884395566, 4389.122175564899, 4398.164348773723, 4427.490838553607, 4442.8222871085445, 4443.266860967904, 4449.354843547668, 4469.374287599739, 4520.4575450946095, 4713.6936099153445, 4726.621870250372, 4739.123262196574, 4778.402699662543, 4965.503449655005, 5016.0, 5019.874503137451, 5021.096202683552, 5051.772670229775, 4677.391939047902, 4697.976510117427, 4700.8119675213975, 4711.0, 4763.976180119077, 4759.428868535798, 4896.387951506062, 4903.239997800347, 4917.213245880642, 4976.0794253063295, 4954.157793175241, 4970.900581988412, 4976.452590215146, 4980.750962451935, 5026.472220416804, 4791.856244312677, 4805.399325084364, 4812.711237325771, 4821.710697358169, 4891.070696567641, 4656.697314674535, 4744.074905393415, 4792.544708252711, 4848.981713840133, 4869.074875773592, 4560.019595786922, 4710.858674239778, 4712.740799256074, 4783.1390349737385, 4796.184648609815, 4812.951870481251, 4914.041761856547, 4928.926066108939, 4942.777575009061, 4959.13215187348, 4804.711717296974, 4812.868975790617, 4820.758962051813, 4861.149298872754, 4905.754712264444], "unit": "score", "name": "dojo.html", "value": 4547.863779476185}, {"lowerIsBetter": false, "replicates": [438.95528641832436, 448.9472187719798, 460.8088092281452, 482.49338194895364, 498.97255650939206, 32791.83604081979, 33160.50259246113, 33191.17022074446, 33245.33509329812, 33291.33417331652, 35951.640483595154, 36471.0, 36544.634553654454, 36587.81706091473, 36681.26637467256, 7608.391328693705, 7783.688652453923, 7806.843863122735, 7807.141214466405, 7832.334251588622, 7525.962370188141, 7667.386609071261, 7688.884666730003, 7701.037370328709, 7728.497647652885, 7836.764897053097, 7890.802729931769, 7906.367490600738, 7924.920750792505, 7935.722249721261, 7844.764657060297, 7848.921510784905, 7887.960560197191, 7889.211078892123, 7914.169012253688, 7816.8827467588035, 7914.169012253688, 7925.564093974829, 7945.364370850318, 7952.801179970489, 36845.81577092098, 37203.62796372029, 37281.25437491262, 37337.62662373396, 37547.24905501902, 2153.558520503293, 2615.4899794540074, 2821.661400631917, 3159.526071089332, 3417.2140407706365, 24349.63475547868, 26328.47343053128, 27075.458490830075, 27385.17844464669, 28258.434831303464, 3038.9088327350214, 3059.3575349176476, 3068.1255842084897, 3077.1537827097504, 3113.7664675149226, 218471.0, 219183.0, 220127.0, 220955.0, 221057.0, 54622.0, 54793.72603136959, 54843.17735233975, 54939.45060549343, 55250.0, 56837.43162568404, 57491.42508574944, 57798.0, 58050.41949580535, 58103.12845307324, 11399.088072954144, 11479.0, 11512.712182195344, 11560.190786645022, 11574.942125289488, 9386.95306523463, 9457.33798634089, 9503.57233924475, 9545.0, 9568.091031352149, 18853.0, 19108.617827643367, 19120.139593718315, 19145.0, 19154.904225478782, 7417.109946806418, 7601.277878601524, 7652.1582625911105, 7652.7704168875025, 7683.8474228865, 820.6266148902235, 873.8776571280026, 882.9028806831243, 909.9590518426687, 932.7668082979255, 26066.478670426484, 26339.868300658374, 26481.0, 26543.203703888914, 28484.430311393655, 924.9815003699888, 958.1999030809213, 969.5055521683851, 999.6850991937662, 1052.4632437456798, 13346.0, 13722.0, 14013.859861401255, 14070.577882663536, 14076.0, 296917.0, 363009.0, 365911.0, 370174.0, 371169.0, 43253.56746432495, 43444.0, 43594.56405435968, 43634.56365436305, 43700.0, 1204.0548169686929, 1210.056156198167, 1219.6341097670663, 1227.79127548317, 1248.2385744695728, 27030.0, 27940.860295699204, 28367.29081772972, 28707.138785836458, 28756.568651469825, 40060.79969600133, 40590.39114413227, 40729.796351018056, 40747.38878916759, 40900.0, 243214.0, 248574.0, 249176.0, 249226.0, 250988.0, 29539.704602953694, 29896.103116906528, 29965.400691986473, 29969.400611988076, 30011.69988300089, 38620.22759544737, 39124.217515650096, 39381.80309098436, 39637.00907477336, 40178.39732404075, 33033.83483082569, 33976.0, 34096.31807363888, 34193.48709769405, 34625.653743462244, 33373.33253334968, 34021.0, 34213.31573368469, 34552.30895382028, 34617.0, 26752.866235669477, 32376.83811580927, 32848.50727239045, 34007.659923401436, 34234.0, 25954.35114122162, 26306.079287224857, 26436.0, 26804.731952680224, 27247.45505089927, 21346.893265533574, 21415.57168856583, 22891.198808041638, 22975.65536516987, 25372.0], "unit": "score", "name": "ext.html", "value": 16528.45335952611}, {"lowerIsBetter": false, "replicates": [324.559313959028, 325.87453830275336, 326.73207969465034, 330.1416317574306, 334.4598473465351, 15150.469733559314, 15230.847691523082, 15737.84262157378, 16650.250738716757, 16670.49988500344, 14751.704965900675, 15118.546443606681, 15182.84817151831, 15462.149581772997, 15768.65966392855, 4911.263310503436, 5115.667481613683, 5128.384593848743, 5145.125328694131, 5153.484651534835, 4844.249141383074, 4954.97522512387, 5091.058154241458, 5093.337866077405, 5126.589872810185, 5032.194848824189, 5033.773480193382, 5037.4458809530925, 5056.747162641872, 5068.670536415139, 4889.9511004889855, 4989.226669866195, 5024.422191447994, 5033.144365457881, 5040.697558146487, 4430.26900561407, 4437.445319335083, 4441.844535441276, 4443.600075993176, 4463.888402789924, 18491.537711557183, 18586.256549737995, 18702.625947480974, 19291.61416771657, 19379.127939242768, 1596.1221328269405, 1720.60426101996, 1793.1213705284447, 1933.8839669619867, 2537.1373732930892, 8122.837543249161, 8625.525596092213, 8630.827383452295, 9028.322875784343, 9305.162535371848, 1739.1391261325598, 1754.8157443468508, 1777.8844375115575, 1786.3926265069938, 1797.9640407191914, 55879.72060139673, 57894.710526447096, 58598.70700646512, 59850.401495984916, 60324.0, 9400.90599094014, 9433.386829856037, 9474.0, 9483.905160948303, 9579.760505987406, 11814.173007889365, 11931.582394616147, 11942.283462992249, 11974.760504789856, 11978.0, 6075.2405949256345, 6093.512518998469, 6251.812445626639, 6353.936460635427, 6364.745410183634, 5771.538276937835, 5778.884422311614, 5784.2769653793275, 5832.212651292021, 5840.941590584125, 3931.2137572485617, 3971.4638523799495, 3978.462907507507, 3986.820593073319, 4010.9197816044098, 1623.2127418202163, 1723.293449685648, 1767.469759072273, 1773.4679596121111, 1809.9457016289532, 833.2292629317857, 852.5098068610449, 895.1227796759213, 898.60910503931, 962.7304354780673, 14597.270136493345, 15011.0, 15495.612609684622, 15702.921485392728, 16215.918920405322, 816.4285000499674, 821.1049955548481, 835.9707410240612, 840.9747707568782, 843.6709683223547, 8866.512341821133, 8969.578213882216, 9104.726858194264, 9175.862362064574, 9201.493917834583, 354917.0, 355496.0, 359586.0, 363780.0, 367523.0, 67000.6649966747, 67375.32624673788, 67528.0, 67581.0, 68528.6573567129, 891.5898686604235, 933.6135838280013, 941.5527624378502, 943.5895385507326, 946.5835032585641, 14622.122672639676, 14623.92688036553, 14671.119732816065, 14680.486182983544, 14792.11247325164, 32721.382289416313, 33361.83319083389, 33491.162720932174, 33959.0, 34323.4851477233, 46868.0, 47447.28829067498, 47485.762571186926, 47662.570122896366, 47681.0, 6852.280510546321, 6909.861802764017, 6996.825079373057, 7034.824129396806, 7081.291870812877, 10001.849972250568, 10143.543540540546, 10339.689809305733, 10356.689299321033, 10459.633912813015, 8686.232321770065, 8912.131176990093, 9079.409838360485, 9379.624815007597, 9441.96138424759, 8920.420172688755, 8950.0, 9099.135582119688, 9215.769605759642, 9496.287778416785, 9079.909200907907, 9222.815543688954, 9300.488473134043, 9421.717348479557, 10063.949680251844, 6776.186857577122, 7135.179454362815, 7244.384227340735, 7263.0, 7302.306280903305, 6456.9354306456335, 8240.299574536231, 9614.71155865325, 9713.660021899199, 9728.22174226046], "unit": "score", "name": "jquery.html", "value": 7551.711827731535}, {"lowerIsBetter": false, "replicates": [1330.7005923667173, 1337.973240535189, 1431.7422863884497, 1652.0418157468669, 1653.9173041347929, 5965.164876917235, 7102.076730025103, 7118.679659415326, 7304.5252058616215, 7346.37555807757, 7131.679074441649, 7228.096487939008, 7252.45606579506, 7277.308655677715, 7296.489245752786, 2081.5628717969244, 2106.0, 2109.1457959526338, 2112.6725357569526, 2120.3532922458644, 2076.7300250967355, 2102.1591363454586, 2117.5129720164373, 2119.162930642395, 2124.5538436928264, 2086.8747875127465, 2100.90545925433, 2120.936371908845, 2129.606022885763, 2129.9467513312215, 2069.317125348631, 2081.6565266730972, 2090.383336915598, 2090.7386576677914, 2092.0272073485903, 2045.263705066175, 2071.9482012949647, 2084.801943815335, 2085.238887805955, 2087.5720477302116, 7412.4440666950195, 7422.777316680508, 7430.034095567596, 7446.888296675555, 7495.475316727831, 4041.5150181978056, 4128.938065929014, 4149.605787450188, 4164.937525937114, 4168.124693814302, 2630.487055024271, 2656.721044290341, 2699.217227004186, 2713.8236014658983, 2716.904908328219, 851.1871163039283, 855.0594346219171, 855.8446097767963, 875.5665945357089, 885.6103314541581, 10101.444420556867, 10156.339837910513, 10176.796464070678, 10211.234157438223, 10271.691849244535, 3988.4017397390626, 4035.2333056719717, 4099.692523060782, 4116.300228961084, 4120.814563344657, 8657.177568131017, 8659.437136586102, 8669.0, 8717.128287171232, 8734.388592798443, 4251.086016506466, 4267.1679022590915, 4273.594008569181, 4282.8715138545895, 4312.870613881589, 3086.2901532647616, 3602.7297952653657, 3665.2119794244363, 3838.846446142179, 3838.9424158637644, 3388.271521622863, 3413.5050417689295, 3415.316936612687, 3427.537282466885, 3429.605595356566, 1080.9838751573495, 1115.4590023838432, 1125.7523344864117, 1126.6338440006866, 1128.0186237972853, 950.6720181537358, 963.6386355116831, 1104.0780947908427, 1109.0794640448569, 1116.0457808573715, 6411.679416029273, 6426.903596446057, 6451.806445806634, 6457.806265812033, 6459.289478157399, 435.14928315143817, 436.75105190042007, 443.16242302049153, 443.48998651550977, 446.2324801341687, 4934.1118598651865, 4950.925736113961, 4957.429895561984, 4964.925526117111, 5009.298698182258, 8309.750707478664, 8818.33862460318, 8823.779405514784, 8844.690435834715, 8877.201051905231, 8639.78400539979, 8654.134586541422, 8671.089535598798, 8723.214910657944, 8726.738197854074, 6585.2426970898005, 6739.5619284746335, 6774.491913106537, 6775.898361524482, 6821.420179284717, 6206.751729930752, 6212.099245609452, 6239.875202495834, 6242.531810114168, 6252.468540174136, 7445.0, 7663.655135519027, 7760.456768026184, 7780.416468764752, 7814.101378341336, 7812.609369531387, 7826.960865195865, 7974.880376794469, 7978.561179135203, 8012.439129260896, 5403.729813509231, 5934.287885453773, 6100.08498725177, 6201.441870231701, 6282.623042617458, 6610.2398224204835, 6679.398854103154, 6683.064370988162, 6689.49828762835, 6692.732290708317, 5870.9412905870395, 5990.0, 6066.4540191382985, 6071.392860713893, 6117.480014198843, 5846.386129456346, 5880.176775251382, 5975.0, 5986.6707331097205, 6035.78874739382, 6039.849003774941, 6183.134361189527, 6189.690515474118, 6202.751889924352, 6212.130301757667, 5665.745041473061, 5703.857403564778, 5712.34308054579, 5714.428557144252, 5721.771129154788, 5668.5465162787705, 5729.541636668973, 5748.281464816898, 5770.6249093808765, 5838.036723940502], "unit": "score", "name": "mootools.html", "value": 3976.2538144446235}, {"lowerIsBetter": false, "replicates": [305.2490872453763, 307.3330872007743, 309.47080492358066, 310.1919499703274, 315.5534918090901, 5600.887982240352, 5614.326280846294, 5665.4334566543375, 5728.0, 5763.769449222036, 5646.20953066571, 5646.971765141178, 5660.2075709400715, 5662.122371032487, 5695.601307908438, 4048.4939382577177, 4170.416141740159, 4248.107897341562, 4266.189424009443, 4330.090680957002, 4311.28863737483, 4325.913481730364, 4337.848175313865, 4344.500382456026, 4348.543402942693, 4298.140371925611, 4299.054208074219, 4304.203722311367, 4306.698531102824, 4312.633426158764, 4291.776843599575, 4309.159713855799, 4313.223619748444, 4317.76252306123, 4322.157179350028, 3760.078780698719, 3768.189839184561, 3773.9056523586855, 3776.4712940188397, 3778.8299526521373, 5444.91832622511, 5446.400895901447, 5447.264619276387, 5449.100898351767, 5463.9180412293845, 4667.183242932473, 4846.5880400166025, 4874.683145595561, 4902.411710594716, 4962.60299176065, 5894.233749612566, 5907.763689452417, 5917.704114794286, 5918.112283157518, 5920.141579470953, 3956.4658771065824, 3963.3064213762764, 3971.801409929521, 3981.064449854282, 3981.3828856527284, 6166.660833654148, 6259.530535209878, 6266.467350275232, 6286.119943207955, 6365.395287447732, 4105.322621767435, 4109.0959988802415, 4109.712320137562, 4118.711690181718, 4125.8968525787095, 4176.916461670749, 4179.226843034048, 4181.121964387452, 4182.079942412725, 4184.623383895464, 4606.0, 4725.125851717443, 4742.264948932921, 4749.073930583503, 4756.6670333077045, 5847.912281315784, 5935.554833387513, 5944.524438044946, 5950.940490595125, 5962.701864906738, 1450.0864455393034, 1455.3087283540233, 1458.5405597236836, 1468.4493315006873, 1468.949700963816, 949.9192568631744, 961.4567769210514, 962.2494454325637, 968.6851773173747, 972.0668158567713, 5058.898822023539, 5095.108356037678, 5101.51535604117, 5115.232715092766, 5122.206058061007, 6185.474234690012, 6192.845178870564, 6195.287541932646, 6196.380361963767, 6199.411055949678, 4996.0, 5114.977004599021, 5118.3090282811345, 5123.769430375642, 5188.584913206934, 3335.766496345281, 3346.782459140148, 3370.511275865035, 3376.74674399421, 3380.6281309055985, 5821.912671309934, 5831.504322132666, 5834.504067154255, 5835.679037652885, 5850.824475265749, 6417.358264173546, 6444.645544495004, 6456.838579035468, 6469.935300646934, 6480.222373315138, 5830.067189249699, 5830.183774271605, 5833.912491312633, 5844.363578198111, 5853.853653658693, 6100.567345874437, 6215.564910456224, 6264.21697287839, 6276.9372306276355, 6279.277883043508, 6071.423214794588, 6089.360617135314, 6094.969525152524, 6113.938860611337, 6123.326434092157, 5798.1302804579655, 5804.82585522435, 5813.331466881363, 5829.737661805144, 5831.679257640871, 3987.481627388537, 4014.9197016060098, 4036.656884164879, 4046.2716710992304, 4058.573849745734, 6216.813495595139, 6219.937800622117, 6230.501559875109, 6249.96875015622, 6259.06114082873, 5733.569982251432, 5981.1327357532045, 5996.0, 5996.850078748066, 6026.156338112755, 5974.522038237017, 5974.671393073423, 5985.940140598538, 5994.370591088047, 5996.190514280691, 5849.502792262705, 5852.678102704393, 5860.208871802252, 5863.912041319299, 5866.120081987736, 6019.849503762441, 6042.788502402394, 6044.879102418015, 6056.0, 6062.18160548338, 5736.942630573641, 5826.184334193301, 5872.647641141545, 5886.970565147147, 5899.705014749331], "unit": "score", "name": "prototype.html", "value": 4413.817856929959}, {"lowerIsBetter": false, "replicates": [524.6694582413079, 528.2024143543249, 641.4964253061346, 671.3756206727743, 679.7450955891541, 9709.951450242757, 10192.64325748599, 10498.265121441502, 10614.522346494397, 11496.655100347003, 12272.140950133495, 12275.63173104806, 12289.0, 12343.691407714812, 12386.690332741686, 757.2730179028126, 775.0234704272601, 776.8601651702692, 777.6345117794656, 777.6617171530374, 759.6505607420593, 766.7738017284886, 769.2807225244386, 769.7382889817461, 772.5441989226383, 789.7670187294761, 793.2345286798238, 795.7732046366787, 795.8647030004884, 798.9241022102891, 781.1134362498548, 782.7416952405692, 784.3333166808196, 785.0932173339773, 786.8308313712522, 587.9647221166744, 588.0238803586027, 588.3263663105763, 588.6997631208072, 590.1767034986214, 10796.67609971702, 10807.83788243177, 10832.566697332097, 11222.102231821516, 11577.479013444416, 10671.893281067245, 10755.462226888625, 11157.497912593954, 11319.094472442268, 11470.885291147066, 8577.656893724243, 8696.869546956737, 8756.255718263956, 8815.77960550985, 8824.911750882537, 3644.8724294649824, 3665.706743460517, 3677.2645470905927, 3704.25914817035, 3710.128119891823, 37003.25993480115, 37012.44481332755, 37163.0, 37189.0, 37315.0, 8333.583320833934, 8396.118407567117, 8431.789205269917, 8586.141385861363, 8679.956600216958, 14585.343659535347, 15369.385224590891, 15405.38378464849, 15418.691626167414, 15478.380864765508, 6137.7851775187655, 6175.783847565313, 6191.1641928339095, 6212.099245609361, 6482.805515834532, 3015.42706885691, 3095.613048368954, 3125.343677827682, 3180.1254654970066, 3494.3011397720556, 2400.6879105716143, 2458.3976925652973, 2504.4114633061217, 2515.924522264335, 2548.8598127103187, 482.38495917704506, 483.12554276758476, 488.18960525527456, 488.66282265236873, 494.9109160351171, 517.2267460147104, 529.4652401074942, 532.544674303465, 536.265316516375, 543.5325619966825, 6643.634600097041, 6663.20041595002, 6701.229358623723, 6708.362705542965, 6744.932550674529, 430.4834198961259, 526.5484747480303, 532.6750682083925, 545.26661640094, 553.6456667732655, 3187.1394723424546, 3228.1606782236786, 3274.2632907596076, 3282.9343413131605, 3288.57248557686, 45599.08801823945, 45949.77025114853, 46196.0, 46943.0, 47690.76154619205, 39107.80446097751, 39683.80158099249, 39860.601393985686, 39908.20183596312, 40040.0, 35814.64185358165, 36380.45429318563, 36669.0, 36701.63298366982, 36764.63235367612, 7184.389326907271, 7222.6388680566815, 7301.963490182515, 7327.890081648886, 7411.592362419903, 30127.04174228668, 30228.69771302259, 31110.53334200034, 31338.686613133577, 31696.841515792272, 38505.42241866318, 38842.6115738839, 39417.2116557673, 39452.60547394604, 39700.602993970846, 9036.954815225881, 9103.635854566008, 9154.992950775542, 9229.35394522377, 9264.39781414206, 10391.844122338322, 10419.218558607983, 10728.302660327054, 10895.618653347095, 11049.33703977764, 10192.235582331206, 10257.384556926609, 10738.302010369302, 10954.507047183055, 11056.170787191153, 10000.0, 10502.062210430222, 10571.471426428494, 10681.51933162994, 11041.0, 9998.200143988319, 10052.849207262043, 10141.746456338651, 10275.801598214512, 10315.504251883585, 8333.791655208426, 8428.704995325133, 8719.78200544966, 8789.648414063366, 8946.642134314554, 8635.82728345417, 8917.687880924137, 8963.955180224057, 8994.865077023718, 9086.954565227132], "unit": "score", "name": "yui.html", "value": 5405.979051953518}], "name": "dromaeo_css", "value": 6145.376886612517}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 112.0, 114.0, 115.0, 116.0, 126.0, 116.0, 115.0, 116.0, 124.0], "unit": "score", "name": "ai-astar", "value": 117.0}, {"lowerIsBetter": true, "replicates": [165.0, 141.0, 162.0, 183.0, 139.0, 156.0, 156.0, 142.0, 184.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 156.7}, {"lowerIsBetter": true, "replicates": [167.0, 165.0, 164.0, 167.0, 165.0, 164.0, 166.0, 179.0, 167.0, 163.0], "unit": "score", "name": "audio-dft", "value": 166.7}, {"lowerIsBetter": true, "replicates": [78.0, 74.0, 78.0, 75.0, 75.0, 129.0, 74.0, 74.0, 78.0, 76.0], "unit": "score", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 129.0, 96.0, 98.0, 96.0, 133.0, 97.0, 98.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [120.0, 119.0, 118.0, 119.0, 120.0, 120.0, 119.0, 120.0, 119.0, 120.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 119.4}, {"lowerIsBetter": true, "replicates": [150.0, 149.0, 149.0, 150.0, 149.0, 150.0, 149.0, 153.0, 150.0, 151.0], "unit": "score", "name": "imaging-darkroom", "value": 150.0}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 99.0, 100.0, 98.0, 97.0, 97.0, 97.0, 98.0, 98.0], "unit": "score", "name": "imaging-desaturate", "value": 97.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 67.0, 69.0, 68.0, 69.0, 76.0, 67.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 69.0}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 72.0, 73.0, 72.0, 72.0, 73.0, 72.0, 72.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.4}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 88.0, 88.0, 90.0, 89.0, 89.0, 89.0, 88.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.6}, {"lowerIsBetter": true, "replicates": [128.0, 132.0, 150.0, 136.0, 135.0, 139.0, 133.0, 137.0, 133.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 135.1}, {"lowerIsBetter": true, "replicates": [160.0, 153.0, 158.0, 157.0, 150.0, 147.0, 162.0, 162.0, 157.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 155.2}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 73.0, 75.0, 74.0, 72.0, 74.0, 73.0, 74.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.9}], "name": "kraken", "value": 1590.3}]} 23:15:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1590.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6145.38"}}} 23:15:50 INFO - Return code: 0 23:15:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:15:50 ERROR - # TBPL SUCCESS # 23:15:50 INFO - Running post-action listener: _resource_record_post_action 23:15:50 INFO - Running post-run listener: _resource_record_post_run 23:15:51 INFO - Total resource usage - Wall time: 1191s; CPU: 25.0%; Read bytes: 0; Write bytes: 302751744; Read time: 0; Write time: 259296 23:15:51 INFO - install - Wall time: 16s; CPU: 25.0%; Read bytes: 0; Write bytes: 15790080; Read time: 0; Write time: 9832 23:15:51 INFO - run-tests - Wall time: 1175s; CPU: 25.0%; Read bytes: 0; Write bytes: 286961664; Read time: 0; Write time: 249464 23:15:51 INFO - Running post-run listener: _upload_blobber_files 23:15:51 INFO - Blob upload gear active. 23:15:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:15:51 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 23:15:51 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'] 23:15:51 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 23:15:52 INFO - (blobuploader) - INFO - Open directory for files ... 23:15:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:15:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:15:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:52 INFO - (blobuploader) - INFO - Done attempting. 23:15:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:15:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:15:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:53 INFO - (blobuploader) - INFO - Done attempting. 23:15:53 INFO - (blobuploader) - INFO - Iteration through files over. 23:15:53 INFO - Return code: 0 23:15:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:15:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:15:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b6e6d9037b53335b77b44e9c895cd38ad03d6c9e4fe6f74ea140d2615446560d5375e234a33b9403832b4748ef82d66af16f11e7c69b5ef6145fc28bf16da51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af7fbdc150f6237c46da529b061620e992477545eec7dacc08c49507de8ad3e24f15665c1b40fcfd34bd6a08e1fb37de041979936600550f6330777200c4073d"} 23:15:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:15:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:15:53 INFO - Contents: 23:15:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b6e6d9037b53335b77b44e9c895cd38ad03d6c9e4fe6f74ea140d2615446560d5375e234a33b9403832b4748ef82d66af16f11e7c69b5ef6145fc28bf16da51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af7fbdc150f6237c46da529b061620e992477545eec7dacc08c49507de8ad3e24f15665c1b40fcfd34bd6a08e1fb37de041979936600550f6330777200c4073d"} 23:15:53 INFO - Running post-run listener: copy_logs_to_upload_dir 23:15:53 INFO - Copying logs to upload dir... 23:15:53 INFO - mkdir: /builds/slave/test/build/upload/logs 23:15:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1333.100639 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2016-03-03 23:15:53.489629) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 23:15:53.493711) ========= 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-1457073601.591312-543738990 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/0b6e6d9037b53335b77b44e9c895cd38ad03d6c9e4fe6f74ea140d2615446560d5375e234a33b9403832b4748ef82d66af16f11e7c69b5ef6145fc28bf16da51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af7fbdc150f6237c46da529b061620e992477545eec7dacc08c49507de8ad3e24f15665c1b40fcfd34bd6a08e1fb37de041979936600550f6330777200c4073d"} build_url:https://queue.taskcluster.net/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005346 build_url: 'https://queue.taskcluster.net/v1/task/Ud3ERORfRFi0jBc84VuyWA/artifacts/public/build/firefox-47.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/0b6e6d9037b53335b77b44e9c895cd38ad03d6c9e4fe6f74ea140d2615446560d5375e234a33b9403832b4748ef82d66af16f11e7c69b5ef6145fc28bf16da51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af7fbdc150f6237c46da529b061620e992477545eec7dacc08c49507de8ad3e24f15665c1b40fcfd34bd6a08e1fb37de041979936600550f6330777200c4073d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 23:15:53.507548) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 23:15:53.507873) ========= 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-1457073601.591312-543738990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002175 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 23:15:53.588724) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 23:15:53.589229) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 23:15:53.589557) ========= ========= Total master_lag: 0.29 =========