builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1460178371.13 results: success (0) buildid: 20160408213953 builduid: 4c4c95a0875f4b309cfe650acfb4b3e2 revision: ca3f8c085a584d804511d9a551e95606fc8ff41d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.134692) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.135131) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.135479) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006707 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.189807) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.190114) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.217900) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.218208) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.272760) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.273318) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.273799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.274114) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-08 22:06:11-- 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% 92.0M=0s 2016-04-08 22:06:11 (92.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133355 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.421588) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.421999) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022174 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.472196) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.472540) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ca3f8c085a584d804511d9a551e95606fc8ff41d --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 ca3f8c085a584d804511d9a551e95606fc8ff41d --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=b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-08 22:06:11,687 truncating revision to first 12 chars 2016-04-08 22:06:11,687 Setting DEBUG logging. 2016-04-08 22:06:11,687 attempt 1/10 2016-04-08 22:06:11,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ca3f8c085a58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 22:06:12,079 unpacking tar archive at: fx-team-ca3f8c085a58/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669576 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:12.159296) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:12.160066) ========= echo ca3f8c085a584d804511d9a551e95606fc8ff41d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ca3f8c085a584d804511d9a551e95606fc8ff41d'] 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=b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ca3f8c085a584d804511d9a551e95606fc8ff41d program finished with exit code 0 elapsedTime=0.004602 script_repo_revision: 'ca3f8c085a584d804511d9a551e95606fc8ff41d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:12.211794) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:12.212138) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:12.222431) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-08 22:06:12.222752) ========= /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=b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:06:12 INFO - MultiFileLogger online at 20160408 22:06:12 in /builds/slave/test 22:06:12 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:06:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:06:12 INFO - {'append_to_log': False, 22:06:12 INFO - 'base_work_dir': '/builds/slave/test', 22:06:12 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:06:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:06:12 INFO - 'branch': 'Fx-Team-Non-PGO', 22:06:12 INFO - 'buildbot_json_path': 'buildprops.json', 22:06:12 INFO - 'config_files': ('talos/linux_config.py',), 22:06:12 INFO - 'default_actions': ('clobber', 22:06:12 INFO - 'read-buildbot-config', 22:06:12 INFO - 'download-and-extract', 22:06:12 INFO - 'populate-webroot', 22:06:12 INFO - 'create-virtualenv', 22:06:12 INFO - 'install', 22:06:12 INFO - 'run-tests'), 22:06:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:06:12 INFO - 'download_minidump_stackwalk': True, 22:06:12 INFO - 'download_symbols': 'ondemand', 22:06:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:06:12 INFO - 'tooltool.py': '/tools/tooltool.py', 22:06:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:06:12 INFO - '/tools/misc-python/virtualenv.py')}, 22:06:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:06:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:06:12 INFO - 'installer_path': 'installer.exe', 22:06:12 INFO - 'log_level': 'info', 22:06:12 INFO - 'log_name': 'talos', 22:06:12 INFO - 'log_to_console': True, 22:06:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:06:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:06:12 INFO - 'opt_config_files': (), 22:06:12 INFO - 'pip_index': False, 22:06:12 INFO - 'sps_profile': False, 22:06:12 INFO - 'sps_profile_interval': 0, 22:06:12 INFO - 'suite': 'dromaeojs-e10s', 22:06:12 INFO - 'system_bits': '32', 22:06:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:06:12 INFO - 'title': 'talos-linux64-ix-007', 22:06:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:06:12 INFO - 'use_talos_json': True, 22:06:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:06:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:06:12 INFO - 'work_dir': 'build'} 22:06:12 INFO - ##### 22:06:12 INFO - ##### Running clobber step. 22:06:12 INFO - ##### 22:06:12 INFO - Running pre-action listener: _resource_record_pre_action 22:06:12 INFO - Running main action method: clobber 22:06:12 INFO - rmtree: /builds/slave/test/build 22:06:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:06:13 INFO - Running post-action listener: _resource_record_post_action 22:06:13 INFO - ##### 22:06:13 INFO - ##### Running read-buildbot-config step. 22:06:13 INFO - ##### 22:06:13 INFO - Running pre-action listener: _resource_record_pre_action 22:06:13 INFO - Running main action method: read_buildbot_config 22:06:13 INFO - Using buildbot properties: 22:06:13 INFO - { 22:06:13 INFO - "project": "", 22:06:13 INFO - "product": "firefox", 22:06:13 INFO - "script_repo_revision": "production", 22:06:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:06:13 INFO - "repository": "", 22:06:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:06:13 INFO - "buildid": "20160408213953", 22:06:13 INFO - "pgo_build": "False", 22:06:13 INFO - "basedir": "/builds/slave/test", 22:06:13 INFO - "buildnumber": 1381, 22:06:13 INFO - "slavename": "talos-linux64-ix-007", 22:06:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:06:13 INFO - "platform": "ubuntu64_hw", 22:06:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:06:13 INFO - "branch": "fx-team", 22:06:13 INFO - "repo_path": "integration/fx-team", 22:06:13 INFO - "revision": "ca3f8c085a584d804511d9a551e95606fc8ff41d", 22:06:13 INFO - "stage_platform": "linux64", 22:06:13 INFO - "builduid": "4c4c95a0875f4b309cfe650acfb4b3e2", 22:06:13 INFO - "slavebuilddir": "test" 22:06:13 INFO - } 22:06:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:06:13 INFO - Running post-action listener: _resource_record_post_action 22:06:13 INFO - ##### 22:06:13 INFO - ##### Running download-and-extract step. 22:06:13 INFO - ##### 22:06:13 INFO - Running pre-action listener: _resource_record_pre_action 22:06:13 INFO - Running main action method: download_and_extract 22:06:13 INFO - mkdir: /builds/slave/test/build/tests 22:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:13 INFO - https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:06:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:06:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:06:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:06:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:06:16 INFO - Downloaded 1361 bytes. 22:06:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:06:16 INFO - Using the following test package requirements: 22:06:16 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:06:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:06:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:16 INFO - u'jsshell-linux-x86_64.zip'], 22:06:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:06:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:06:16 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:06:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:06:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:06:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:16 INFO - https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:06:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:06:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:06:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:06:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:06:26 INFO - Downloaded 22186314 bytes. 22:06:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:06:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:06:27 INFO - Return code: 0 22:06:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:27 INFO - https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:06:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:06:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:06:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:06:30 INFO - Downloaded 22186314 bytes. 22:06:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:06:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:06:31 INFO - Return code: 0 22:06:31 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:06:31 INFO - https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:06:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:06:32 INFO - Downloaded 10847693 bytes. 22:06:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:06:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:06:32 INFO - Return code: 0 22:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:32 INFO - https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:06:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:06:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:06:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:06:34 INFO - Downloaded 54052336 bytes. 22:06:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:06:34 INFO - mkdir: /builds/slave/test/properties 22:06:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:06:34 INFO - Writing to file /builds/slave/test/properties/build_url 22:06:34 INFO - Contents: 22:06:34 INFO - build_url:https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:06:34 INFO - Running post-action listener: _resource_record_post_action 22:06:34 INFO - Running post-action listener: set_extra_try_arguments 22:06:34 INFO - ##### 22:06:34 INFO - ##### Running populate-webroot step. 22:06:34 INFO - ##### 22:06:34 INFO - Running pre-action listener: _resource_record_pre_action 22:06:34 INFO - Running main action method: populate_webroot 22:06:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:06:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:06:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:06:34 INFO - '--tppagecycles', 22:06:34 INFO - '7'], 22:06:34 INFO - 'tests': ['tsvgm']}}, 22:06:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:06:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:06:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:06:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:06:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:06:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:06:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:34 INFO - 'talos_options': ['--disable-e10s'], 22:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:06:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:06:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:34 INFO - 'talos_options': ['--disable-e10s'], 22:06:34 INFO - 'tests': ['damp', 'tps']}, 22:06:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:34 INFO - 'tests': ['damp', 'tps']}, 22:06:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:06:34 INFO - 'tests': ['dromaeo_dom']}, 22:06:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:06:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:06:34 INFO - 'tests': ['a11yr', 22:06:34 INFO - 'ts_paint', 22:06:34 INFO - 'tpaint', 22:06:34 INFO - 'sessionrestore', 22:06:34 INFO - 'sessionrestore_no_auto_restore', 22:06:34 INFO - 'tabpaint']}, 22:06:34 INFO - 'other-e10s': {'tests': ['a11yr', 22:06:34 INFO - 'ts_paint', 22:06:34 INFO - 'tpaint', 22:06:34 INFO - 'sessionrestore', 22:06:34 INFO - 'sessionrestore_no_auto_restore', 22:06:34 INFO - 'tabpaint']}, 22:06:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:06:34 INFO - 'ts_paint', 22:06:34 INFO - 'tpaint', 22:06:34 INFO - 'sessionrestore', 22:06:34 INFO - 'sessionrestore_no_auto_restore', 22:06:34 INFO - 'tabpaint']}, 22:06:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:06:34 INFO - 'ts_paint', 22:06:34 INFO - 'tpaint', 22:06:34 INFO - 'sessionrestore', 22:06:34 INFO - 'sessionrestore_no_auto_restore', 22:06:34 INFO - 'tabpaint']}, 22:06:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:06:34 INFO - 'tests': ['a11yr', 22:06:34 INFO - 'ts_paint', 22:06:34 INFO - 'tpaint', 22:06:34 INFO - 'sessionrestore', 22:06:34 INFO - 'sessionrestore_no_auto_restore', 22:06:34 INFO - 'tabpaint']}, 22:06:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:06:34 INFO - 'tests': ['a11yr', 22:06:34 INFO - 'ts_paint', 22:06:34 INFO - 'tpaint', 22:06:34 INFO - 'sessionrestore', 22:06:34 INFO - 'sessionrestore_no_auto_restore', 22:06:34 INFO - 'tabpaint']}, 22:06:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:06:34 INFO - 'tests': ['tsvgx', 22:06:34 INFO - 'tsvgr_opacity', 22:06:34 INFO - 'tart', 22:06:34 INFO - 'tscrollx', 22:06:34 INFO - 'cart']}, 22:06:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:06:34 INFO - 'tsvgr_opacity', 22:06:34 INFO - 'tart', 22:06:34 INFO - 'tscrollx', 22:06:34 INFO - 'cart']}, 22:06:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:34 INFO - 'talos_options': ['--disable-e10s'], 22:06:34 INFO - 'tests': ['tp5o']}, 22:06:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:34 INFO - 'tests': ['tp5o']}, 22:06:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:34 INFO - 'talos_options': ['--disable-e10s', 22:06:34 INFO - '--xperf_path', 22:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:06:34 INFO - 'tests': ['tp5n']}, 22:06:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:34 INFO - 'talos_options': ['--xperf_path', 22:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:06:34 INFO - 'tests': ['tp5n']}}, 22:06:34 INFO - 'talos.zip': {'path': '', 22:06:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:06:34 INFO - Running post-action listener: _resource_record_post_action 22:06:34 INFO - ##### 22:06:34 INFO - ##### Running create-virtualenv step. 22:06:34 INFO - ##### 22:06:34 INFO - Running pre-action listener: _resource_record_pre_action 22:06:34 INFO - Running main action method: create_virtualenv 22:06:34 INFO - Creating virtualenv /builds/slave/test/build/venv 22:06:34 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:06:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:06:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:06:35 INFO - Using real prefix '/usr' 22:06:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:06:35 INFO - Installing distribute.............................................................................................................................................................................................done. 22:06:37 INFO - Installing pip.................done. 22:06:37 INFO - Return code: 0 22:06:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:06:37 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:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:37 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:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:37 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 0x7ffe496aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210f410>, '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 0x2110310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21107a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', '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:06:37 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:06:37 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:06:37 INFO - Using env: {'DISPLAY': ':0', 22:06:37 INFO - 'HOME': '/home/cltbld', 22:06:37 INFO - 'LANG': 'en_US.UTF-8', 22:06:37 INFO - 'LANGUAGE': 'en_US:en', 22:06:37 INFO - 'LOGNAME': 'cltbld', 22:06:37 INFO - 'MAIL': '/var/mail/cltbld', 22:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:37 INFO - 'MOZ_NO_REMOTE': '1', 22:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:37 INFO - 'NO_EM_RESTART': '1', 22:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:37 INFO - 'PWD': '/builds/slave/test', 22:06:37 INFO - 'SHELL': '/bin/bash', 22:06:37 INFO - 'SHLVL': '1', 22:06:37 INFO - 'TERM': 'linux', 22:06:37 INFO - 'TMOUT': '86400', 22:06:37 INFO - 'USER': 'cltbld', 22:06:37 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', 22:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:37 INFO - '_': '/tools/buildbot/bin/python'} 22:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:37 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:06:37 INFO - Cleaning up... 22:06:37 INFO - Return code: 0 22:06:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:06:37 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:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:37 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:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:37 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 0x7ffe496aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210f410>, '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 0x2110310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21107a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', '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:06:37 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:06:37 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:06:37 INFO - Using env: {'DISPLAY': ':0', 22:06:37 INFO - 'HOME': '/home/cltbld', 22:06:37 INFO - 'LANG': 'en_US.UTF-8', 22:06:37 INFO - 'LANGUAGE': 'en_US:en', 22:06:37 INFO - 'LOGNAME': 'cltbld', 22:06:37 INFO - 'MAIL': '/var/mail/cltbld', 22:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:37 INFO - 'MOZ_NO_REMOTE': '1', 22:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:37 INFO - 'NO_EM_RESTART': '1', 22:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:37 INFO - 'PWD': '/builds/slave/test', 22:06:37 INFO - 'SHELL': '/bin/bash', 22:06:37 INFO - 'SHLVL': '1', 22:06:37 INFO - 'TERM': 'linux', 22:06:37 INFO - 'TMOUT': '86400', 22:06:37 INFO - 'USER': 'cltbld', 22:06:37 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', 22:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:37 INFO - '_': '/tools/buildbot/bin/python'} 22:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:37 INFO - Downloading/unpacking psutil>=0.7.1 22:06:37 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:06:37 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:06:37 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:06:37 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:06:37 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:06:37 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:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:06:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:06:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:06:39 INFO - Installing collected packages: psutil 22:06:39 INFO - Running setup.py install for psutil 22:06:40 INFO - building 'psutil._psutil_linux' extension 22:06:40 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:06:40 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:06:40 INFO - building 'psutil._psutil_posix' extension 22:06:40 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:06:40 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:06:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:06:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:06:40 INFO - Successfully installed psutil 22:06:40 INFO - Cleaning up... 22:06:40 INFO - Return code: 0 22:06:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:40 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 0x7ffe496aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210f410>, '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 0x2110310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21107a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', '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:06:40 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:06:40 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:06:40 INFO - Using env: {'DISPLAY': ':0', 22:06:40 INFO - 'HOME': '/home/cltbld', 22:06:40 INFO - 'LANG': 'en_US.UTF-8', 22:06:40 INFO - 'LANGUAGE': 'en_US:en', 22:06:40 INFO - 'LOGNAME': 'cltbld', 22:06:40 INFO - 'MAIL': '/var/mail/cltbld', 22:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:40 INFO - 'MOZ_NO_REMOTE': '1', 22:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:40 INFO - 'NO_EM_RESTART': '1', 22:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:40 INFO - 'PWD': '/builds/slave/test', 22:06:40 INFO - 'SHELL': '/bin/bash', 22:06:40 INFO - 'SHLVL': '1', 22:06:40 INFO - 'TERM': 'linux', 22:06:40 INFO - 'TMOUT': '86400', 22:06:40 INFO - 'USER': 'cltbld', 22:06:40 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', 22:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:40 INFO - '_': '/tools/buildbot/bin/python'} 22:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:06:40 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:06:40 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:06:40 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:06:40 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:06:40 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:06:40 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:06:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:06:42 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:06:42 INFO - Installing collected packages: mozsystemmonitor 22:06:42 INFO - Running setup.py install for mozsystemmonitor 22:06:42 INFO - Successfully installed mozsystemmonitor 22:06:42 INFO - Cleaning up... 22:06:42 INFO - Return code: 0 22:06:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:42 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 0x7ffe496aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210f410>, '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 0x2110310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21107a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', '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:06:42 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:06:42 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:06:42 INFO - Using env: {'DISPLAY': ':0', 22:06:42 INFO - 'HOME': '/home/cltbld', 22:06:42 INFO - 'LANG': 'en_US.UTF-8', 22:06:42 INFO - 'LANGUAGE': 'en_US:en', 22:06:42 INFO - 'LOGNAME': 'cltbld', 22:06:42 INFO - 'MAIL': '/var/mail/cltbld', 22:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:42 INFO - 'MOZ_NO_REMOTE': '1', 22:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:42 INFO - 'NO_EM_RESTART': '1', 22:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:42 INFO - 'PWD': '/builds/slave/test', 22:06:42 INFO - 'SHELL': '/bin/bash', 22:06:42 INFO - 'SHLVL': '1', 22:06:42 INFO - 'TERM': 'linux', 22:06:42 INFO - 'TMOUT': '86400', 22:06:42 INFO - 'USER': 'cltbld', 22:06:42 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', 22:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:42 INFO - '_': '/tools/buildbot/bin/python'} 22:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:43 INFO - Downloading/unpacking blobuploader==1.2.4 22:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:45 INFO - Downloading blobuploader-1.2.4.tar.gz 22:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:06:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:06:45 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:06:45 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:06:45 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:06:45 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:06:45 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:06:45 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:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:06:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:06:45 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:06:45 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:06:45 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:06:45 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:06:45 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:06:45 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:06:45 INFO - Downloading docopt-0.6.1.tar.gz 22:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:06:45 INFO - Installing collected packages: blobuploader, requests, docopt 22:06:45 INFO - Running setup.py install for blobuploader 22:06:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:06:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:06:45 INFO - Running setup.py install for requests 22:06:46 INFO - Running setup.py install for docopt 22:06:46 INFO - Successfully installed blobuploader requests docopt 22:06:46 INFO - Cleaning up... 22:06:46 INFO - Return code: 0 22:06:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:46 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 0x7ffe496aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210f410>, '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 0x2110310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21107a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', '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:06:46 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:06:46 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:06:46 INFO - Using env: {'DISPLAY': ':0', 22:06:46 INFO - 'HOME': '/home/cltbld', 22:06:46 INFO - 'LANG': 'en_US.UTF-8', 22:06:46 INFO - 'LANGUAGE': 'en_US:en', 22:06:46 INFO - 'LOGNAME': 'cltbld', 22:06:46 INFO - 'MAIL': '/var/mail/cltbld', 22:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:46 INFO - 'MOZ_NO_REMOTE': '1', 22:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:46 INFO - 'NO_EM_RESTART': '1', 22:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:46 INFO - 'PWD': '/builds/slave/test', 22:06:46 INFO - 'SHELL': '/bin/bash', 22:06:46 INFO - 'SHLVL': '1', 22:06:46 INFO - 'TERM': 'linux', 22:06:46 INFO - 'TMOUT': '86400', 22:06:46 INFO - 'USER': 'cltbld', 22:06:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', 22:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:46 INFO - '_': '/tools/buildbot/bin/python'} 22:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:06:46 INFO - Running setup.py (path:/tmp/pip-07yVCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:06:46 INFO - Running setup.py (path:/tmp/pip-volBL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:06:46 INFO - Running setup.py (path:/tmp/pip-p2rSzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:06:46 INFO - Running setup.py (path:/tmp/pip-KCzoDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:06:46 INFO - Running setup.py (path:/tmp/pip-G1EZH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:06:46 INFO - Running setup.py (path:/tmp/pip-FD1HXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:06:47 INFO - Running setup.py (path:/tmp/pip-nuUfmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:06:47 INFO - Running setup.py (path:/tmp/pip-MJMSK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:06:47 INFO - Running setup.py (path:/tmp/pip-JVlN7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:06:47 INFO - Running setup.py (path:/tmp/pip-aCdNMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:06:47 INFO - Running setup.py (path:/tmp/pip-zPCRPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:06:47 INFO - Running setup.py (path:/tmp/pip-Urbgu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:06:47 INFO - Running setup.py (path:/tmp/pip-ya0jAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:06:47 INFO - Running setup.py (path:/tmp/pip-kNbxLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:47 INFO - Running setup.py (path:/tmp/pip-LmGzxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:06:47 INFO - Running setup.py (path:/tmp/pip-MbyZca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:06:47 INFO - Running setup.py (path:/tmp/pip-jDYPWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:06:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:06:47 INFO - Running setup.py install for manifestparser 22:06:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:06:47 INFO - Running setup.py install for mozcrash 22:06:48 INFO - Running setup.py install for mozdebug 22:06:48 INFO - Running setup.py install for mozdevice 22:06:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:06:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:06:48 INFO - Running setup.py install for mozfile 22:06:48 INFO - Running setup.py install for mozhttpd 22:06:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:06:48 INFO - Running setup.py install for mozinfo 22:06:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:06:48 INFO - Running setup.py install for mozInstall 22:06:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:06:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:06:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:06:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:06:48 INFO - Running setup.py install for mozleak 22:06:48 INFO - Running setup.py install for mozlog 22:06:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:06:48 INFO - Running setup.py install for moznetwork 22:06:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:06:48 INFO - Running setup.py install for mozprocess 22:06:49 INFO - Running setup.py install for mozprofile 22:06:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:06:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:06:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:06:49 INFO - Running setup.py install for mozrunner 22:06:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:06:49 INFO - Running setup.py install for mozscreenshot 22:06:49 INFO - Running setup.py install for moztest 22:06:49 INFO - Running setup.py install for mozversion 22:06:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:06:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:06:49 INFO - Cleaning up... 22:06:49 INFO - Return code: 0 22:06:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:49 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 0x7ffe496aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210f410>, '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 0x2110310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21107a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', '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:06:49 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:06:49 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:06:49 INFO - Using env: {'DISPLAY': ':0', 22:06:49 INFO - 'HOME': '/home/cltbld', 22:06:49 INFO - 'LANG': 'en_US.UTF-8', 22:06:49 INFO - 'LANGUAGE': 'en_US:en', 22:06:49 INFO - 'LOGNAME': 'cltbld', 22:06:49 INFO - 'MAIL': '/var/mail/cltbld', 22:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:49 INFO - 'MOZ_NO_REMOTE': '1', 22:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:49 INFO - 'NO_EM_RESTART': '1', 22:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:49 INFO - 'PWD': '/builds/slave/test', 22:06:49 INFO - 'SHELL': '/bin/bash', 22:06:49 INFO - 'SHLVL': '1', 22:06:49 INFO - 'TERM': 'linux', 22:06:49 INFO - 'TMOUT': '86400', 22:06:49 INFO - 'USER': 'cltbld', 22:06:49 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', 22:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:49 INFO - '_': '/tools/buildbot/bin/python'} 22:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:06:49 INFO - Running setup.py (path:/tmp/pip-uyAhj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:06:49 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:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:06:49 INFO - Running setup.py (path:/tmp/pip-aXWoSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:06:49 INFO - Running setup.py (path:/tmp/pip-kMll0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:06: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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:06:50 INFO - Running setup.py (path:/tmp/pip-uXWK8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:06: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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:06:50 INFO - Running setup.py (path:/tmp/pip-nqIpnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:06: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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:06:50 INFO - Running setup.py (path:/tmp/pip-xJ2quT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:06: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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:06:50 INFO - Running setup.py (path:/tmp/pip-kmJvuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:06: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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:06:50 INFO - Running setup.py (path:/tmp/pip-k7WC_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:06: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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:06:50 INFO - Running setup.py (path:/tmp/pip-tjuGo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:06: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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:06:50 INFO - Running setup.py (path:/tmp/pip-Rw2GdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:06: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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:06:50 INFO - Running setup.py (path:/tmp/pip-87_BY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:06: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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:06:50 INFO - Running setup.py (path:/tmp/pip-Hu177P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:06:50 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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:06:50 INFO - Running setup.py (path:/tmp/pip-H8sxnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:06:50 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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:06:50 INFO - Running setup.py (path:/tmp/pip-xvgN0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:06:50 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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:50 INFO - Running setup.py (path:/tmp/pip-gA1r0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:50 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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:06:50 INFO - Running setup.py (path:/tmp/pip-SR8rzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:06:50 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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:06:50 INFO - Running setup.py (path:/tmp/pip-1hbY7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:06: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:06: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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:06: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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:06: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:06: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:06: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:06:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:06: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:06: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:06: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:06: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:06: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:06: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:06:53 INFO - Downloading blessings-1.6.tar.gz 22:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:06:53 INFO - Installing collected packages: blessings 22:06:53 INFO - Running setup.py install for blessings 22:06:53 INFO - Successfully installed blessings 22:06:53 INFO - Cleaning up... 22:06:53 INFO - Return code: 0 22:06:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:06:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:06:53 INFO - Reading from file tmpfile_stdout 22:06:53 INFO - Current package versions: 22:06:53 INFO - argparse == 1.2.1 22:06:53 INFO - blessings == 1.6 22:06:53 INFO - blobuploader == 1.2.4 22:06:53 INFO - docopt == 0.6.1 22:06:53 INFO - manifestparser == 1.1 22:06:53 INFO - mozInstall == 1.12 22:06:53 INFO - mozcrash == 0.17 22:06:53 INFO - mozdebug == 0.1 22:06:53 INFO - mozdevice == 0.48 22:06:53 INFO - mozfile == 1.2 22:06:53 INFO - mozhttpd == 0.7 22:06:53 INFO - mozinfo == 0.9 22:06:53 INFO - mozleak == 0.1 22:06:53 INFO - mozlog == 3.1 22:06:53 INFO - moznetwork == 0.27 22:06:53 INFO - mozprocess == 0.22 22:06:53 INFO - mozprofile == 0.28 22:06:53 INFO - mozrunner == 6.11 22:06:53 INFO - mozscreenshot == 0.1 22:06:53 INFO - mozsystemmonitor == 0.0 22:06:53 INFO - moztest == 0.7 22:06:53 INFO - mozversion == 1.4 22:06:53 INFO - psutil == 3.1.1 22:06:53 INFO - requests == 1.2.3 22:06:53 INFO - wsgiref == 0.1.2 22:06:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:06: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:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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 0x7ffe496aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210f410>, '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 0x2110310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21107a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', '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:06: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:06: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:06:53 INFO - Using env: {'DISPLAY': ':0', 22:06:53 INFO - 'HOME': '/home/cltbld', 22:06:53 INFO - 'LANG': 'en_US.UTF-8', 22:06:53 INFO - 'LANGUAGE': 'en_US:en', 22:06:53 INFO - 'LOGNAME': 'cltbld', 22:06:53 INFO - 'MAIL': '/var/mail/cltbld', 22:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:53 INFO - 'MOZ_NO_REMOTE': '1', 22:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:53 INFO - 'NO_EM_RESTART': '1', 22:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:53 INFO - 'PWD': '/builds/slave/test', 22:06:53 INFO - 'SHELL': '/bin/bash', 22:06:53 INFO - 'SHLVL': '1', 22:06:53 INFO - 'TERM': 'linux', 22:06:53 INFO - 'TMOUT': '86400', 22:06:53 INFO - 'USER': 'cltbld', 22:06:53 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', 22:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:53 INFO - '_': '/tools/buildbot/bin/python'} 22:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06: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:06: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:06: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:06: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:06: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:06: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:06: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:06: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:06: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:06: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:06: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:06:53 INFO - Cleaning up... 22:06:53 INFO - Return code: 0 22:06:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:06: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:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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 0x7ffe496aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210f410>, '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 0x2110310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21107a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', '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:06: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:06: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:06:53 INFO - Using env: {'DISPLAY': ':0', 22:06:53 INFO - 'HOME': '/home/cltbld', 22:06:53 INFO - 'LANG': 'en_US.UTF-8', 22:06:53 INFO - 'LANGUAGE': 'en_US:en', 22:06:53 INFO - 'LOGNAME': 'cltbld', 22:06:53 INFO - 'MAIL': '/var/mail/cltbld', 22:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:53 INFO - 'MOZ_NO_REMOTE': '1', 22:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:53 INFO - 'NO_EM_RESTART': '1', 22:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:53 INFO - 'PWD': '/builds/slave/test', 22:06:53 INFO - 'SHELL': '/bin/bash', 22:06:53 INFO - 'SHLVL': '1', 22:06:53 INFO - 'TERM': 'linux', 22:06:53 INFO - 'TMOUT': '86400', 22:06:53 INFO - 'USER': 'cltbld', 22:06:53 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', 22:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:53 INFO - '_': '/tools/buildbot/bin/python'} 22:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:53 INFO - Downloading/unpacking jsonschema 22:06:53 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:06:53 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:06:53 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:06:53 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:06:53 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:06:53 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:06:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:06:55 INFO - Downloading/unpacking functools32 (from jsonschema) 22:06: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:06: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:06: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:06: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:06: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:06: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:06:56 INFO - Downloading functools32-3.2.3-2.tar.gz 22:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:06:56 INFO - warning: no files found matching '*.txt' 22:06:56 INFO - no previously-included directories found matching 'build' 22:06:56 INFO - no previously-included directories found matching 'dist' 22:06:56 INFO - no previously-included directories found matching '.git*' 22:06:56 INFO - Installing collected packages: jsonschema, functools32 22:06:56 INFO - Running setup.py install for functools32 22:06:56 INFO - warning: no files found matching '*.txt' 22:06:56 INFO - no previously-included directories found matching 'build' 22:06:56 INFO - no previously-included directories found matching 'dist' 22:06:56 INFO - no previously-included directories found matching '.git*' 22:06:56 INFO - Successfully installed jsonschema functools32 22:06:56 INFO - Cleaning up... 22:06:56 INFO - Return code: 0 22:06:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:06: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:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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 0x7ffe496aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210f410>, '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 0x2110310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21107a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', '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:06: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:06: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:06:56 INFO - Using env: {'DISPLAY': ':0', 22:06:56 INFO - 'HOME': '/home/cltbld', 22:06:56 INFO - 'LANG': 'en_US.UTF-8', 22:06:56 INFO - 'LANGUAGE': 'en_US:en', 22:06:56 INFO - 'LOGNAME': 'cltbld', 22:06:56 INFO - 'MAIL': '/var/mail/cltbld', 22:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:56 INFO - 'MOZ_NO_REMOTE': '1', 22:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:56 INFO - 'NO_EM_RESTART': '1', 22:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:56 INFO - 'PWD': '/builds/slave/test', 22:06:56 INFO - 'SHELL': '/bin/bash', 22:06:56 INFO - 'SHLVL': '1', 22:06:56 INFO - 'TERM': 'linux', 22:06:56 INFO - 'TMOUT': '86400', 22:06:56 INFO - 'USER': 'cltbld', 22:06:56 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', 22:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:56 INFO - '_': '/tools/buildbot/bin/python'} 22:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:56 INFO - Downloading/unpacking flake8 22:06: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:06: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:06: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:06: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:06: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:06: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:06:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:06:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:06: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:06: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:06: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:06: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:06: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:06: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:06:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:06:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:06: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:06: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:06: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:06: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:06: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:06: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:06:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:06: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:06: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:06: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:06: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:06: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:06: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:06:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:06:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:06:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:06:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:06:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:06:59 INFO - no previously-included directories found matching 'docs/_build' 22:06:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:06:59 INFO - Running setup.py install for pep8 22:06:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:06:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:06:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:06:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:06:59 INFO - no previously-included directories found matching 'docs/_build' 22:06:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:06:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:06:59 INFO - Cleaning up... 22:06:59 INFO - Return code: 0 22:06:59 INFO - Running post-action listener: _resource_record_post_action 22:06:59 INFO - Running post-action listener: _start_resource_monitoring 22:06:59 INFO - Starting resource monitoring. 22:06:59 INFO - ##### 22:06:59 INFO - ##### Running install step. 22:06:59 INFO - ##### 22:06:59 INFO - Running pre-action listener: _resource_record_pre_action 22:06:59 INFO - Running main action method: install 22:06:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:06:59 INFO - Reading from file tmpfile_stdout 22:06:59 INFO - Detecting whether we're running mozinstall >=1.0... 22:06:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:06:59 INFO - Reading from file tmpfile_stdout 22:06:59 INFO - Output received: 22:06:59 INFO - Usage: mozinstall [options] installer 22:06:59 INFO - Options: 22:06:59 INFO - -h, --help show this help message and exit 22:06:59 INFO - -d DEST, --destination=DEST 22:06:59 INFO - Directory to install application into. [default: 22:06:59 INFO - "/builds/slave/test"] 22:06:59 INFO - --app=APP Application being installed. [default: firefox] 22:06:59 INFO - mkdir: /builds/slave/test/build/application 22:06:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:07:15 INFO - Reading from file tmpfile_stdout 22:07:15 INFO - Output received: 22:07:15 INFO - /builds/slave/test/build/application/firefox/firefox 22:07:15 INFO - Running post-action listener: _resource_record_post_action 22:07:15 INFO - ##### 22:07:15 INFO - ##### Running run-tests step. 22:07:15 INFO - ##### 22:07:15 INFO - Running pre-action listener: _resource_record_pre_action 22:07:15 INFO - Running main action method: run_tests 22:07:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:07:15 INFO - Python 2.7.3 22:07:15 INFO - Return code: 0 22:07:15 INFO - grabbing minidump binary from tooltool 22:07: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:07: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 0x210f410>, '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 0x2110310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21107a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:07: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:07: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:07:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:07:15 INFO - Return code: 0 22:07:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:07:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:07:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:07:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:07:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:07:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:07:16 INFO - Return code: 0 22:07: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/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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:07: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/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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:07:16 INFO - Using env: {'DISPLAY': ':0', 22:07:16 INFO - 'HOME': '/home/cltbld', 22:07:16 INFO - 'LANG': 'en_US.UTF-8', 22:07:16 INFO - 'LANGUAGE': 'en_US:en', 22:07:16 INFO - 'LOGNAME': 'cltbld', 22:07:16 INFO - 'MAIL': '/var/mail/cltbld', 22:07:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:07:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:16 INFO - 'MOZ_NO_REMOTE': '1', 22:07:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:16 INFO - 'NO_EM_RESTART': '1', 22:07:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:16 INFO - 'PWD': '/builds/slave/test', 22:07:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:07:16 INFO - 'SHELL': '/bin/bash', 22:07:16 INFO - 'SHLVL': '1', 22:07:16 INFO - 'TERM': 'linux', 22:07:16 INFO - 'TMOUT': '86400', 22:07:16 INFO - 'USER': 'cltbld', 22:07:16 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524', 22:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:16 INFO - '_': '/tools/buildbot/bin/python'} 22:07: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/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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:07:16 INFO - mozversion application_buildid: 20160408213953 22:07:16 INFO - mozversion application_changeset: ca3f8c085a584d804511d9a551e95606fc8ff41d 22:07:16 INFO - mozversion application_display_name: Nightly 22:07:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:07:16 INFO - mozversion application_name: Firefox 22:07:16 INFO - mozversion application_remotingname: firefox 22:07:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:07:16 INFO - mozversion application_vendor: Mozilla 22:07:16 INFO - mozversion application_version: 48.0a1 22:07:16 INFO - mozversion platform_buildid: 20160408213953 22:07:16 INFO - mozversion platform_changeset: ca3f8c085a584d804511d9a551e95606fc8ff41d 22:07:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:07:16 INFO - mozversion platform_version: 48.0a1 22:07:16 INFO - using testdate: 1460178436 22:07:16 INFO - actual date: 1460178436 22:07:16 INFO - starting webserver on 'localhost:54241' 22:07:16 INFO - SUITE-START | Running 2 tests 22:07:16 INFO - TEST-START | dromaeo_css 22:07:16 INFO - operating with platform_type : linux_ 22:07:16 INFO - Initialising browser for dromaeo_css test... 22:07:16 INFO - TEST-INFO | started process 12908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptzcUQw/profile http://localhost:54241/getInfo.html) 22:07:20 INFO - PROCESS | 12908 | 22:07:20 INFO - PROCESS | 12908 | (process:12972): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:07:20 INFO - PROCESS | 12908 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 22:07:21 INFO - PROCESS | 12908 | __metrics Screen width/height:1600/1200 22:07:21 INFO - PROCESS | 12908 | colorDepth:24 22:07:21 INFO - PROCESS | 12908 | Browser inner width/height: 1024/697 22:07:21 INFO - PROCESS | 12908 | __metrics 22:07:22 ERROR - PROCESS | 12908 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 22:07:23 INFO - TEST-INFO | 12908: exit 0 22:07:23 INFO - Browser initialized. 22:07:23 INFO - Running cycle 1/1 for dromaeo_css test... 22:07:23 INFO - TEST-INFO | started process 13023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptzcUQw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:07:25 INFO - PROCESS | 13023 | 22:07:25 INFO - PROCESS | 13023 | (process:13083): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:07:35 INFO - PROCESS | 13023 | RSS: Main: 164102144 22:07:35 INFO - PROCESS | 13023 | 22:08:24 INFO - PROCESS | 13023 | 1460178504607 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:10:36 INFO - PROCESS | 13023 | Cycle 1(1): loaded http://localhost:54241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54241/tests/dromaeo/cssquery-ext.html) 22:10:37 INFO - PROCESS | 13023 | RSS: Main: 168620032 22:10:37 INFO - PROCESS | 13023 | 22:13:39 INFO - PROCESS | 13023 | Cycle 1(1): loaded http://localhost:54241/tests/dromaeo/cssquery-ext.html (next: http://localhost:54241/tests/dromaeo/cssquery-jquery.html) 22:13:40 INFO - PROCESS | 13023 | RSS: Main: 165605376 22:13:40 INFO - PROCESS | 13023 | 22:16:42 INFO - PROCESS | 13023 | Cycle 1(1): loaded http://localhost:54241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54241/tests/dromaeo/cssquery-mootools.html) 22:16:42 INFO - PROCESS | 13023 | RSS: Main: 166146048 22:16:42 INFO - PROCESS | 13023 | 22:19:44 INFO - PROCESS | 13023 | Cycle 1(1): loaded http://localhost:54241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54241/tests/dromaeo/cssquery-prototype.html) 22:19:45 INFO - PROCESS | 13023 | RSS: Main: 164085760 22:19:45 INFO - PROCESS | 13023 | 22:22:47 INFO - PROCESS | 13023 | Cycle 1(1): loaded http://localhost:54241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54241/tests/dromaeo/cssquery-yui.html) 22:22:48 INFO - PROCESS | 13023 | RSS: Main: 165400576 22:22:48 INFO - PROCESS | 13023 | 22:25:51 INFO - PROCESS | 13023 | Cycle 1(1): loaded http://localhost:54241/tests/dromaeo/cssquery-yui.html (next: http://localhost:54241/tests/dromaeo/cssquery-dojo.html) 22:25:51 INFO - PROCESS | 13023 | RSS: Main: 167387136 22:25:51 INFO - PROCESS | 13023 | 22:25:51 INFO - PROCESS | 13023 | __start_tp_report 22:25:51 INFO - PROCESS | 13023 | _x_x_mozilla_page_load 22:25:51 INFO - PROCESS | 13023 | _x_x_mozilla_page_load_details 22:25:51 INFO - PROCESS | 13023 | |i|pagename|runs| 22:25:51 INFO - PROCESS | 13023 | |0;dojo.html;2643.5373809583325;2710.7831373490117;2741;2741.39689268361;2750.0512323248486;4656.161890859648;4657.60410365119;4696.389469368985;4749.857504274873;4763.118823017744;4630.953690463094;4712.0811441768865;4791.880202994927;4815.590674792638;4890.070886531556;4369.10433361161;4420.734755914656;4491.797869095899;4512.616427603642;4542.863714088583;4434.268345722952;4453.910921781562;4482.260427029536;4499.595036446719;4545.477270113946;4389.253826849427;4408.9859332353735;4432.357308190294;4457.353683715875;4480.753558554278;4426.336049592554;4428.114377124588;4429.645628349725;4430.401895744098;4483.461984561841;4238.766867822269;4383.539728328544;4401.977990110061;4405.11897620474;4462.687611867171;4675.766211689402;4697.365855609517;4717.198076327033;4724.692894961817;4772.141014617368;5122.487751224885;5145.871353216162;5150.819721309774;5155.40712818027;5185.662931909452;5027.145385284511;5124.641275110744;5133.204353325241;5189.143791274473;5226.320578324831;4745.525447455296;4767.594754445841;4778.139934811733;4811.566958973709;4828.46886842447;5208.921866172011;5211.1922651989;5211.452797456288;5211.5049070338255;5229.660072095302;4890.364252647133;4934.3338649282605;4951.554360107608;5028.220625803006;5075.390953085654;4865.391826021747;5074.594032477393;5107.642465027412;5172.870678232999;5202.7918883245;5114.974425127925;5115.565176959925;5119.846404607868;5141.357330333708;5161.071007218661;4925.87685307863;4960.181570040975;5010.5240002199735;5099.209622508517;5117.385913690381;4275.1663425631705;4318.697691161588;4335.696501244883;4366.170427618742;4401.339799030171;3778.244351129785;3791.696664266852;3798.9240215196096;3826.273008128502;3830.2339532093692;4418.072204836956;4421.049474362963;4423.07115505741;4460.28635418338;4468.396766436555;5075.87310317245;5085.898282034339;5152.871178220575;5212.139996900545;5245.6852588844795;4444.82220711168;4447.2439685253585;4466.129104824528;4467.463904331501;4506.909861802746;4711.811527538928;4713.128071306819;4713.9764301178275;4715.033418149271;4761.095391875532;4717.575418212377;4842.854714358505;4868.975655121843;4894.437139728977;4916.852494425173;5002.924956125588;5062.873428164178;5066.265391518283;5080.136376815876;5120.436751957356;4624.075184962953;4802.471728109975;4807.110684523234;4814.422269327703;4852.611791056777;5012.824551140692;5072.188449848007;5092.821751238689;5096.719680417613;5129.512696293846;5194.117000110066;5215.6609820361555;5216.139337009351;5219.1388420910125;5267.104592219409;4831;4922.852314430573;5030.57240134578;5046.268291097696;5048.3941926969;4879.170541007966;4931.852044438672;4946.332245146859;4958.528939750718;4996.3504744383;4912.410510738734;4943.3573635427165;4947.3568436104515;4949.752512374439;5033.723145226902;4910.410750709938;5009.524095210949;5053.8736531587;5071.974640126923;5099.923501147411;4832.879178020437;4852.17513022794;4868.586170175433;4873.512648735098;4914.36113305268 22:25:51 INFO - PROCESS | 13023 | |1;ext.html;558.3217219304486;577.0593931891017;598.6767145741298;604.247711599059;630.2877748144596;32418.513722294156;33287;33597.16007099824;33629.32741345172;33720.66279337206;36617.45073823895;37412;37423.625763742355;37457.81271093641;37492;7638.885416718767;7813.374930005614;7819.335356494705;7820.608969551528;7823.10034346049;7748.41886858485;7787;7847;7873.409494287951;7877.212278772135;7791.961040194791;7854.960725196366;7871.409644276673;7875.173106823787;7885.172056934025;7807.219278072204;7855.8821617675785;7864.724734634317;7871.212878712112;7873.5275883447175;7738.380929525624;7790.220977902221;7802.648880800378;7847.469743400039;7877.960610196969;28660.71339286601;33666.1583460413;34346.48480272798;34352;34379.31241375183;3032.3632037271977;3169.889053883126;3217.5978002749657;3245.1562593725566;3378.983105084483;26382;27183.72816271832;27459.450810983868;27745.722542774718;28155;3393.389189945809;3395.6095049069427;3455.1362159460136;3471.444568868994;3555.591107022674;221231;225764.99999999837;226765;227328;227523;56393.71803140958;56437;56574.71712641411;56579;56899;60670.69664651649;61904;62190.68904655538;62289.377106228356;62324.68837655873;15386.230688465532;15620.609484762745;15668.764968525482;15671.529854104396;15737.134457604941;11524.423778811026;11589.188756787113;11615.128865335133;11713.531458741554;11720.17958742897;18720.438386848415;18956.715649265272;19020.334288299844;19122.71315930262;19234.80765192358;7496.325330720152;7609.505382150142;7611.505252158703;7652.693892244248;7746.419018573517;890.1988210610373;892.2549671024638;917.2203626917201;981.190517822799;1006.8590397344377;27650.032248871194;28453.430931381256;28895.42209155805;28910.710892890802;29029.56455653167;1026.9383836969805;1061.2783307351076;1061.867266591676;1073.683263437288;1082.2370228988543;14823;15174.772378414333;15359;15483;15550.611234719223;303245;307804;307811;309954;310006;48229;48957.265641015416;49356;49364.55718985308;49558.50441495611;1246.9314187719763;1263.886250237483;1279.3795009420423;1295.9935200323937;1302.856685764565;26651.333716656463;27959.720402796524;28010.579841302806;28045.579316309864;28524.714752852207;42726.35910461408;44238.557614423444;44549.33176002298;44556.55443445524;44576.55423445854;309126;310806;312351;312670;313083;25990.35024124412;26633;26685.46629067369;38840.41739373855;40198.79900600478;36650.266994659425;36849.07877303089;37289.25421491501;37458.25083498369;37990.24019519649;35340.46989295214;35575.11062223465;35732.285354292246;35893.64106358903;36015.45976810298;34635.82682086573;34769;35158;35410.822945885106;35517.112072198404;30616;34967.82516087403;35313.64686353206;36292.637073628925;37320;28256;28660.14019579416;29829;31141.8442907784;31496.842515787273;24288.1499147529;24619.384515387257;24834.82432905236;25001.624975625018;25109.372265693502 22:25:51 INFO - PROCESS | 13023 | |2;jquery.html;364.5698076270002;366.40093447213803;368.1403921842498;372.24434398171724;373.82617083056374;15673.216339183038;16274.186290685462;17762.911185444056;17804.198811053502;17828.286868525276;16471.505854824343;16720.916395418008;17347.39284125056;17401;17483.562910927234;5027.723475208872;5143.382794064718;5194;5195.376554813428;5208.062548741225;3717.5353080864893;5080.974595127038;5549.472800084006;5894.469497745202;5895.587308888379;5820.563457740686;5830.737616807254;5835.679037652927;5851.8537036574;5860.062390017598;5647.463490968372;6069.3323734389405;6075.058365953262;6082.8783424331705;6103.23709536308;5067.974660126676;5312.415634280264;5350.839474815762;5353.866153346158;5369.275147855029;20305.898470507702;20405.489862753402;20409.183632654676;20492.795072049237;20533.794662053337;1882.190658017052;1997.9200831966705;2193.287181665949;2251.1558165687866;2290.946164764194;13106.148100373444;13264.867351326557;13420.530281440102;13446.126001809851;13510.121842080232;1651.223924755363;1716.888402253862;1749.7462867884085;1767.2130011434867;1781.616952355237;65770;65969.3403065968;66440.3355966439;66465;66518.66740666314;9140.862887056566;9341.766455838522;9504.809903802023;9991.600335986624;10099.798004039878;13676.452941882413;13759.243241621607;13774.586762397144;13820.170789752647;13836.861631383557;7224.313690199423;7702.537847729154;7848.450608457353;7880.724174653859;7884.250996155356;7470.775876723707;7572.545647261182;7666.156722760492;7688.923110768821;7773.18381569927;5880.117982302689;6068.939310606926;6088.117223002729;6112.755489780359;6218.129461875341;1547.4351861570672;1621.910794906268;1715.3567412220418;1848.5655870870335;1874.5219968908114;852.032942610142;889.3596610440602;922.2022950148073;945.9195968342768;995.8878504672897;15365.769513457308;15793.526194214191;16761.91619041897;17471.213795379237;17480.650386992187;895.7671005538607;902.9975332021056;907.8275127725711;957.1242313283407;963.7879666473365;9856.408615483095;9875.209983201326;9908;9931;10075.34510256831;357893;368128;369407;369454;370683;67220.32779672238;68682;70424.2957570428;71569.28430715627;73962.99999999892;946.9857952130724;949.4635530925005;955.0640372435053;977.5845265762165;1016.903394177552;14752.704945901236;14763.409463621334;14783.441988867911;15828.60428489297;16250;34723.479147813305;35410.46884296789;35427.29145417129;36250.27499450049;36480;49904;50964.74517627388;52126;52127.47872521226;52198.478015220884;7454.776356709307;7565.243475652611;7573.6213189341415;7640.80897977555;7649.579273140031;8767.386282960131;9471.857922131036;11383.146264030065;12150.817737733763;12210.694732631755;9985.1512621428;10134.239932005277;10156.035176658206;10231.43727095017;10336;9910.603575856885;9998.200143988319;10114.595416183565;10384.480775961021;10451.477426128511;9888.604455821687;10239.897601023895;10243.129334006693;10338;10482.37105773656;7322.926770732438;7418.554886706815;7464.738734144279;7508.324250817453;7705.537667739729;10078.697639070839;10399.27205095636;10431.58273669075;10576.36541807494;10610.734731631772 22:25:51 INFO - PROCESS | 13023 | |3;mootools.html;1483.1471903655402;1509.9849001509983;1665.9521649402316;1796.7215081662348;1822.0434272007187;6789.7284108635595;7582.658780354884;7660.463767536275;7836.882446763296;7857.646405911733;7701.807454813633;7745.07059152901;7772.106207786106;7823.843523129548;7845.09781375142;2185.15871389515;2193.9890300548477;2202.6916231727573;2202.944926376845;2209.414505156127;2186.737591489016;2190.310052333518;2230.230570453199;2231.5983123037845;2237.5748607764554;2204.2505548113636;2222.4554984028855;2225.5978733397938;2235.16181431963;2235.508188198602;2148.1729534129317;2151.8386121040908;2178.2485042660337;2181.018541656261;2183.148572056899;2150.5913876363597;2170.555036217572;2171.9674204886937;2183.705199798023;2184.049938276855;7840.255175758294;7860.921390786076;7865.488743231672;7880.527168369917;7884.369250459949;4448.8442904498515;4595.7702114894455;4598.287265473857;4618.468876079261;4621.075784843045;2767.169849045278;2822.350859302372;2856.9857150714115;2890.783191260664;2925.546540286259;871.8997315308694;904.5070436612062;911.6325511732401;917.0874979395478;924.6809850601531;10717.303375280582;10753.677389678322;10781.137508999262;10782.622608208754;10786.191035672357;4003.2994226010333;4246.426732391088;4259.97870010648;4276.401303817468;4280.143971205771;9252.53737313145;9284.303677224236;9285.071492850797;9288;9308.348415610977;4691.483936766953;4717.198076327033;4720.150372932905;4724.952750472451;4727.267273572533;3777.697784177259;4311.374850646639;4321.891952701145;4337.240982827992;4349.217140914666;3729.4592284119194;3733.9626603733614;3822.541295044557;3863.671587915059;3878.8836334909997;1257.2330878164312;1260.4265059398135;1265.816456613786;1271.2499625221164;1294.087668193921;1199.7660456210956;1204.265398107154;1223.0643557678384;1248.806435002558;1265.3420221484776;7384.852302954018;7436.442266830009;7448.031755871702;7460.85078298431;7568.3945284378215;429.95270520242747;435.0559286348631;435.44915681662724;440.1768692544961;442.1135623075777;5676.687782171937;5734.111212762028;5737.913931291034;5747.655140691572;5767.307923049177;9016;9180.31147663928;9353.906460935303;9358.859617105749;9394.953025234967;9320.673776417792;9326.440413575207;9365.203957663674;9381.155695987394;9431.90568094324;6733.93266067333;7089.361957423856;7126.857462850714;7146.857062858714;7173.641317934187;7359.889601656087;7423.92576074254;7489.251074892467;7506.512076714996;7663.233676632515;8995.100489951214;9015.2787776979;9027.909720902708;9187.402818816756;9205.171534561921;8925.598348074482;9084.591193396182;9203.815923681355;9314.44113353201;9356.485393303434;5956.821295361146;6490.091387205889;6699.933000670126;6985.5808651481075;7176.282371762782;7291.30732580404;7341.3392794648735;7356.448266379936;7369.520981136209;7413.8146546336775;6414.326495718069;6688.297728738413;6708.429783468265;6714.664266786739;6753.729850805913;6601.141851559267;6612.5040621952585;6627.536072474881;6663.400293973566;6664.5334826561675;6846.452283817183;6851.931480685129;6868.450523958171;6869.381755642016;6900.068490753884;6384;6564.8358791030605;6572.047053177167;6629.171353580802;6632.900506492503;6420.967895160495;6435.871282574416;6438.259600146043;6457.3865482779065;6468.5472016958365 22:25:51 INFO - PROCESS | 13023 | |4;prototype.html;299.8350907001149;302.5975452647978;304.61466245199824;305.8883507519756;315.3676877859891;5177.792888284469;5216.634835561512;5286.541758082491;5338.946610533893;5354.839354819352;5210.5310522053005;5240.895182096356;5267;5274.604404669655;5311;3887.688984881203;4000.379941109118;4084.550699423061;4109.075458021951;4122.051928056549;4097.692673049518;4142.150859073882;4145.8963525911795;4149.170165966803;4157.5634558371385;4085.9785053736564;4086.2031903778625;4116.855910043149;4130.97934510327;4137.81379837908;4049.736767110158;4099.323611604082;4128.236276288866;4134.090500089976;4134.4625198724125;3632.346177688015;3649.6897763690117;3651.8174091295327;3656.945145822815;3671.4859919611276;5041.143005689041;5047.116754567936;5048.419431765357;5070.492950704936;5070.670406423607;4795;4798.0643774464;4802.303665968415;4804.5916097131785;4806.855794326176;5266.789328426858;5584.190292407578;5598;5601.915971260393;5629.746661400247;3867.7485963412287;3869.941950870739;3873.8837834865;3875.7210120660116;3876;5704.71476426177;5735.397783232784;5848.67832269225;5851.297844258674;5860.619059761102;3913.412988051815;3923.6664883484655;3925.1953349563273;3947.802609869495;3955.723099383073;3972.205558888234;3985.5217373915316;3992.780397078189;3999.4000899864673;4011.5558398976345;4597.402337696078;4619.630429565626;4635.768211589407;4642.630424024921;4678.976605116953;5444.156155795858;5544.944550554524;5592.1134811306565;5601.915971260434;5605.579581531401;1386.9306534673226;1410.781328894023;1412.6185929799103;1416.652920034598;1417.2134465371612;903.6475774447971;928.252756530999;947.7062110745691;949.2832911152036;953.0850383631653;4724.456687480915;4796.664233503621;4946.307516947631;4946.950530494721;4968.105740966661;5819.767209311664;5827.621204621686;5832.24180856486;5836.299644042742;5850.502707269845;4663;4945.579625731782;4952.182889823211;4956.182229932021;4959.70241785494;3059.3881223754893;3080.476319025771;3088.1507585414192;3101.8449077546034;3108.98445507771;5441.782328706808;5445.809396671098;5449.591280653887;5492.835214943558;5511.311086114236;5823.583212966656;5891.05743081105;5957.791477298274;5973.954557952341;5979.133025711248;5484.91772623411;5494.917576236359;5506.587005974568;5526.2145430380315;5539.7784088636;5630.324361076697;5765.538756899354;5819.6508209507565;5845.649261044351;5853.824385268449;5693.4021927696995;5693.544516438592;5696.686682232517;5699.857503562278;5720.8283751487525;5493.121100623881;5497.862553436036;5504.587155963239;5509;5517.172424136412;3782.6028267032666;3971.8609848656315;3990.1620659660634;4014.0566966762203;4032.395140728914;5720.427957204246;5746.13807928814;5767.423257674199;5804.738786754522;5804.854878628068;5546.805861794818;5558.249636299048;5568.916466252928;5586;5607.719614019201;5323.574114070788;5529.668219906818;5535.280413546374;5540.667559946416;5545.33639908034;5461.098918678533;5487.725613719378;5499.835004949858;5510.669359838423;5523.392426832965;5357.491038351351;5487.176923461513;5598.776048957996;5639;5646.124850648156;5443.713640271017;5480.698561579152;5490.094134467928;5504.422035686195;5505.889882202254 22:25:51 INFO - PROCESS | 13023 | |5;yui.html;579.956079057696;602.3645054467538;643.9999999999997;661.6294874870073;661.8160071763182;11371.886281137186;11480.368579728112;11501.079913606913;12000.699982500442;12216.328101954412;12223.449944752485;12262.141650084497;12263.448144833481;12295.938520307409;12305.938470307658;647.6081970407906;787.5943888897223;793.4445887878479;814.5235037503068;817.452306954342;816.3387655998661;820.1839170025833;822.7901885019342;823.555280148719;824.5217773691274;844.7972486603202;852.3735054734765;854.5556310718423;854.7521218846528;859.4800145911696;845.5476320168711;847.6990668312721;849.6728759427665;850.0437008365589;851.825375797963;624.8312955502034;625.7903602293237;625.7934881489098;626.2703949898363;626.5582764151262;12245.816312755316;12379.504819807196;12429.31638759868;12452.501899923993;12479.75040499185;12942.482300707961;13005.479780808757;13030.934845325713;13117;13247.88018067997;9902.653407130716;10069.949650251701;10204.183665306758;10265.281430299881;10399.376037437778;3293.3907227162813;3297.9835100824343;3349.949750753716;3360.647132051148;3394.049666093473;42382.78808605968;42651.1469770606;43474.782626086984;44073;44403.333949990774;9570.47362395075;9647.807043859084;9870.654527091518;9884.11043006133;10010.749731256632;16127;16129;16202.946808457413;16242.269097890623;16959.745603815954;6974.407175390149;7054.6825392857445;7082.645867706594;7154.856902861914;7203.351698347174;3631.3463576556474;3706.258748250307;3755.4179102239195;3759.680427163667;3815.4849095372324;2937.3390987027747;3119.438501069784;3123.7500999919953;3130.0609817055247;3130.7182353588287;539.2908325551887;552.7512619321241;554.5812911251979;554.9167624856303;558.5531574740191;439.20942303853576;533.8104972734701;537.4142185018349;565.0845630079216;580.773498335641;7827.9608601956625;7843.803904902423;7951.721689740947;8295.502269863828;8392.916070839214;613.687019619997;617.4196255519797;639.6226226526372;639.9968297370634;652.787843950718;3880.9611903881164;3902.5316961964745;3934.8622798201927;3977.0455090778005;4027.395890616431;46431;46504;47349.763251183525;47406.5259347409;47652.76173619179;43218.783906080265;43374.13251734948;44245.11509769851;44288.11423771507;45234.77382613131;40910;40943.795281024;41048.589514104475;41303.586964130576;42054.579454205064;7377.372923301579;7450.925490745023;7535.6985720570565;7923.3661307096445;8288.254057134645;26250.343741406617;26538.60192097159;27070.05254816072;27142.864285679236;27399.589006165323;34758.30483390368;35229.47155792614;36781;37040.444393333586;37625.4356184652;10978.176636752116;11019.779604407706;11039.116870650168;11255.380954047607;11304.660860174208;11845.289282643069;12219.75560488803;12324.137310388187;12335.444904979477;12525.248485090924;11386.43067846621;11487.597934072268;11986.76026479483;12047.33739644328;12052.638420847388;11473;11487.425628718363;11502.597409090642;11875.574931008334;11891;11179.496922638664;11538.134639901873;11545.88454115448;11577.131715121232;11581.681066773279;9475.47884866339;9579.233661307218;9743.123118919331;9751.707448776264;10178;9485.383450075724;9685.70942871715;9766.037585444235;9820.312578119463;9825.557849896915 22:25:51 INFO - PROCESS | 13023 | __end_tp_report 22:25:51 INFO - PROCESS | 13023 | __start_cc_report 22:25:51 INFO - PROCESS | 13023 | _x_x_mozilla_cycle_collect,370 22:25:51 INFO - PROCESS | 13023 | __end_cc_report 22:25:51 INFO - PROCESS | 13023 | __startTimestamp1460179551332__endTimestamp 22:25:51 INFO - PROCESS | 13023 | 22:25:51 INFO - PROCESS | 13023 | ------- Summary: start ------- 22:25:51 INFO - PROCESS | 13023 | Number of tests: 6 22:25:51 INFO - PROCESS | 13023 | 22:25:51 INFO - PROCESS | 13023 | [#0] dojo.html Cycles:165 Average:4736.80 Median:4852.18 stddev:484.26 (10.0%) stddev-sans-first:457.06 22:25:51 INFO - PROCESS | 13023 | Values: 2643.5 2710.8 2741.0 2741.4 2750.1 4656.2 4657.6 4696.4 4749.9 4763.1 4631.0 4712.1 4791.9 4815.6 4890.1 4369.1 4420.7 4491.8 4512.6 4542.9 4434.3 4453.9 4482.3 4499.6 4545.5 4389.3 4409.0 4432.4 4457.4 4480.8 4426.3 4428.1 4429.6 4430.4 4483.5 4238.8 4383.5 4402.0 4405.1 4462.7 4675.8 4697.4 4717.2 4724.7 4772.1 5122.5 5145.9 5150.8 5155.4 5185.7 5027.1 5124.6 5133.2 5189.1 5226.3 4745.5 4767.6 4778.1 4811.6 4828.5 5208.9 5211.2 5211.5 5211.5 5229.7 4890.4 4934.3 4951.6 5028.2 5075.4 4865.4 5074.6 5107.6 5172.9 5202.8 5115.0 5115.6 5119.8 5141.4 5161.1 4925.9 4960.2 5010.5 5099.2 5117.4 4275.2 4318.7 4335.7 4366.2 4401.3 3778.2 3791.7 3798.9 3826.3 3830.2 4418.1 4421.0 4423.1 4460.3 4468.4 5075.9 5085.9 5152.9 5212.1 5245.7 4444.8 4447.2 4466.1 4467.5 4506.9 4711.8 4713.1 4714.0 4715.0 4761.1 4717.6 4842.9 4869.0 4894.4 4916.9 5002.9 5062.9 5066.3 5080.1 5120.4 4624.1 4802.5 4807.1 4814.4 4852.6 5012.8 5072.2 5092.8 5096.7 5129.5 5194.1 5215.7 5216.1 5219.1 5267.1 4831.0 4922.9 5030.6 5046.3 5048.4 4879.2 4931.9 4946.3 4958.5 4996.4 4912.4 4943.4 4947.4 4949.8 5033.7 4910.4 5009.5 5053.9 5072.0 5099.9 4832.9 4852.2 4868.6 4873.5 4914.4 22:25:51 INFO - PROCESS | 13023 | 22:25:51 INFO - PROCESS | 13023 | [#1] ext.html Cycles:180 Average:44232.62 Median:34365.66 stddev:74502.87 (216.8%) stddev-sans-first:74639.71 22:25:51 INFO - PROCESS | 13023 | Values: 558.3 577.1 598.7 604.2 630.3 32418.5 33287.0 33597.2 33629.3 33720.7 36617.5 37412.0 37423.6 37457.8 37492.0 7638.9 7813.4 7819.3 7820.6 7823.1 7748.4 7787.0 7847.0 7873.4 7877.2 7792.0 7855.0 7871.4 7875.2 7885.2 7807.2 7855.9 7864.7 7871.2 7873.5 7738.4 7790.2 7802.6 7847.5 7878.0 28660.7 33666.2 34346.5 34352.0 34379.3 3032.4 3169.9 3217.6 3245.2 3379.0 26382.0 27183.7 27459.5 27745.7 28155.0 3393.4 3395.6 3455.1 3471.4 3555.6 221231.0 225765.0 226765.0 227328.0 227523.0 56393.7 56437.0 56574.7 56579.0 56899.0 60670.7 61904.0 62190.7 62289.4 62324.7 15386.2 15620.6 15668.8 15671.5 15737.1 11524.4 11589.2 11615.1 11713.5 11720.2 18720.4 18956.7 19020.3 19122.7 19234.8 7496.3 7609.5 7611.5 7652.7 7746.4 890.2 892.3 917.2 981.2 1006.9 27650.0 28453.4 28895.4 28910.7 29029.6 1026.9 1061.3 1061.9 1073.7 1082.2 14823.0 15174.8 15359.0 15483.0 15550.6 303245.0 307804.0 307811.0 309954.0 310006.0 48229.0 48957.3 49356.0 49364.6 49558.5 1246.9 1263.9 1279.4 1296.0 1302.9 26651.3 27959.7 28010.6 28045.6 28524.7 42726.4 44238.6 44549.3 44556.6 44576.6 309126.0 310806.0 312351.0 312670.0 313083.0 25990.4 26633.0 26685.5 38840.4 40198.8 36650.3 36849.1 37289.3 37458.3 37990.2 35340.5 35575.1 35732.3 35893.6 36015.5 34635.8 34769.0 35158.0 35410.8 35517.1 30616.0 34967.8 35313.6 36292.6 37320.0 28256.0 28660.1 29829.0 31141.8 31496.8 24288.1 24619.4 24834.8 25001.6 25109.4 22:25:51 INFO - PROCESS | 13023 | 22:25:51 INFO - PROCESS | 13023 | [#2] jquery.html Cycles:180 Average:23568.98 Median:5074.47 stddev:60515.64 (1192.5%) stddev-sans-first:60660.33 22:25:51 INFO - PROCESS | 13023 | Values: 364.6 366.4 368.1 372.2 373.8 15673.2 16274.2 17762.9 17804.2 17828.3 16471.5 16720.9 17347.4 17401.0 17483.6 5027.7 5143.4 5194.0 5195.4 5208.1 3717.5 5081.0 5549.5 5894.5 5895.6 5820.6 5830.7 5835.7 5851.9 5860.1 5647.5 6069.3 6075.1 6082.9 6103.2 5068.0 5312.4 5350.8 5353.9 5369.3 20305.9 20405.5 20409.2 20492.8 20533.8 1882.2 1997.9 2193.3 2251.2 2290.9 13106.1 13264.9 13420.5 13446.1 13510.1 1651.2 1716.9 1749.7 1767.2 1781.6 65770.0 65969.3 66440.3 66465.0 66518.7 9140.9 9341.8 9504.8 9991.6 10099.8 13676.5 13759.2 13774.6 13820.2 13836.9 7224.3 7702.5 7848.5 7880.7 7884.3 7470.8 7572.5 7666.2 7688.9 7773.2 5880.1 6068.9 6088.1 6112.8 6218.1 1547.4 1621.9 1715.4 1848.6 1874.5 852.0 889.4 922.2 945.9 995.9 15365.8 15793.5 16761.9 17471.2 17480.7 895.8 903.0 907.8 957.1 963.8 9856.4 9875.2 9908.0 9931.0 10075.3 357893.0 368128.0 369407.0 369454.0 370683.0 67220.3 68682.0 70424.3 71569.3 73963.0 947.0 949.5 955.1 977.6 1016.9 14752.7 14763.4 14783.4 15828.6 16250.0 34723.5 35410.5 35427.3 36250.3 36480.0 49904.0 50964.7 52126.0 52127.5 52198.5 7454.8 7565.2 7573.6 7640.8 7649.6 8767.4 9471.9 11383.1 12150.8 12210.7 9985.2 10134.2 10156.0 10231.4 10336.0 9910.6 9998.2 10114.6 10384.5 10451.5 9888.6 10239.9 10243.1 10338.0 10482.4 7322.9 7418.6 7464.7 7508.3 7705.5 10078.7 10399.3 10431.6 10576.4 10610.7 22:25:51 INFO - PROCESS | 13023 | 22:25:51 INFO - PROCESS | 13023 | [#3] mootools.html Cycles:180 Average:5441.52 Median:6447.82 stddev:2901.27 (45.0%) stddev-sans-first:2894.15 22:25:51 INFO - PROCESS | 13023 | Values: 1483.1 1510.0 1666.0 1796.7 1822.0 6789.7 7582.7 7660.5 7836.9 7857.6 7701.8 7745.1 7772.1 7823.8 7845.1 2185.2 2194.0 2202.7 2202.9 2209.4 2186.7 2190.3 2230.2 2231.6 2237.6 2204.3 2222.5 2225.6 2235.2 2235.5 2148.2 2151.8 2178.2 2181.0 2183.1 2150.6 2170.6 2172.0 2183.7 2184.0 7840.3 7860.9 7865.5 7880.5 7884.4 4448.8 4595.8 4598.3 4618.5 4621.1 2767.2 2822.4 2857.0 2890.8 2925.5 871.9 904.5 911.6 917.1 924.7 10717.3 10753.7 10781.1 10782.6 10786.2 4003.3 4246.4 4260.0 4276.4 4280.1 9252.5 9284.3 9285.1 9288.0 9308.3 4691.5 4717.2 4720.2 4725.0 4727.3 3777.7 4311.4 4321.9 4337.2 4349.2 3729.5 3734.0 3822.5 3863.7 3878.9 1257.2 1260.4 1265.8 1271.2 1294.1 1199.8 1204.3 1223.1 1248.8 1265.3 7384.9 7436.4 7448.0 7460.9 7568.4 430.0 435.1 435.4 440.2 442.1 5676.7 5734.1 5737.9 5747.7 5767.3 9016.0 9180.3 9353.9 9358.9 9395.0 9320.7 9326.4 9365.2 9381.2 9431.9 6733.9 7089.4 7126.9 7146.9 7173.6 7359.9 7423.9 7489.3 7506.5 7663.2 8995.1 9015.3 9027.9 9187.4 9205.2 8925.6 9084.6 9203.8 9314.4 9356.5 5956.8 6490.1 6699.9 6985.6 7176.3 7291.3 7341.3 7356.4 7369.5 7413.8 6414.3 6688.3 6708.4 6714.7 6753.7 6601.1 6612.5 6627.5 6663.4 6664.5 6846.5 6851.9 6868.5 6869.4 6900.1 6384.0 6564.8 6572.0 6629.2 6632.9 6421.0 6435.9 6438.3 6457.4 6468.5 22:25:51 INFO - PROCESS | 13023 | 22:25:51 INFO - PROCESS | 13023 | [#4] prototype.html Cycles:180 Average:4620.29 Median:5270.80 stddev:1363.02 (25.9%) stddev-sans-first:1327.71 22:25:51 INFO - PROCESS | 13023 | Values: 299.8 302.6 304.6 305.9 315.4 5177.8 5216.6 5286.5 5338.9 5354.8 5210.5 5240.9 5267.0 5274.6 5311.0 3887.7 4000.4 4084.6 4109.1 4122.1 4097.7 4142.2 4145.9 4149.2 4157.6 4086.0 4086.2 4116.9 4131.0 4137.8 4049.7 4099.3 4128.2 4134.1 4134.5 3632.3 3649.7 3651.8 3656.9 3671.5 5041.1 5047.1 5048.4 5070.5 5070.7 4795.0 4798.1 4802.3 4804.6 4806.9 5266.8 5584.2 5598.0 5601.9 5629.7 3867.7 3869.9 3873.9 3875.7 3876.0 5704.7 5735.4 5848.7 5851.3 5860.6 3913.4 3923.7 3925.2 3947.8 3955.7 3972.2 3985.5 3992.8 3999.4 4011.6 4597.4 4619.6 4635.8 4642.6 4679.0 5444.2 5544.9 5592.1 5601.9 5605.6 1386.9 1410.8 1412.6 1416.7 1417.2 903.6 928.3 947.7 949.3 953.1 4724.5 4796.7 4946.3 4947.0 4968.1 5819.8 5827.6 5832.2 5836.3 5850.5 4663.0 4945.6 4952.2 4956.2 4959.7 3059.4 3080.5 3088.2 3101.8 3109.0 5441.8 5445.8 5449.6 5492.8 5511.3 5823.6 5891.1 5957.8 5974.0 5979.1 5484.9 5494.9 5506.6 5526.2 5539.8 5630.3 5765.5 5819.7 5845.6 5853.8 5693.4 5693.5 5696.7 5699.9 5720.8 5493.1 5497.9 5504.6 5509.0 5517.2 3782.6 3971.9 3990.2 4014.1 4032.4 5720.4 5746.1 5767.4 5804.7 5804.9 5546.8 5558.2 5568.9 5586.0 5607.7 5323.6 5529.7 5535.3 5540.7 5545.3 5461.1 5487.7 5499.8 5510.7 5523.4 5357.5 5487.2 5598.8 5639.0 5646.1 5443.7 5480.7 5490.1 5504.4 5505.9 22:25:51 INFO - PROCESS | 13023 | 22:25:51 INFO - PROCESS | 13023 | [#5] yui.html Cycles:180 Average:12380.66 Median:42218.68 stddev:13417.83 (31.8%) stddev-sans-first:13426.20 22:25:51 INFO - PROCESS | 13023 | Values: 580.0 602.4 644.0 661.6 661.8 11371.9 11480.4 11501.1 12000.7 12216.3 12223.4 12262.1 12263.4 12295.9 12305.9 647.6 787.6 793.4 814.5 817.5 816.3 820.2 822.8 823.6 824.5 844.8 852.4 854.6 854.8 859.5 845.5 847.7 849.7 850.0 851.8 624.8 625.8 625.8 626.3 626.6 12245.8 12379.5 12429.3 12452.5 12479.8 12942.5 13005.5 13030.9 13117.0 13247.9 9902.7 10069.9 10204.2 10265.3 10399.4 3293.4 3298.0 3349.9 3360.6 3394.0 42382.8 42651.1 43474.8 44073.0 44403.3 9570.5 9647.8 9870.7 9884.1 10010.7 16127.0 16129.0 16202.9 16242.3 16959.7 6974.4 7054.7 7082.6 7154.9 7203.4 3631.3 3706.3 3755.4 3759.7 3815.5 2937.3 3119.4 3123.8 3130.1 3130.7 539.3 552.8 554.6 554.9 558.6 439.2 533.8 537.4 565.1 580.8 7828.0 7843.8 7951.7 8295.5 8392.9 613.7 617.4 639.6 640.0 652.8 3881.0 3902.5 3934.9 3977.0 4027.4 46431.0 46504.0 47349.8 47406.5 47652.8 43218.8 43374.1 44245.1 44288.1 45234.8 40910.0 40943.8 41048.6 41303.6 42054.6 7377.4 7450.9 7535.7 7923.4 8288.3 26250.3 26538.6 27070.1 27142.9 27399.6 34758.3 35229.5 36781.0 37040.4 37625.4 10978.2 11019.8 11039.1 11255.4 11304.7 11845.3 12219.8 12324.1 12335.4 12525.2 11386.4 11487.6 11986.8 12047.3 12052.6 11473.0 11487.4 11502.6 11875.6 11891.0 11179.5 11538.1 11545.9 11577.1 11581.7 9475.5 9579.2 9743.1 9751.7 10178.0 9485.4 9685.7 9766.0 9820.3 9825.6 22:25:51 INFO - PROCESS | 13023 | -------- Summary: end -------- 22:25:51 INFO - PROCESS | 13023 | 22:25:52 INFO - TEST-INFO | 13023: exit 0 22:25:52 INFO - TEST-OK | dromaeo_css | took 1115550ms 22:25:52 INFO - TEST-START | kraken 22:25:52 INFO - operating with platform_type : linux_ 22:25:52 INFO - Initialising browser for kraken test... 22:25:52 INFO - TEST-INFO | started process 13261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_f8oXt/profile http://localhost:54241/getInfo.html) 22:25:56 INFO - PROCESS | 13261 | 22:25:56 INFO - PROCESS | 13261 | (process:13330): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:25:56 INFO - PROCESS | 13261 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 22:25:57 INFO - PROCESS | 13261 | __metrics Screen width/height:1600/1200 22:25:57 INFO - PROCESS | 13261 | colorDepth:24 22:25:57 INFO - PROCESS | 13261 | Browser inner width/height: 1024/697 22:25:57 INFO - PROCESS | 13261 | __metrics 22:25:57 ERROR - PROCESS | 13261 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 22:25:58 INFO - TEST-INFO | 13261: exit 0 22:25:58 INFO - Browser initialized. 22:25:58 INFO - Running cycle 1/1 for kraken test... 22:25:58 INFO - TEST-INFO | started process 13381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_f8oXt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:26:00 INFO - PROCESS | 13381 | 22:26:00 INFO - PROCESS | 13381 | (process:13440): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:26:10 INFO - PROCESS | 13381 | RSS: Main: 164585472 22:26:10 INFO - PROCESS | 13381 | 22:26:13 INFO - PROCESS | 13381 | Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54241/tests/kraken/driver.html?testName=audio-beat-detection) 22:26:13 INFO - PROCESS | 13381 | RSS: Main: 168849408 22:26:13 INFO - PROCESS | 13381 | 22:26:16 INFO - PROCESS | 13381 | Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54241/tests/kraken/driver.html?testName=audio-dft) 22:26:17 INFO - PROCESS | 13381 | RSS: Main: 171827200 22:26:17 INFO - PROCESS | 13381 | 22:26:20 INFO - PROCESS | 13381 | Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54241/tests/kraken/driver.html?testName=audio-fft) 22:26:20 INFO - PROCESS | 13381 | RSS: Main: 163438592 22:26:20 INFO - PROCESS | 13381 | 22:26:23 INFO - PROCESS | 13381 | Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54241/tests/kraken/driver.html?testName=audio-oscillator) 22:26:23 INFO - PROCESS | 13381 | RSS: Main: 163721216 22:26:23 INFO - PROCESS | 13381 | 22:26:25 INFO - PROCESS | 13381 | Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:26:26 INFO - PROCESS | 13381 | RSS: Main: 164171776 22:26:26 INFO - PROCESS | 13381 | 22:26:29 INFO - PROCESS | 13381 | Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54241/tests/kraken/driver.html?testName=imaging-darkroom) 22:26:30 INFO - PROCESS | 13381 | RSS: Main: 164638720 22:26:30 INFO - PROCESS | 13381 | 22:26:33 INFO - PROCESS | 13381 | Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54241/tests/kraken/driver.html?testName=imaging-desaturate) 22:26:34 INFO - PROCESS | 13381 | RSS: Main: 164311040 22:26:34 INFO - PROCESS | 13381 | 22:26:37 INFO - PROCESS | 13381 | Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54241/tests/kraken/driver.html?testName=json-parse-financial) 22:26:38 INFO - PROCESS | 13381 | RSS: Main: 165158912 22:26:38 INFO - PROCESS | 13381 | 22:26:39 INFO - PROCESS | 13381 | Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:26:40 INFO - PROCESS | 13381 | RSS: Main: 165023744 22:26:40 INFO - PROCESS | 13381 | 22:26:42 INFO - PROCESS | 13381 | Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:26:42 INFO - PROCESS | 13381 | RSS: Main: 165326848 22:26:42 INFO - PROCESS | 13381 | 22:26:45 INFO - PROCESS | 13381 | Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:26:45 INFO - PROCESS | 13381 | RSS: Main: 165658624 22:26:45 INFO - PROCESS | 13381 | 22:26:48 INFO - PROCESS | 13381 | Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:26:49 INFO - PROCESS | 13381 | RSS: Main: 166010880 22:26:49 INFO - PROCESS | 13381 | 22:26:52 INFO - PROCESS | 13381 | Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:26:52 INFO - PROCESS | 13381 | RSS: Main: 165941248 22:26:52 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | Cycle 1(1): loaded http://localhost:54241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54241/tests/kraken/driver.html?testName=ai-astar) 22:26:54 INFO - PROCESS | 13381 | RSS: Main: 167223296 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | __start_tp_report 22:26:54 INFO - PROCESS | 13381 | _x_x_mozilla_page_load 22:26:54 INFO - PROCESS | 13381 | _x_x_mozilla_page_load_details 22:26:54 INFO - PROCESS | 13381 | |i|pagename|runs| 22:26:54 INFO - PROCESS | 13381 | |0;ai-astar;115;108;117;114;115;127;113;114;113;113 22:26:54 INFO - PROCESS | 13381 | |1;audio-beat-detection;156;140;159;183;134;163;161;134;188;135 22:26:54 INFO - PROCESS | 13381 | |2;audio-dft;164;165;161;162;164;173;164;163;166;164 22:26:54 INFO - PROCESS | 13381 | |3;audio-fft;74;75;74;75;74;73;77;152;73;76 22:26:54 INFO - PROCESS | 13381 | |4;audio-oscillator;93;94;138;95;96;94;141;93;94;143 22:26:54 INFO - PROCESS | 13381 | |5;imaging-gaussian-blur;122;120;117;117;118;117;117;119;118;118 22:26:54 INFO - PROCESS | 13381 | |6;imaging-darkroom;147;146;147;147;147;147;147;150;147;147 22:26:54 INFO - PROCESS | 13381 | |7;imaging-desaturate;96;96;96;96;96;96;97;97;96;95 22:26:54 INFO - PROCESS | 13381 | |8;json-parse-financial;65;66;65;66;65;65;67;65;66;66 22:26:54 INFO - PROCESS | 13381 | |9;json-stringify-tinderbox;64;63;65;65;65;67;65;65;64;64 22:26:54 INFO - PROCESS | 13381 | |10;stanford-crypto-aes;88;87;85;86;86;87;85;84;95;88 22:26:54 INFO - PROCESS | 13381 | |11;stanford-crypto-ccm;141;157;148;137;139;147;147;151;140;141 22:26:54 INFO - PROCESS | 13381 | |12;stanford-crypto-pbkdf2;179;180;182;172;173;171;173;174;172;174 22:26:54 INFO - PROCESS | 13381 | |13;stanford-crypto-sha256-iterative;73;74;71;72;71;72;73;73;70;71 22:26:54 INFO - PROCESS | 13381 | __end_tp_report 22:26:54 INFO - PROCESS | 13381 | __start_cc_report 22:26:54 INFO - PROCESS | 13381 | _x_x_mozilla_cycle_collect,899 22:26:54 INFO - PROCESS | 13381 | __end_cc_report 22:26:54 INFO - PROCESS | 13381 | __startTimestamp1460179614679__endTimestamp 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | ------- Summary: start ------- 22:26:54 INFO - PROCESS | 13381 | Number of tests: 14 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | [#0] ai-astar Cycles:10 Average:114.90 Median:114.50 stddev:4.84 (4.2%) stddev-sans-first:5.13 22:26:54 INFO - PROCESS | 13381 | Values: 115.0 108.0 117.0 114.0 115.0 127.0 113.0 114.0 113.0 113.0 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | [#1] audio-beat-detection Cycles:10 Average:155.30 Median:160.00 stddev:19.71 (12.3%) stddev-sans-first:20.90 22:26:54 INFO - PROCESS | 13381 | Values: 156.0 140.0 159.0 183.0 134.0 163.0 161.0 134.0 188.0 135.0 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:3.27 (2.0%) stddev-sans-first:3.46 22:26:54 INFO - PROCESS | 13381 | Values: 164.0 165.0 161.0 162.0 164.0 173.0 164.0 163.0 166.0 164.0 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | [#3] audio-fft Cycles:10 Average:82.30 Median:74.50 stddev:24.52 (32.9%) stddev-sans-first:25.83 22:26:54 INFO - PROCESS | 13381 | Values: 74.0 75.0 74.0 75.0 74.0 73.0 77.0 152.0 73.0 76.0 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:94.00 stddev:22.52 (24.0%) stddev-sans-first:23.22 22:26:54 INFO - PROCESS | 13381 | Values: 93.0 94.0 138.0 95.0 96.0 94.0 141.0 93.0 94.0 143.0 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:1.64 (1.4%) stddev-sans-first:1.05 22:26:54 INFO - PROCESS | 13381 | Values: 122.0 120.0 117.0 117.0 118.0 117.0 117.0 119.0 118.0 118.0 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 22:26:54 INFO - PROCESS | 13381 | Values: 147.0 146.0 147.0 147.0 147.0 147.0 147.0 150.0 147.0 147.0 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 22:26:54 INFO - PROCESS | 13381 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 95.0 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 22:26:54 INFO - PROCESS | 13381 | Values: 65.0 66.0 65.0 66.0 65.0 65.0 67.0 65.0 66.0 66.0 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:1.09 22:26:54 INFO - PROCESS | 13381 | Values: 64.0 63.0 65.0 65.0 65.0 67.0 65.0 65.0 64.0 64.0 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:3.07 (3.5%) stddev-sans-first:3.24 22:26:54 INFO - PROCESS | 13381 | Values: 88.0 87.0 85.0 86.0 86.0 87.0 85.0 84.0 95.0 88.0 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:147.00 stddev:6.27 (4.3%) stddev-sans-first:6.50 22:26:54 INFO - PROCESS | 13381 | Values: 141.0 157.0 148.0 137.0 139.0 147.0 147.0 151.0 140.0 141.0 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:174.00 stddev:3.86 (2.2%) stddev-sans-first:3.81 22:26:54 INFO - PROCESS | 13381 | Values: 179.0 180.0 182.0 172.0 173.0 171.0 173.0 174.0 172.0 174.0 22:26:54 INFO - PROCESS | 13381 | 22:26:54 INFO - PROCESS | 13381 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.50 stddev:1.25 (1.7%) stddev-sans-first:1.27 22:26:54 INFO - PROCESS | 13381 | Values: 73.0 74.0 71.0 72.0 71.0 72.0 73.0 73.0 70.0 71.0 22:26:54 INFO - PROCESS | 13381 | -------- Summary: end -------- 22:26:54 INFO - PROCESS | 13381 | 22:26:55 INFO - TEST-INFO | 13381: exit 0 22:26:55 INFO - TEST-OK | kraken | took 63571ms 22:26:55 INFO - SUITE-END | took 1179s 22:26:55 INFO - Completed test suite (00:19:39) 22:26:55 INFO - javascript benchmark 22:26:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2643.5373809583325, 2710.7831373490117, 2741.0, 2741.39689268361, 2750.0512323248486, 4656.161890859648, 4657.60410365119, 4696.389469368985, 4749.857504274873, 4763.118823017744, 4630.953690463094, 4712.0811441768865, 4791.880202994927, 4815.590674792638, 4890.070886531556, 4369.10433361161, 4420.734755914656, 4491.797869095899, 4512.616427603642, 4542.863714088583, 4434.268345722952, 4453.910921781562, 4482.260427029536, 4499.595036446719, 4545.477270113946, 4389.253826849427, 4408.9859332353735, 4432.357308190294, 4457.353683715875, 4480.753558554278, 4426.336049592554, 4428.114377124588, 4429.645628349725, 4430.401895744098, 4483.461984561841, 4238.766867822269, 4383.539728328544, 4401.977990110061, 4405.11897620474, 4462.687611867171, 4675.766211689402, 4697.365855609517, 4717.198076327033, 4724.692894961817, 4772.141014617368, 5122.487751224885, 5145.871353216162, 5150.819721309774, 5155.40712818027, 5185.662931909452, 5027.145385284511, 5124.641275110744, 5133.204353325241, 5189.143791274473, 5226.320578324831, 4745.525447455296, 4767.594754445841, 4778.139934811733, 4811.566958973709, 4828.46886842447, 5208.921866172011, 5211.1922651989, 5211.452797456288, 5211.5049070338255, 5229.660072095302, 4890.364252647133, 4934.3338649282605, 4951.554360107608, 5028.220625803006, 5075.390953085654, 4865.391826021747, 5074.594032477393, 5107.642465027412, 5172.870678232999, 5202.7918883245, 5114.974425127925, 5115.565176959925, 5119.846404607868, 5141.357330333708, 5161.071007218661, 4925.87685307863, 4960.181570040975, 5010.5240002199735, 5099.209622508517, 5117.385913690381, 4275.1663425631705, 4318.697691161588, 4335.696501244883, 4366.170427618742, 4401.339799030171, 3778.244351129785, 3791.696664266852, 3798.9240215196096, 3826.273008128502, 3830.2339532093692, 4418.072204836956, 4421.049474362963, 4423.07115505741, 4460.28635418338, 4468.396766436555, 5075.87310317245, 5085.898282034339, 5152.871178220575, 5212.139996900545, 5245.6852588844795, 4444.82220711168, 4447.2439685253585, 4466.129104824528, 4467.463904331501, 4506.909861802746, 4711.811527538928, 4713.128071306819, 4713.9764301178275, 4715.033418149271, 4761.095391875532, 4717.575418212377, 4842.854714358505, 4868.975655121843, 4894.437139728977, 4916.852494425173, 5002.924956125588, 5062.873428164178, 5066.265391518283, 5080.136376815876, 5120.436751957356, 4624.075184962953, 4802.471728109975, 4807.110684523234, 4814.422269327703, 4852.611791056777, 5012.824551140692, 5072.188449848007, 5092.821751238689, 5096.719680417613, 5129.512696293846, 5194.117000110066, 5215.6609820361555, 5216.139337009351, 5219.1388420910125, 5267.104592219409, 4831.0, 4922.852314430573, 5030.57240134578, 5046.268291097696, 5048.3941926969, 4879.170541007966, 4931.852044438672, 4946.332245146859, 4958.528939750718, 4996.3504744383, 4912.410510738734, 4943.3573635427165, 4947.3568436104515, 4949.752512374439, 5033.723145226902, 4910.410750709938, 5009.524095210949, 5053.8736531587, 5071.974640126923, 5099.923501147411, 4832.879178020437, 4852.17513022794, 4868.586170175433, 4873.512648735098, 4914.36113305268], "value": 4706.830970253081, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.3217219304486, 577.0593931891017, 598.6767145741298, 604.247711599059, 630.2877748144596, 32418.513722294156, 33287.0, 33597.16007099824, 33629.32741345172, 33720.66279337206, 36617.45073823895, 37412.0, 37423.625763742355, 37457.81271093641, 37492.0, 7638.885416718767, 7813.374930005614, 7819.335356494705, 7820.608969551528, 7823.10034346049, 7748.41886858485, 7787.0, 7847.0, 7873.409494287951, 7877.212278772135, 7791.961040194791, 7854.960725196366, 7871.409644276673, 7875.173106823787, 7885.172056934025, 7807.219278072204, 7855.8821617675785, 7864.724734634317, 7871.212878712112, 7873.5275883447175, 7738.380929525624, 7790.220977902221, 7802.648880800378, 7847.469743400039, 7877.960610196969, 28660.71339286601, 33666.1583460413, 34346.48480272798, 34352.0, 34379.31241375183, 3032.3632037271977, 3169.889053883126, 3217.5978002749657, 3245.1562593725566, 3378.983105084483, 26382.0, 27183.72816271832, 27459.450810983868, 27745.722542774718, 28155.0, 3393.389189945809, 3395.6095049069427, 3455.1362159460136, 3471.444568868994, 3555.591107022674, 221231.0, 225764.99999999837, 226765.0, 227328.0, 227523.0, 56393.71803140958, 56437.0, 56574.71712641411, 56579.0, 56899.0, 60670.69664651649, 61904.0, 62190.68904655538, 62289.377106228356, 62324.68837655873, 15386.230688465532, 15620.609484762745, 15668.764968525482, 15671.529854104396, 15737.134457604941, 11524.423778811026, 11589.188756787113, 11615.128865335133, 11713.531458741554, 11720.17958742897, 18720.438386848415, 18956.715649265272, 19020.334288299844, 19122.71315930262, 19234.80765192358, 7496.325330720152, 7609.505382150142, 7611.505252158703, 7652.693892244248, 7746.419018573517, 890.1988210610373, 892.2549671024638, 917.2203626917201, 981.190517822799, 1006.8590397344377, 27650.032248871194, 28453.430931381256, 28895.42209155805, 28910.710892890802, 29029.56455653167, 1026.9383836969805, 1061.2783307351076, 1061.867266591676, 1073.683263437288, 1082.2370228988543, 14823.0, 15174.772378414333, 15359.0, 15483.0, 15550.611234719223, 303245.0, 307804.0, 307811.0, 309954.0, 310006.0, 48229.0, 48957.265641015416, 49356.0, 49364.55718985308, 49558.50441495611, 1246.9314187719763, 1263.886250237483, 1279.3795009420423, 1295.9935200323937, 1302.856685764565, 26651.333716656463, 27959.720402796524, 28010.579841302806, 28045.579316309864, 28524.714752852207, 42726.35910461408, 44238.557614423444, 44549.33176002298, 44556.55443445524, 44576.55423445854, 309126.0, 310806.0, 312351.0, 312670.0, 313083.0, 25990.35024124412, 26633.0, 26685.46629067369, 38840.41739373855, 40198.79900600478, 36650.266994659425, 36849.07877303089, 37289.25421491501, 37458.25083498369, 37990.24019519649, 35340.46989295214, 35575.11062223465, 35732.285354292246, 35893.64106358903, 36015.45976810298, 34635.82682086573, 34769.0, 35158.0, 35410.822945885106, 35517.112072198404, 30616.0, 34967.82516087403, 35313.64686353206, 36292.637073628925, 37320.0, 28256.0, 28660.14019579416, 29829.0, 31141.8442907784, 31496.842515787273, 24288.1499147529, 24619.384515387257, 24834.82432905236, 25001.624975625018, 25109.372265693502], "value": 17496.50778269662, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.5698076270002, 366.40093447213803, 368.1403921842498, 372.24434398171724, 373.82617083056374, 15673.216339183038, 16274.186290685462, 17762.911185444056, 17804.198811053502, 17828.286868525276, 16471.505854824343, 16720.916395418008, 17347.39284125056, 17401.0, 17483.562910927234, 5027.723475208872, 5143.382794064718, 5194.0, 5195.376554813428, 5208.062548741225, 3717.5353080864893, 5080.974595127038, 5549.472800084006, 5894.469497745202, 5895.587308888379, 5820.563457740686, 5830.737616807254, 5835.679037652927, 5851.8537036574, 5860.062390017598, 5647.463490968372, 6069.3323734389405, 6075.058365953262, 6082.8783424331705, 6103.23709536308, 5067.974660126676, 5312.415634280264, 5350.839474815762, 5353.866153346158, 5369.275147855029, 20305.898470507702, 20405.489862753402, 20409.183632654676, 20492.795072049237, 20533.794662053337, 1882.190658017052, 1997.9200831966705, 2193.287181665949, 2251.1558165687866, 2290.946164764194, 13106.148100373444, 13264.867351326557, 13420.530281440102, 13446.126001809851, 13510.121842080232, 1651.223924755363, 1716.888402253862, 1749.7462867884085, 1767.2130011434867, 1781.616952355237, 65770.0, 65969.3403065968, 66440.3355966439, 66465.0, 66518.66740666314, 9140.862887056566, 9341.766455838522, 9504.809903802023, 9991.600335986624, 10099.798004039878, 13676.452941882413, 13759.243241621607, 13774.586762397144, 13820.170789752647, 13836.861631383557, 7224.313690199423, 7702.537847729154, 7848.450608457353, 7880.724174653859, 7884.250996155356, 7470.775876723707, 7572.545647261182, 7666.156722760492, 7688.923110768821, 7773.18381569927, 5880.117982302689, 6068.939310606926, 6088.117223002729, 6112.755489780359, 6218.129461875341, 1547.4351861570672, 1621.910794906268, 1715.3567412220418, 1848.5655870870335, 1874.5219968908114, 852.032942610142, 889.3596610440602, 922.2022950148073, 945.9195968342768, 995.8878504672897, 15365.769513457308, 15793.526194214191, 16761.91619041897, 17471.213795379237, 17480.650386992187, 895.7671005538607, 902.9975332021056, 907.8275127725711, 957.1242313283407, 963.7879666473365, 9856.408615483095, 9875.209983201326, 9908.0, 9931.0, 10075.34510256831, 357893.0, 368128.0, 369407.0, 369454.0, 370683.0, 67220.32779672238, 68682.0, 70424.2957570428, 71569.28430715627, 73962.99999999892, 946.9857952130724, 949.4635530925005, 955.0640372435053, 977.5845265762165, 1016.903394177552, 14752.704945901236, 14763.409463621334, 14783.441988867911, 15828.60428489297, 16250.0, 34723.479147813305, 35410.46884296789, 35427.29145417129, 36250.27499450049, 36480.0, 49904.0, 50964.74517627388, 52126.0, 52127.47872521226, 52198.478015220884, 7454.776356709307, 7565.243475652611, 7573.6213189341415, 7640.80897977555, 7649.579273140031, 8767.386282960131, 9471.857922131036, 11383.146264030065, 12150.817737733763, 12210.694732631755, 9985.1512621428, 10134.239932005277, 10156.035176658206, 10231.43727095017, 10336.0, 9910.603575856885, 9998.200143988319, 10114.595416183565, 10384.480775961021, 10451.477426128511, 9888.604455821687, 10239.897601023895, 10243.129334006693, 10338.0, 10482.37105773656, 7322.926770732438, 7418.554886706815, 7464.738734144279, 7508.324250817453, 7705.537667739729, 10078.697639070839, 10399.27205095636, 10431.58273669075, 10576.36541807494, 10610.734731631772], "value": 8408.251173113164, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.1471903655402, 1509.9849001509983, 1665.9521649402316, 1796.7215081662348, 1822.0434272007187, 6789.7284108635595, 7582.658780354884, 7660.463767536275, 7836.882446763296, 7857.646405911733, 7701.807454813633, 7745.07059152901, 7772.106207786106, 7823.843523129548, 7845.09781375142, 2185.15871389515, 2193.9890300548477, 2202.6916231727573, 2202.944926376845, 2209.414505156127, 2186.737591489016, 2190.310052333518, 2230.230570453199, 2231.5983123037845, 2237.5748607764554, 2204.2505548113636, 2222.4554984028855, 2225.5978733397938, 2235.16181431963, 2235.508188198602, 2148.1729534129317, 2151.8386121040908, 2178.2485042660337, 2181.018541656261, 2183.148572056899, 2150.5913876363597, 2170.555036217572, 2171.9674204886937, 2183.705199798023, 2184.049938276855, 7840.255175758294, 7860.921390786076, 7865.488743231672, 7880.527168369917, 7884.369250459949, 4448.8442904498515, 4595.7702114894455, 4598.287265473857, 4618.468876079261, 4621.075784843045, 2767.169849045278, 2822.350859302372, 2856.9857150714115, 2890.783191260664, 2925.546540286259, 871.8997315308694, 904.5070436612062, 911.6325511732401, 917.0874979395478, 924.6809850601531, 10717.303375280582, 10753.677389678322, 10781.137508999262, 10782.622608208754, 10786.191035672357, 4003.2994226010333, 4246.426732391088, 4259.97870010648, 4276.401303817468, 4280.143971205771, 9252.53737313145, 9284.303677224236, 9285.071492850797, 9288.0, 9308.348415610977, 4691.483936766953, 4717.198076327033, 4720.150372932905, 4724.952750472451, 4727.267273572533, 3777.697784177259, 4311.374850646639, 4321.891952701145, 4337.240982827992, 4349.217140914666, 3729.4592284119194, 3733.9626603733614, 3822.541295044557, 3863.671587915059, 3878.8836334909997, 1257.2330878164312, 1260.4265059398135, 1265.816456613786, 1271.2499625221164, 1294.087668193921, 1199.7660456210956, 1204.265398107154, 1223.0643557678384, 1248.806435002558, 1265.3420221484776, 7384.852302954018, 7436.442266830009, 7448.031755871702, 7460.85078298431, 7568.3945284378215, 429.95270520242747, 435.0559286348631, 435.44915681662724, 440.1768692544961, 442.1135623075777, 5676.687782171937, 5734.111212762028, 5737.913931291034, 5747.655140691572, 5767.307923049177, 9016.0, 9180.31147663928, 9353.906460935303, 9358.859617105749, 9394.953025234967, 9320.673776417792, 9326.440413575207, 9365.203957663674, 9381.155695987394, 9431.90568094324, 6733.93266067333, 7089.361957423856, 7126.857462850714, 7146.857062858714, 7173.641317934187, 7359.889601656087, 7423.92576074254, 7489.251074892467, 7506.512076714996, 7663.233676632515, 8995.100489951214, 9015.2787776979, 9027.909720902708, 9187.402818816756, 9205.171534561921, 8925.598348074482, 9084.591193396182, 9203.815923681355, 9314.44113353201, 9356.485393303434, 5956.821295361146, 6490.091387205889, 6699.933000670126, 6985.5808651481075, 7176.282371762782, 7291.30732580404, 7341.3392794648735, 7356.448266379936, 7369.520981136209, 7413.8146546336775, 6414.326495718069, 6688.297728738413, 6708.429783468265, 6714.664266786739, 6753.729850805913, 6601.141851559267, 6612.5040621952585, 6627.536072474881, 6663.400293973566, 6664.5334826561675, 6846.452283817183, 6851.931480685129, 6868.450523958171, 6869.381755642016, 6900.068490753884, 6384.0, 6564.8358791030605, 6572.047053177167, 6629.171353580802, 6632.900506492503, 6420.967895160495, 6435.871282574416, 6438.259600146043, 6457.3865482779065, 6468.5472016958365], "value": 4357.696264835735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.8350907001149, 302.5975452647978, 304.61466245199824, 305.8883507519756, 315.3676877859891, 5177.792888284469, 5216.634835561512, 5286.541758082491, 5338.946610533893, 5354.839354819352, 5210.5310522053005, 5240.895182096356, 5267.0, 5274.604404669655, 5311.0, 3887.688984881203, 4000.379941109118, 4084.550699423061, 4109.075458021951, 4122.051928056549, 4097.692673049518, 4142.150859073882, 4145.8963525911795, 4149.170165966803, 4157.5634558371385, 4085.9785053736564, 4086.2031903778625, 4116.855910043149, 4130.97934510327, 4137.81379837908, 4049.736767110158, 4099.323611604082, 4128.236276288866, 4134.090500089976, 4134.4625198724125, 3632.346177688015, 3649.6897763690117, 3651.8174091295327, 3656.945145822815, 3671.4859919611276, 5041.143005689041, 5047.116754567936, 5048.419431765357, 5070.492950704936, 5070.670406423607, 4795.0, 4798.0643774464, 4802.303665968415, 4804.5916097131785, 4806.855794326176, 5266.789328426858, 5584.190292407578, 5598.0, 5601.915971260393, 5629.746661400247, 3867.7485963412287, 3869.941950870739, 3873.8837834865, 3875.7210120660116, 3876.0, 5704.71476426177, 5735.397783232784, 5848.67832269225, 5851.297844258674, 5860.619059761102, 3913.412988051815, 3923.6664883484655, 3925.1953349563273, 3947.802609869495, 3955.723099383073, 3972.205558888234, 3985.5217373915316, 3992.780397078189, 3999.4000899864673, 4011.5558398976345, 4597.402337696078, 4619.630429565626, 4635.768211589407, 4642.630424024921, 4678.976605116953, 5444.156155795858, 5544.944550554524, 5592.1134811306565, 5601.915971260434, 5605.579581531401, 1386.9306534673226, 1410.781328894023, 1412.6185929799103, 1416.652920034598, 1417.2134465371612, 903.6475774447971, 928.252756530999, 947.7062110745691, 949.2832911152036, 953.0850383631653, 4724.456687480915, 4796.664233503621, 4946.307516947631, 4946.950530494721, 4968.105740966661, 5819.767209311664, 5827.621204621686, 5832.24180856486, 5836.299644042742, 5850.502707269845, 4663.0, 4945.579625731782, 4952.182889823211, 4956.182229932021, 4959.70241785494, 3059.3881223754893, 3080.476319025771, 3088.1507585414192, 3101.8449077546034, 3108.98445507771, 5441.782328706808, 5445.809396671098, 5449.591280653887, 5492.835214943558, 5511.311086114236, 5823.583212966656, 5891.05743081105, 5957.791477298274, 5973.954557952341, 5979.133025711248, 5484.91772623411, 5494.917576236359, 5506.587005974568, 5526.2145430380315, 5539.7784088636, 5630.324361076697, 5765.538756899354, 5819.6508209507565, 5845.649261044351, 5853.824385268449, 5693.4021927696995, 5693.544516438592, 5696.686682232517, 5699.857503562278, 5720.8283751487525, 5493.121100623881, 5497.862553436036, 5504.587155963239, 5509.0, 5517.172424136412, 3782.6028267032666, 3971.8609848656315, 3990.1620659660634, 4014.0566966762203, 4032.395140728914, 5720.427957204246, 5746.13807928814, 5767.423257674199, 5804.738786754522, 5804.854878628068, 5546.805861794818, 5558.249636299048, 5568.916466252928, 5586.0, 5607.719614019201, 5323.574114070788, 5529.668219906818, 5535.280413546374, 5540.667559946416, 5545.33639908034, 5461.098918678533, 5487.725613719378, 5499.835004949858, 5510.669359838423, 5523.392426832965, 5357.491038351351, 5487.176923461513, 5598.776048957996, 5639.0, 5646.124850648156, 5443.713640271017, 5480.698561579152, 5490.094134467928, 5504.422035686195, 5505.889882202254], "value": 4180.032678388939, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.956079057696, 602.3645054467538, 643.9999999999997, 661.6294874870073, 661.8160071763182, 11371.886281137186, 11480.368579728112, 11501.079913606913, 12000.699982500442, 12216.328101954412, 12223.449944752485, 12262.141650084497, 12263.448144833481, 12295.938520307409, 12305.938470307658, 647.6081970407906, 787.5943888897223, 793.4445887878479, 814.5235037503068, 817.452306954342, 816.3387655998661, 820.1839170025833, 822.7901885019342, 823.555280148719, 824.5217773691274, 844.7972486603202, 852.3735054734765, 854.5556310718423, 854.7521218846528, 859.4800145911696, 845.5476320168711, 847.6990668312721, 849.6728759427665, 850.0437008365589, 851.825375797963, 624.8312955502034, 625.7903602293237, 625.7934881489098, 626.2703949898363, 626.5582764151262, 12245.816312755316, 12379.504819807196, 12429.31638759868, 12452.501899923993, 12479.75040499185, 12942.482300707961, 13005.479780808757, 13030.934845325713, 13117.0, 13247.88018067997, 9902.653407130716, 10069.949650251701, 10204.183665306758, 10265.281430299881, 10399.376037437778, 3293.3907227162813, 3297.9835100824343, 3349.949750753716, 3360.647132051148, 3394.049666093473, 42382.78808605968, 42651.1469770606, 43474.782626086984, 44073.0, 44403.333949990774, 9570.47362395075, 9647.807043859084, 9870.654527091518, 9884.11043006133, 10010.749731256632, 16127.0, 16129.0, 16202.946808457413, 16242.269097890623, 16959.745603815954, 6974.407175390149, 7054.6825392857445, 7082.645867706594, 7154.856902861914, 7203.351698347174, 3631.3463576556474, 3706.258748250307, 3755.4179102239195, 3759.680427163667, 3815.4849095372324, 2937.3390987027747, 3119.438501069784, 3123.7500999919953, 3130.0609817055247, 3130.7182353588287, 539.2908325551887, 552.7512619321241, 554.5812911251979, 554.9167624856303, 558.5531574740191, 439.20942303853576, 533.8104972734701, 537.4142185018349, 565.0845630079216, 580.773498335641, 7827.9608601956625, 7843.803904902423, 7951.721689740947, 8295.502269863828, 8392.916070839214, 613.687019619997, 617.4196255519797, 639.6226226526372, 639.9968297370634, 652.787843950718, 3880.9611903881164, 3902.5316961964745, 3934.8622798201927, 3977.0455090778005, 4027.395890616431, 46431.0, 46504.0, 47349.763251183525, 47406.5259347409, 47652.76173619179, 43218.783906080265, 43374.13251734948, 44245.11509769851, 44288.11423771507, 45234.77382613131, 40910.0, 40943.795281024, 41048.589514104475, 41303.586964130576, 42054.579454205064, 7377.372923301579, 7450.925490745023, 7535.6985720570565, 7923.3661307096445, 8288.254057134645, 26250.343741406617, 26538.60192097159, 27070.05254816072, 27142.864285679236, 27399.589006165323, 34758.30483390368, 35229.47155792614, 36781.0, 37040.444393333586, 37625.4356184652, 10978.176636752116, 11019.779604407706, 11039.116870650168, 11255.380954047607, 11304.660860174208, 11845.289282643069, 12219.75560488803, 12324.137310388187, 12335.444904979477, 12525.248485090924, 11386.43067846621, 11487.597934072268, 11986.76026479483, 12047.33739644328, 12052.638420847388, 11473.0, 11487.425628718363, 11502.597409090642, 11875.574931008334, 11891.0, 11179.496922638664, 11538.134639901873, 11545.88454115448, 11577.131715121232, 11581.681066773279, 9475.47884866339, 9579.233661307218, 9743.123118919331, 9751.707448776264, 10178.0, 9485.383450075724, 9685.70942871715, 9766.037585444235, 9820.312578119463, 9825.557849896915], "value": 5919.758573001979, "unit": "score"}], "name": "dromaeo_css", "value": 6489.258336598388, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 117.0, 114.0, 115.0, 127.0, 113.0, 114.0, 113.0, 113.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 140.0, 159.0, 183.0, 134.0, 163.0, 161.0, 134.0, 188.0, 135.0], "value": 155.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 161.0, 162.0, 164.0, 173.0, 164.0, 163.0, 166.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 75.0, 74.0, 73.0, 77.0, 152.0, 73.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 138.0, 95.0, 96.0, 94.0, 141.0, 93.0, 94.0, 143.0], "value": 108.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 117.0, 117.0, 118.0, 117.0, 117.0, 119.0, 118.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 150.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 67.0, 65.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 65.0, 65.0, 67.0, 65.0, 65.0, 64.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 85.0, 86.0, 86.0, 87.0, 85.0, 84.0, 95.0, 88.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 157.0, 148.0, 137.0, 139.0, 147.0, 147.0, 151.0, 140.0, 141.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 180.0, 182.0, 172.0, 173.0, 171.0, 173.0, 174.0, 172.0, 174.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 71.0, 72.0, 71.0, 72.0, 73.0, 73.0, 70.0, 71.0], "value": 72.0, "unit": "score"}], "name": "kraken", "value": 1596.0, "alertThreshold": 2.0}]} 22:26:55 INFO - Return code: 0 22:26:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:26:55 ERROR - # TBPL SUCCESS # 22:26:55 INFO - Running post-action listener: _resource_record_post_action 22:26:55 INFO - Running post-run listener: _resource_record_post_run 22:26:57 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518799360; Read time: 4; Write time: 461908 22:26:57 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233369600; Read time: 0; Write time: 270620 22:26:57 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285429760; Read time: 4; Write time: 191288 22:26:57 INFO - Running post-run listener: _upload_blobber_files 22:26:57 INFO - Blob upload gear active. 22:26:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:26:57 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 22:26:57 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'] 22:26:57 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 22:26:57 INFO - (blobuploader) - INFO - Open directory for files ... 22:26:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:26:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:26:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:26:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:26:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:26:58 INFO - (blobuploader) - INFO - Done attempting. 22:26:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:26:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:26:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:26:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:26:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:26:59 INFO - (blobuploader) - INFO - Done attempting. 22:26:59 INFO - (blobuploader) - INFO - Iteration through files over. 22:26:59 INFO - Return code: 0 22:26:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:26:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:26:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/320ead6deddec71ac27edb59fe11c31d41e1ebf5bd2ae307c3a1f649a3a63f269940362c06fe5b752f6ffadde8cbf9589242d4c8b10a927bd1c40bce54991a1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b5e22b803f53a0a5ec93926a46aecd221fd5fb466e69b9c461012568960e80825cb7c58511a275b5007a241d535399c9b0c7a059aa9897682823807a1bf46b6d"} 22:26:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:26:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:26:59 INFO - Contents: 22:26:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/320ead6deddec71ac27edb59fe11c31d41e1ebf5bd2ae307c3a1f649a3a63f269940362c06fe5b752f6ffadde8cbf9589242d4c8b10a927bd1c40bce54991a1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b5e22b803f53a0a5ec93926a46aecd221fd5fb466e69b9c461012568960e80825cb7c58511a275b5007a241d535399c9b0c7a059aa9897682823807a1bf46b6d"} 22:26:59 INFO - Running post-run listener: copy_logs_to_upload_dir 22:26:59 INFO - Copying logs to upload dir... 22:26:59 INFO - mkdir: /builds/slave/test/build/upload/logs 22:26:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.816371 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-08 22:26:59.052906) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 22:26:59.056077) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524 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/320ead6deddec71ac27edb59fe11c31d41e1ebf5bd2ae307c3a1f649a3a63f269940362c06fe5b752f6ffadde8cbf9589242d4c8b10a927bd1c40bce54991a1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b5e22b803f53a0a5ec93926a46aecd221fd5fb466e69b9c461012568960e80825cb7c58511a275b5007a241d535399c9b0c7a059aa9897682823807a1bf46b6d"} build_url:https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011425 build_url: 'https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/320ead6deddec71ac27edb59fe11c31d41e1ebf5bd2ae307c3a1f649a3a63f269940362c06fe5b752f6ffadde8cbf9589242d4c8b10a927bd1c40bce54991a1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b5e22b803f53a0a5ec93926a46aecd221fd5fb466e69b9c461012568960e80825cb7c58511a275b5007a241d535399c9b0c7a059aa9897682823807a1bf46b6d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 22:26:59.084380) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:26:59.084726) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1460178336.674257-196962524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:26:59.169223) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 22:26:59.169900) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 22:26:59.170475) ========= ========= Total master_lag: 0.31 =========