builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1456873276.39 results: success (0) buildid: 20160301143133 builduid: b56dd3e3f4f74853a57d6b36b6905558 revision: baabb61180e8fe2d55d76ef20fa8ad8c7f4667aa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:16.391106) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:16.391619) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:16.392058) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006372 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:16.419693) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:16.420027) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:16.438750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:16.439173) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:16.505893) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:16.506187) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:16.506565) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:16.506876) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 15:01:16-- 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% 231M=0s 2016-03-01 15:01:16 (231 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091521 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:16.613920) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:16.614250) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022367 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:16.668654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:16.669000) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev baabb61180e8fe2d55d76ef20fa8ad8c7f4667aa --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 baabb61180e8fe2d55d76ef20fa8ad8c7f4667aa --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=2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 15:01:16,846 truncating revision to first 12 chars 2016-03-01 15:01:16,846 Setting DEBUG logging. 2016-03-01 15:01:16,846 attempt 1/10 2016-03-01 15:01:16,846 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/baabb61180e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 15:01:17,101 unpacking tar archive at: fx-team-baabb61180e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542669 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:17.228253) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:17.228901) ========= echo baabb61180e8fe2d55d76ef20fa8ad8c7f4667aa in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'baabb61180e8fe2d55d76ef20fa8ad8c7f4667aa'] 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=2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False baabb61180e8fe2d55d76ef20fa8ad8c7f4667aa program finished with exit code 0 elapsedTime=0.004654 script_repo_revision: 'baabb61180e8fe2d55d76ef20fa8ad8c7f4667aa' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:17.283249) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:17.283599) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 15:01:17.294037) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-03-01 15:01:17.294369) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:01:17 INFO - MultiFileLogger online at 20160301 15:01:17 in /builds/slave/test 15:01:17 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 15:01:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:01:17 INFO - {'append_to_log': False, 15:01:17 INFO - 'base_work_dir': '/builds/slave/test', 15:01:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:01:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:01:17 INFO - 'branch': 'Fx-Team-Non-PGO', 15:01:17 INFO - 'buildbot_json_path': 'buildprops.json', 15:01:17 INFO - 'config_files': ('talos/linux_config.py',), 15:01:17 INFO - 'default_actions': ('clobber', 15:01:17 INFO - 'read-buildbot-config', 15:01:17 INFO - 'download-and-extract', 15:01:17 INFO - 'populate-webroot', 15:01:17 INFO - 'create-virtualenv', 15:01:17 INFO - 'install', 15:01:17 INFO - 'run-tests'), 15:01:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:01:17 INFO - 'download_minidump_stackwalk': True, 15:01:17 INFO - 'download_symbols': 'ondemand', 15:01:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:01:17 INFO - 'tooltool.py': '/tools/tooltool.py', 15:01:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:01:17 INFO - '/tools/misc-python/virtualenv.py')}, 15:01:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:01:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:01:17 INFO - 'installer_path': 'installer.exe', 15:01:17 INFO - 'log_level': 'info', 15:01:17 INFO - 'log_name': 'talos', 15:01:17 INFO - 'log_to_console': True, 15:01:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:01:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:01:17 INFO - 'opt_config_files': (), 15:01:17 INFO - 'pip_index': False, 15:01:17 INFO - 'sps_profile': False, 15:01:17 INFO - 'sps_profile_interval': 0, 15:01:17 INFO - 'suite': 'dromaeojs-e10s', 15:01:17 INFO - 'system_bits': '32', 15:01:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:01:17 INFO - 'title': 'talos-linux64-ix-012', 15:01:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:01:17 INFO - 'use_talos_json': True, 15:01:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:01:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:01:17 INFO - 'work_dir': 'build'} 15:01:17 INFO - ##### 15:01:17 INFO - ##### Running clobber step. 15:01:17 INFO - ##### 15:01:17 INFO - Running pre-action listener: _resource_record_pre_action 15:01:17 INFO - Running main action method: clobber 15:01:17 INFO - rmtree: /builds/slave/test/build 15:01:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:01:18 INFO - Running post-action listener: _resource_record_post_action 15:01:18 INFO - ##### 15:01:18 INFO - ##### Running read-buildbot-config step. 15:01:18 INFO - ##### 15:01:18 INFO - Running pre-action listener: _resource_record_pre_action 15:01:18 INFO - Running main action method: read_buildbot_config 15:01:18 INFO - Using buildbot properties: 15:01:18 INFO - { 15:01:18 INFO - "project": "", 15:01:18 INFO - "product": "firefox", 15:01:18 INFO - "script_repo_revision": "production", 15:01:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:01:18 INFO - "repository": "", 15:01:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:01:18 INFO - "buildid": "20160301143133", 15:01:18 INFO - "pgo_build": "False", 15:01:18 INFO - "basedir": "/builds/slave/test", 15:01:18 INFO - "buildnumber": 930, 15:01:18 INFO - "slavename": "talos-linux64-ix-012", 15:01:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:01:18 INFO - "platform": "ubuntu64_hw", 15:01:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:01:18 INFO - "branch": "fx-team", 15:01:18 INFO - "repo_path": "integration/fx-team", 15:01:18 INFO - "revision": "baabb61180e8fe2d55d76ef20fa8ad8c7f4667aa", 15:01:18 INFO - "stage_platform": "linux64", 15:01:18 INFO - "builduid": "b56dd3e3f4f74853a57d6b36b6905558", 15:01:18 INFO - "slavebuilddir": "test" 15:01:18 INFO - } 15:01:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 15:01:18 INFO - Running post-action listener: _resource_record_post_action 15:01:18 INFO - ##### 15:01:18 INFO - ##### Running download-and-extract step. 15:01:18 INFO - ##### 15:01:18 INFO - Running pre-action listener: _resource_record_pre_action 15:01:18 INFO - Running main action method: download_and_extract 15:01:18 INFO - mkdir: /builds/slave/test/build/tests 15:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:18 INFO - https://queue.taskcluster.net/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:01:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 15:01:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 15:01:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 15:01:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:01:19 INFO - Downloaded 1448 bytes. 15:01:19 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 15:01:19 INFO - Using the following test package requirements: 15:01:19 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:01:19 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:01:19 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:01:19 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:19 INFO - u'jsshell-linux-x86_64.zip'], 15:01:19 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:01:19 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:01:19 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:01:19 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:01:19 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:01:19 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:01:19 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:01:19 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:01:19 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')]} 15:01:19 INFO - https://queue.taskcluster.net/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:01:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:01:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:01:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:01:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:01:21 INFO - Downloaded 22077569 bytes. 15:01:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:01:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:01:22 INFO - Return code: 0 15:01:22 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:01:22 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')]} 15:01:22 INFO - https://queue.taskcluster.net/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:01:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:01:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:01:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:01:24 INFO - Downloaded 22077569 bytes. 15:01:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:01:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:01:25 INFO - Return code: 0 15:01:25 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')]} 15:01:25 INFO - https://queue.taskcluster.net/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:01:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 15:01:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 15:01:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 15:01:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:01:42 INFO - Downloaded 10713413 bytes. 15:01:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:01:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:01:42 INFO - Return code: 0 15:01: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')]} 15:01:42 INFO - https://queue.taskcluster.net/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:01:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:01:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:01:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:01:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:01:46 INFO - Downloaded 54381798 bytes. 15:01:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:01:46 INFO - mkdir: /builds/slave/test/properties 15:01:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:01:46 INFO - Writing to file /builds/slave/test/properties/build_url 15:01:46 INFO - Contents: 15:01:46 INFO - build_url:https://queue.taskcluster.net/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:01:47 INFO - Running post-action listener: _resource_record_post_action 15:01:47 INFO - Running post-action listener: set_extra_try_arguments 15:01:47 INFO - ##### 15:01:47 INFO - ##### Running populate-webroot step. 15:01:47 INFO - ##### 15:01:47 INFO - Running pre-action listener: _resource_record_pre_action 15:01:47 INFO - Running main action method: populate_webroot 15:01:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:01:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:01:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:01:47 INFO - '--tppagecycles', 15:01:47 INFO - '7'], 15:01:47 INFO - 'tests': ['tsvgm']}}, 15:01:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:01:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:01:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:01:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:01:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:01:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:01:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:47 INFO - 'talos_options': ['--e10s'], 15:01:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:47 INFO - 'tests': ['damp', 'tps']}, 15:01:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:47 INFO - 'talos_options': ['--e10s'], 15:01:47 INFO - 'tests': ['damp', 'tps']}, 15:01:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:01:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:01:47 INFO - 'other': {'tests': ['a11yr', 15:01:47 INFO - 'ts_paint', 15:01:47 INFO - 'tpaint', 15:01:47 INFO - 'sessionrestore', 15:01:47 INFO - 'sessionrestore_no_auto_restore']}, 15:01:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:01:47 INFO - 'tests': ['a11yr', 15:01:47 INFO - 'ts_paint', 15:01:47 INFO - 'tpaint', 15:01:47 INFO - 'sessionrestore', 15:01:47 INFO - 'sessionrestore_no_auto_restore']}, 15:01:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:01:47 INFO - 'tests': ['a11yr', 15:01:47 INFO - 'ts_paint', 15:01:47 INFO - 'tpaint', 15:01:47 INFO - 'sessionrestore', 15:01:47 INFO - 'sessionrestore_no_auto_restore']}, 15:01:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:01:47 INFO - 'tests': ['a11yr', 15:01:47 INFO - 'ts_paint', 15:01:47 INFO - 'tpaint', 15:01:47 INFO - 'sessionrestore', 15:01:47 INFO - 'sessionrestore_no_auto_restore']}, 15:01:47 INFO - 'other_l64': {'tests': ['a11yr', 15:01:47 INFO - 'ts_paint', 15:01:47 INFO - 'tpaint', 15:01:47 INFO - 'sessionrestore', 15:01:47 INFO - 'sessionrestore_no_auto_restore']}, 15:01:47 INFO - 'other_nol64': {'tests': ['a11yr', 15:01:47 INFO - 'ts_paint', 15:01:47 INFO - 'tpaint', 15:01:47 INFO - 'sessionrestore', 15:01:47 INFO - 'sessionrestore_no_auto_restore']}, 15:01:47 INFO - 'svgr': {'tests': ['tsvgx', 15:01:47 INFO - 'tsvgr_opacity', 15:01:47 INFO - 'tart', 15:01:47 INFO - 'tscrollx', 15:01:47 INFO - 'cart']}, 15:01:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:01:47 INFO - 'tests': ['tsvgx', 15:01:47 INFO - 'tsvgr_opacity', 15:01:47 INFO - 'tart', 15:01:47 INFO - 'tscrollx', 15:01:47 INFO - 'cart']}, 15:01:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:47 INFO - 'tests': ['tp5o']}, 15:01:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:47 INFO - 'talos_options': ['--e10s'], 15:01:47 INFO - 'tests': ['tp5o']}, 15:01:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:47 INFO - 'talos_options': ['--xperf_path', 15:01:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:47 INFO - 'tests': ['tp5n']}, 15:01:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:47 INFO - 'talos_options': ['--e10s', 15:01:47 INFO - '--xperf_path', 15:01:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:47 INFO - 'tests': ['tp5n']}}, 15:01:47 INFO - 'talos.zip': {'path': '', 15:01:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:01:47 INFO - Running post-action listener: _resource_record_post_action 15:01:47 INFO - ##### 15:01:47 INFO - ##### Running create-virtualenv step. 15:01:47 INFO - ##### 15:01:47 INFO - Running pre-action listener: _resource_record_pre_action 15:01:47 INFO - Running main action method: create_virtualenv 15:01:47 INFO - Creating virtualenv /builds/slave/test/build/venv 15:01:47 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 15:01:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:01:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:01:47 INFO - Using real prefix '/usr' 15:01:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:01:47 INFO - Installing distribute.............................................................................................................................................................................................done. 15:01:49 INFO - Installing pip.................done. 15:01:49 INFO - Return code: 0 15:01:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:01: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')]} 15:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:49 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 0x7f92bfe11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea100>, '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 0x14eb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', '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 15:01:49 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 15:01:49 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 15:01:49 INFO - Using env: {'DISPLAY': ':0', 15:01:49 INFO - 'HOME': '/home/cltbld', 15:01:49 INFO - 'LANG': 'en_US.UTF-8', 15:01:49 INFO - 'LANGUAGE': 'en_US:en', 15:01:49 INFO - 'LOGNAME': 'cltbld', 15:01:49 INFO - 'MAIL': '/var/mail/cltbld', 15:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:49 INFO - 'MOZ_NO_REMOTE': '1', 15:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:49 INFO - 'NO_EM_RESTART': '1', 15:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:49 INFO - 'PWD': '/builds/slave/test', 15:01:49 INFO - 'SHELL': '/bin/bash', 15:01:49 INFO - 'SHLVL': '1', 15:01:49 INFO - 'TERM': 'linux', 15:01:49 INFO - 'TMOUT': '86400', 15:01:49 INFO - 'USER': 'cltbld', 15:01:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', 15:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:49 INFO - '_': '/tools/buildbot/bin/python'} 15:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:49 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 15:01:49 INFO - Cleaning up... 15:01:49 INFO - Return code: 0 15:01:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:01: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')]} 15:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:49 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 0x7f92bfe11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea100>, '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 0x14eb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', '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 15:01:49 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 15:01:49 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 15:01:49 INFO - Using env: {'DISPLAY': ':0', 15:01:49 INFO - 'HOME': '/home/cltbld', 15:01:49 INFO - 'LANG': 'en_US.UTF-8', 15:01:49 INFO - 'LANGUAGE': 'en_US:en', 15:01:49 INFO - 'LOGNAME': 'cltbld', 15:01:49 INFO - 'MAIL': '/var/mail/cltbld', 15:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:49 INFO - 'MOZ_NO_REMOTE': '1', 15:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:49 INFO - 'NO_EM_RESTART': '1', 15:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:49 INFO - 'PWD': '/builds/slave/test', 15:01:49 INFO - 'SHELL': '/bin/bash', 15:01:49 INFO - 'SHLVL': '1', 15:01:49 INFO - 'TERM': 'linux', 15:01:49 INFO - 'TMOUT': '86400', 15:01:49 INFO - 'USER': 'cltbld', 15:01:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', 15:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:49 INFO - '_': '/tools/buildbot/bin/python'} 15:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:50 INFO - Downloading/unpacking psutil>=0.7.1 15:01:50 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 15:01:50 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 15:01:50 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 15:01:50 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 15:01:50 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 15:01:50 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 15:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:01:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:52 INFO - Installing collected packages: psutil 15:01:52 INFO - Running setup.py install for psutil 15:01:52 INFO - building 'psutil._psutil_linux' extension 15:01:52 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 15:01:52 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 15:01:52 INFO - building 'psutil._psutil_posix' extension 15:01:52 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 15:01:52 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 15:01:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:52 INFO - Successfully installed psutil 15:01:52 INFO - Cleaning up... 15:01:52 INFO - Return code: 0 15:01:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f92bfe11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea100>, '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 0x14eb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', '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 15:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:01:52 INFO - Using env: {'DISPLAY': ':0', 15:01:52 INFO - 'HOME': '/home/cltbld', 15:01:52 INFO - 'LANG': 'en_US.UTF-8', 15:01:52 INFO - 'LANGUAGE': 'en_US:en', 15:01:52 INFO - 'LOGNAME': 'cltbld', 15:01:52 INFO - 'MAIL': '/var/mail/cltbld', 15:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:52 INFO - 'MOZ_NO_REMOTE': '1', 15:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:52 INFO - 'NO_EM_RESTART': '1', 15:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:52 INFO - 'PWD': '/builds/slave/test', 15:01:52 INFO - 'SHELL': '/bin/bash', 15:01:52 INFO - 'SHLVL': '1', 15:01:52 INFO - 'TERM': 'linux', 15:01:52 INFO - 'TMOUT': '86400', 15:01:52 INFO - 'USER': 'cltbld', 15:01:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', 15:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:52 INFO - '_': '/tools/buildbot/bin/python'} 15:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:01:52 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 15:01:52 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 15:01:52 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 15:01:52 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 15:01:52 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 15:01:52 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 15:01:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:01:54 INFO - Installing collected packages: mozsystemmonitor 15:01:54 INFO - Running setup.py install for mozsystemmonitor 15:01:54 INFO - Successfully installed mozsystemmonitor 15:01:54 INFO - Cleaning up... 15:01:54 INFO - Return code: 0 15:01:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:01:54 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')]} 15:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:54 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')]} 15:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:54 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 0x7f92bfe11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea100>, '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 0x14eb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', '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 15:01:54 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 15:01:54 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 15:01:54 INFO - Using env: {'DISPLAY': ':0', 15:01:54 INFO - 'HOME': '/home/cltbld', 15:01:54 INFO - 'LANG': 'en_US.UTF-8', 15:01:54 INFO - 'LANGUAGE': 'en_US:en', 15:01:54 INFO - 'LOGNAME': 'cltbld', 15:01:54 INFO - 'MAIL': '/var/mail/cltbld', 15:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:54 INFO - 'MOZ_NO_REMOTE': '1', 15:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:54 INFO - 'NO_EM_RESTART': '1', 15:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:54 INFO - 'PWD': '/builds/slave/test', 15:01:54 INFO - 'SHELL': '/bin/bash', 15:01:54 INFO - 'SHLVL': '1', 15:01:54 INFO - 'TERM': 'linux', 15:01:54 INFO - 'TMOUT': '86400', 15:01:54 INFO - 'USER': 'cltbld', 15:01:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', 15:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:54 INFO - '_': '/tools/buildbot/bin/python'} 15:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:55 INFO - Downloading/unpacking blobuploader==1.2.4 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:56 INFO - Downloading blobuploader-1.2.4.tar.gz 15:01:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:01:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:01:57 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 15:01:57 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 15:01:57 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 15:01:57 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 15:01:57 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 15:01:57 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 15:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:01:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:01:57 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 15:01:57 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 15:01:57 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 15:01:57 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 15:01:57 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 15:01:57 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 15:01:57 INFO - Downloading docopt-0.6.1.tar.gz 15:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:01:57 INFO - Installing collected packages: blobuploader, requests, docopt 15:01:57 INFO - Running setup.py install for blobuploader 15:01:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:01:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:01:57 INFO - Running setup.py install for requests 15:01:58 INFO - Running setup.py install for docopt 15:01:58 INFO - Successfully installed blobuploader requests docopt 15:01:58 INFO - Cleaning up... 15:01:58 INFO - Return code: 0 15:01:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:58 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')]} 15:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:58 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')]} 15:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:58 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 0x7f92bfe11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea100>, '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 0x14eb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', '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 15:01:58 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 15:01:58 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 15:01:58 INFO - Using env: {'DISPLAY': ':0', 15:01:58 INFO - 'HOME': '/home/cltbld', 15:01:58 INFO - 'LANG': 'en_US.UTF-8', 15:01:58 INFO - 'LANGUAGE': 'en_US:en', 15:01:58 INFO - 'LOGNAME': 'cltbld', 15:01:58 INFO - 'MAIL': '/var/mail/cltbld', 15:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:58 INFO - 'MOZ_NO_REMOTE': '1', 15:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:58 INFO - 'NO_EM_RESTART': '1', 15:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:58 INFO - 'PWD': '/builds/slave/test', 15:01:58 INFO - 'SHELL': '/bin/bash', 15:01:58 INFO - 'SHLVL': '1', 15:01:58 INFO - 'TERM': 'linux', 15:01:58 INFO - 'TMOUT': '86400', 15:01:58 INFO - 'USER': 'cltbld', 15:01:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', 15:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:58 INFO - '_': '/tools/buildbot/bin/python'} 15:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:58 INFO - Running setup.py (path:/tmp/pip-iqhnIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:58 INFO - Running setup.py (path:/tmp/pip-NvYnZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:58 INFO - Running setup.py (path:/tmp/pip-cUYAii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:58 INFO - Running setup.py (path:/tmp/pip-_7gSCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:58 INFO - Running setup.py (path:/tmp/pip-08bIGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:58 INFO - Running setup.py (path:/tmp/pip-GgrB6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:58 INFO - Running setup.py (path:/tmp/pip-PVIhcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:59 INFO - Running setup.py (path:/tmp/pip-o57m8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:59 INFO - Running setup.py (path:/tmp/pip-N6k907-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:59 INFO - Running setup.py (path:/tmp/pip-OepvZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:59 INFO - Running setup.py (path:/tmp/pip-BTiBKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:59 INFO - Running setup.py (path:/tmp/pip-eWY1gD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:59 INFO - Running setup.py (path:/tmp/pip-6psLHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:59 INFO - Running setup.py (path:/tmp/pip-sa1sGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:59 INFO - Running setup.py (path:/tmp/pip-f68wlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:59 INFO - Running setup.py (path:/tmp/pip-rSUDnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:59 INFO - Running setup.py (path:/tmp/pip-QZDTKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:01:59 INFO - Running setup.py install for manifestparser 15:01:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:01:59 INFO - Running setup.py install for mozcrash 15:01:59 INFO - Running setup.py install for mozdebug 15:02:00 INFO - Running setup.py install for mozdevice 15:02:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:02:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:02:00 INFO - Running setup.py install for mozfile 15:02:00 INFO - Running setup.py install for mozhttpd 15:02:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:02:00 INFO - Running setup.py install for mozinfo 15:02:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:02:00 INFO - Running setup.py install for mozInstall 15:02:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:02:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:02:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:02:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:02:00 INFO - Running setup.py install for mozleak 15:02:00 INFO - Running setup.py install for mozlog 15:02:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:02:00 INFO - Running setup.py install for moznetwork 15:02:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:02:00 INFO - Running setup.py install for mozprocess 15:02:00 INFO - Running setup.py install for mozprofile 15:02:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:02:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:02:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:02:01 INFO - Running setup.py install for mozrunner 15:02:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:02:01 INFO - Running setup.py install for mozscreenshot 15:02:01 INFO - Running setup.py install for moztest 15:02:01 INFO - Running setup.py install for mozversion 15:02:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:02:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:02:01 INFO - Cleaning up... 15:02:01 INFO - Return code: 0 15:02:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:01 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 0x7f92bfe11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea100>, '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 0x14eb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', '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 15:02:01 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 15:02:01 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 15:02:01 INFO - Using env: {'DISPLAY': ':0', 15:02:01 INFO - 'HOME': '/home/cltbld', 15:02:01 INFO - 'LANG': 'en_US.UTF-8', 15:02:01 INFO - 'LANGUAGE': 'en_US:en', 15:02:01 INFO - 'LOGNAME': 'cltbld', 15:02:01 INFO - 'MAIL': '/var/mail/cltbld', 15:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:01 INFO - 'MOZ_NO_REMOTE': '1', 15:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:01 INFO - 'NO_EM_RESTART': '1', 15:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:01 INFO - 'PWD': '/builds/slave/test', 15:02:01 INFO - 'SHELL': '/bin/bash', 15:02:01 INFO - 'SHLVL': '1', 15:02:01 INFO - 'TERM': 'linux', 15:02:01 INFO - 'TMOUT': '86400', 15:02:01 INFO - 'USER': 'cltbld', 15:02:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', 15:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:01 INFO - '_': '/tools/buildbot/bin/python'} 15:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:02:01 INFO - Running setup.py (path:/tmp/pip-MHU908-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:02:01 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)) 15:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:02:01 INFO - Running setup.py (path:/tmp/pip-mRedUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:02:01 INFO - Running setup.py (path:/tmp/pip-32WkxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:02:01 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)) 15:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:02:01 INFO - Running setup.py (path:/tmp/pip-c3XEEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:02:02 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)) 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:02:02 INFO - Running setup.py (path:/tmp/pip-y7_4kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:02:02 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)) 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:02:02 INFO - Running setup.py (path:/tmp/pip-aKe3LP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:02:02 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)) 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:02:02 INFO - Running setup.py (path:/tmp/pip-K0FU5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:02:02 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)) 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:02:02 INFO - Running setup.py (path:/tmp/pip-ChW_QP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:02:02 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)) 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:02:02 INFO - Running setup.py (path:/tmp/pip-KSe46R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:02:02 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)) 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:02:02 INFO - Running setup.py (path:/tmp/pip-rEo1YO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:02:02 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)) 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:02:02 INFO - Running setup.py (path:/tmp/pip-Bcv34g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:02:02 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)) 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:02:02 INFO - Running setup.py (path:/tmp/pip-SzVC9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:02:02 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)) 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:02:02 INFO - Running setup.py (path:/tmp/pip-Z9FRyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:02:02 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)) 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:02:02 INFO - Running setup.py (path:/tmp/pip-kwgYb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:02:02 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)) 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:02 INFO - Running setup.py (path:/tmp/pip-MZFS4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:02 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)) 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:02:02 INFO - Running setup.py (path:/tmp/pip-gxyIK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:02:02 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)) 15:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:02:02 INFO - Running setup.py (path:/tmp/pip-OgwwAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:02:02 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)) 15:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:02:02 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)) 15:02:02 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)) 15:02:02 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)) 15:02:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:02:02 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 15:02:02 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 15:02:02 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 15:02:02 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 15:02:02 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 15:02:02 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 15:02:04 INFO - Downloading blessings-1.6.tar.gz 15:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:02:04 INFO - Installing collected packages: blessings 15:02:04 INFO - Running setup.py install for blessings 15:02:04 INFO - Successfully installed blessings 15:02:04 INFO - Cleaning up... 15:02:05 INFO - Return code: 0 15:02:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:02:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:05 INFO - Reading from file tmpfile_stdout 15:02:05 INFO - Current package versions: 15:02:05 INFO - argparse == 1.2.1 15:02:05 INFO - blessings == 1.6 15:02:05 INFO - blobuploader == 1.2.4 15:02:05 INFO - docopt == 0.6.1 15:02:05 INFO - manifestparser == 1.1 15:02:05 INFO - mozInstall == 1.12 15:02:05 INFO - mozcrash == 0.16 15:02:05 INFO - mozdebug == 0.1 15:02:05 INFO - mozdevice == 0.48 15:02:05 INFO - mozfile == 1.2 15:02:05 INFO - mozhttpd == 0.7 15:02:05 INFO - mozinfo == 0.9 15:02:05 INFO - mozleak == 0.1 15:02:05 INFO - mozlog == 3.1 15:02:05 INFO - moznetwork == 0.27 15:02:05 INFO - mozprocess == 0.22 15:02:05 INFO - mozprofile == 0.28 15:02:05 INFO - mozrunner == 6.11 15:02:05 INFO - mozscreenshot == 0.1 15:02:05 INFO - mozsystemmonitor == 0.0 15:02:05 INFO - moztest == 0.7 15:02:05 INFO - mozversion == 1.4 15:02:05 INFO - psutil == 3.1.1 15:02:05 INFO - requests == 1.2.3 15:02:05 INFO - wsgiref == 0.1.2 15:02:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:05 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')]} 15:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:05 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')]} 15:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:05 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 0x7f92bfe11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea100>, '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 0x14eb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', '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 15:02:05 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 15:02:05 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 15:02:05 INFO - Using env: {'DISPLAY': ':0', 15:02:05 INFO - 'HOME': '/home/cltbld', 15:02:05 INFO - 'LANG': 'en_US.UTF-8', 15:02:05 INFO - 'LANGUAGE': 'en_US:en', 15:02:05 INFO - 'LOGNAME': 'cltbld', 15:02:05 INFO - 'MAIL': '/var/mail/cltbld', 15:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:05 INFO - 'MOZ_NO_REMOTE': '1', 15:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:05 INFO - 'NO_EM_RESTART': '1', 15:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:05 INFO - 'PWD': '/builds/slave/test', 15:02:05 INFO - 'SHELL': '/bin/bash', 15:02:05 INFO - 'SHLVL': '1', 15:02:05 INFO - 'TERM': 'linux', 15:02:05 INFO - 'TMOUT': '86400', 15:02:05 INFO - 'USER': 'cltbld', 15:02:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', 15:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:05 INFO - '_': '/tools/buildbot/bin/python'} 15:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:05 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)) 15:02:05 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)) 15:02:05 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)) 15:02:05 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)) 15:02:05 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)) 15:02:05 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)) 15:02:05 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)) 15:02:05 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)) 15:02:05 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)) 15:02:05 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)) 15:02:05 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)) 15:02:05 INFO - Cleaning up... 15:02:05 INFO - Return code: 0 15:02:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:02:05 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')]} 15:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:05 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')]} 15:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:05 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 0x7f92bfe11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea100>, '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 0x14eb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', '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 15:02:05 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 15:02:05 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 15:02:05 INFO - Using env: {'DISPLAY': ':0', 15:02:05 INFO - 'HOME': '/home/cltbld', 15:02:05 INFO - 'LANG': 'en_US.UTF-8', 15:02:05 INFO - 'LANGUAGE': 'en_US:en', 15:02:05 INFO - 'LOGNAME': 'cltbld', 15:02:05 INFO - 'MAIL': '/var/mail/cltbld', 15:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:05 INFO - 'MOZ_NO_REMOTE': '1', 15:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:05 INFO - 'NO_EM_RESTART': '1', 15:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:05 INFO - 'PWD': '/builds/slave/test', 15:02:05 INFO - 'SHELL': '/bin/bash', 15:02:05 INFO - 'SHLVL': '1', 15:02:05 INFO - 'TERM': 'linux', 15:02:05 INFO - 'TMOUT': '86400', 15:02:05 INFO - 'USER': 'cltbld', 15:02:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', 15:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:05 INFO - '_': '/tools/buildbot/bin/python'} 15:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:05 INFO - Downloading/unpacking jsonschema 15:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:02:07 INFO - Downloading/unpacking functools32 (from jsonschema) 15:02:07 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 15:02:07 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 15:02:07 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 15:02:07 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 15:02:07 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 15:02:07 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 15:02:07 INFO - Downloading functools32-3.2.3-2.tar.gz 15:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:02:07 INFO - warning: no files found matching '*.txt' 15:02:07 INFO - no previously-included directories found matching 'build' 15:02:07 INFO - no previously-included directories found matching 'dist' 15:02:07 INFO - no previously-included directories found matching '.git*' 15:02:07 INFO - Installing collected packages: jsonschema, functools32 15:02:07 INFO - Running setup.py install for functools32 15:02:07 INFO - warning: no files found matching '*.txt' 15:02:07 INFO - no previously-included directories found matching 'build' 15:02:07 INFO - no previously-included directories found matching 'dist' 15:02:07 INFO - no previously-included directories found matching '.git*' 15:02:07 INFO - Successfully installed jsonschema functools32 15:02:07 INFO - Cleaning up... 15:02:07 INFO - Return code: 0 15:02:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:02:07 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')]} 15:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:07 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')]} 15:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:07 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 0x7f92bfe11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea100>, '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 0x14eb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', '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 15:02:07 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 15:02:07 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 15:02:07 INFO - Using env: {'DISPLAY': ':0', 15:02:07 INFO - 'HOME': '/home/cltbld', 15:02:07 INFO - 'LANG': 'en_US.UTF-8', 15:02:07 INFO - 'LANGUAGE': 'en_US:en', 15:02:07 INFO - 'LOGNAME': 'cltbld', 15:02:07 INFO - 'MAIL': '/var/mail/cltbld', 15:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:07 INFO - 'MOZ_NO_REMOTE': '1', 15:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:07 INFO - 'NO_EM_RESTART': '1', 15:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:08 INFO - 'PWD': '/builds/slave/test', 15:02:08 INFO - 'SHELL': '/bin/bash', 15:02:08 INFO - 'SHLVL': '1', 15:02:08 INFO - 'TERM': 'linux', 15:02:08 INFO - 'TMOUT': '86400', 15:02:08 INFO - 'USER': 'cltbld', 15:02:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', 15:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:08 INFO - '_': '/tools/buildbot/bin/python'} 15:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:08 INFO - Downloading/unpacking flake8 15:02:08 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 15:02:08 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 15:02:08 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 15:02:08 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 15:02:08 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 15:02:08 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 15:02:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:02:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:02:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:02:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:02:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:02:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:02:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:02:10 INFO - no previously-included directories found matching 'docs/_build' 15:02:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:02:10 INFO - Running setup.py install for pep8 15:02:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:02:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:02:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:02:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:02:10 INFO - no previously-included directories found matching 'docs/_build' 15:02:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:02:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:02:10 INFO - Cleaning up... 15:02:10 INFO - Return code: 0 15:02:10 INFO - Running post-action listener: _resource_record_post_action 15:02:10 INFO - Running post-action listener: _start_resource_monitoring 15:02:10 INFO - Starting resource monitoring. 15:02:10 INFO - ##### 15:02:10 INFO - ##### Running install step. 15:02:10 INFO - ##### 15:02:10 INFO - Running pre-action listener: _resource_record_pre_action 15:02:10 INFO - Running main action method: install 15:02:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:11 INFO - Reading from file tmpfile_stdout 15:02:11 INFO - Detecting whether we're running mozinstall >=1.0... 15:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:02:11 INFO - Reading from file tmpfile_stdout 15:02:11 INFO - Output received: 15:02:11 INFO - Usage: mozinstall [options] installer 15:02:11 INFO - Options: 15:02:11 INFO - -h, --help show this help message and exit 15:02:11 INFO - -d DEST, --destination=DEST 15:02:11 INFO - Directory to install application into. [default: 15:02:11 INFO - "/builds/slave/test"] 15:02:11 INFO - --app=APP Application being installed. [default: firefox] 15:02:11 INFO - mkdir: /builds/slave/test/build/application 15:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:02:26 INFO - Reading from file tmpfile_stdout 15:02:26 INFO - Output received: 15:02:26 INFO - /builds/slave/test/build/application/firefox/firefox 15:02:26 INFO - Running post-action listener: _resource_record_post_action 15:02:26 INFO - ##### 15:02:26 INFO - ##### Running run-tests step. 15:02:26 INFO - ##### 15:02:26 INFO - Running pre-action listener: _resource_record_pre_action 15:02:26 INFO - Running main action method: run_tests 15:02:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:02:26 INFO - Python 2.7.3 15:02:26 INFO - Return code: 0 15:02:26 INFO - grabbing minidump binary from tooltool 15:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:26 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 0x14ea100>, '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 0x14eb000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:02:26 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 15:02:27 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 15:02:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:02:27 INFO - Return code: 0 15:02:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:02:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:02:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:02:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:02:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:02:28 INFO - Return code: 0 15:02:28 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/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 15:02:28 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/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 15:02:28 INFO - Using env: {'DISPLAY': ':0', 15:02:28 INFO - 'HOME': '/home/cltbld', 15:02:28 INFO - 'LANG': 'en_US.UTF-8', 15:02:28 INFO - 'LANGUAGE': 'en_US:en', 15:02:28 INFO - 'LOGNAME': 'cltbld', 15:02:28 INFO - 'MAIL': '/var/mail/cltbld', 15:02:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:28 INFO - 'MOZ_NO_REMOTE': '1', 15:02:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:28 INFO - 'NO_EM_RESTART': '1', 15:02:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:28 INFO - 'PWD': '/builds/slave/test', 15:02:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:28 INFO - 'SHELL': '/bin/bash', 15:02:28 INFO - 'SHLVL': '1', 15:02:28 INFO - 'TERM': 'linux', 15:02:28 INFO - 'TMOUT': '86400', 15:02:28 INFO - 'USER': 'cltbld', 15:02:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537', 15:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:28 INFO - '_': '/tools/buildbot/bin/python'} 15:02:28 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/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 15:02:28 INFO - mozversion application_buildid: 20160301143133 15:02:28 INFO - mozversion application_changeset: baabb61180e8fe2d55d76ef20fa8ad8c7f4667aa 15:02:28 INFO - mozversion application_display_name: Nightly 15:02:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:02:28 INFO - mozversion application_name: Firefox 15:02:28 INFO - mozversion application_remotingname: firefox 15:02:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:02:28 INFO - mozversion application_vendor: Mozilla 15:02:28 INFO - mozversion application_version: 47.0a1 15:02:28 INFO - mozversion platform_buildid: 20160301143133 15:02:28 INFO - mozversion platform_changeset: baabb61180e8fe2d55d76ef20fa8ad8c7f4667aa 15:02:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:02:28 INFO - mozversion platform_version: 47.0a1 15:02:28 INFO - using testdate: 1456873348 15:02:28 INFO - actual date: 1456873348 15:02:28 INFO - starting webserver on 'localhost:35886' 15:02:28 INFO - SUITE-START | Running 2 tests 15:02:28 INFO - TEST-START | dromaeo_css 15:02:28 INFO - operating with platform_type : linux_ 15:02:28 INFO - Initialising browser for dromaeo_css test... 15:02:28 INFO - TEST-INFO | started process 13409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFehWKh/profile http://localhost:35886/getInfo.html) 15:02:31 INFO - PROCESS | 13409 | 15:02:31 INFO - PROCESS | 13409 | (process:13490): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:02:32 INFO - PROCESS | 13409 | __metrics Screen width/height:1600/1200 15:02:32 INFO - PROCESS | 13409 | colorDepth:24 15:02:32 INFO - PROCESS | 13409 | Browser inner width/height: 1024/697 15:02:32 INFO - PROCESS | 13409 | __metrics 15:02:33 ERROR - PROCESS | 13409 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:02:33 INFO - PROCESS | 13409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:02:33 INFO - PROCESS | 13409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:02:33 INFO - PROCESS | 13409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:02:33 INFO - PROCESS | 13409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:02:33 INFO - PROCESS | 13409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:02:33 INFO - PROCESS | 13409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:02:33 INFO - PROCESS | 13409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:02:33 INFO - PROCESS | 13409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:02:33 INFO - PROCESS | 13409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:02:33 INFO - TEST-INFO | 13409: exit 0 15:02:33 INFO - Browser initialized. 15:02:33 INFO - Running cycle 1/1 for dromaeo_css test... 15:02:33 INFO - TEST-INFO | started process 13541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFehWKh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:35 INFO - PROCESS | 13541 | 15:02:35 INFO - PROCESS | 13541 | (process:13596): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:02:46 INFO - PROCESS | 13541 | RSS: Main: 160997376 15:02:46 INFO - PROCESS | 13541 | 15:03:35 INFO - PROCESS | 13541 | 1456873415667 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] 15:05:47 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:35886/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35886/tests/dromaeo/cssquery-ext.html) 15:05:48 INFO - PROCESS | 13541 | RSS: Main: 170340352 15:05:48 INFO - PROCESS | 13541 | 15:08:50 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:35886/tests/dromaeo/cssquery-ext.html (next: http://localhost:35886/tests/dromaeo/cssquery-jquery.html) 15:08:51 INFO - PROCESS | 13541 | RSS: Main: 165056512 15:08:51 INFO - PROCESS | 13541 | 15:11:52 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:35886/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35886/tests/dromaeo/cssquery-mootools.html) 15:11:53 INFO - PROCESS | 13541 | RSS: Main: 166375424 15:11:53 INFO - PROCESS | 13541 | 15:14:55 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:35886/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35886/tests/dromaeo/cssquery-prototype.html) 15:14:55 INFO - PROCESS | 13541 | RSS: Main: 163819520 15:14:55 INFO - PROCESS | 13541 | 15:17:58 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:35886/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35886/tests/dromaeo/cssquery-yui.html) 15:17:59 INFO - PROCESS | 13541 | RSS: Main: 164249600 15:17:59 INFO - PROCESS | 13541 | 15:21:01 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:35886/tests/dromaeo/cssquery-yui.html (next: http://localhost:35886/tests/dromaeo/cssquery-dojo.html) 15:21:01 INFO - PROCESS | 13541 | RSS: Main: 168857600 15:21:01 INFO - PROCESS | 13541 | 15:21:01 INFO - PROCESS | 13541 | __start_tp_report 15:21:01 INFO - PROCESS | 13541 | _x_x_mozilla_page_load 15:21:01 INFO - PROCESS | 13541 | _x_x_mozilla_page_load_details 15:21:01 INFO - PROCESS | 13541 | |i|pagename|runs| 15:21:01 INFO - PROCESS | 13541 | |0;dojo.html;2628.6319915211884;2641.339665083729;2658.3619931216513;2670.719574444682;2680.6247125402447;4544.045750392422;4577.473590537089;4578.587927086562;4611.654125940555;4614.353990441341;4473.507914129451;4522.638188944885;4554.703944243622;4575.222212223922;4600.815967361302;4212.473440819897;4262.680298977573;4269.765162916038;4270.850520231777;4311.1808756336195;559.9333089402986;4114.136031433388;4204.306289462251;4224.302990006645;4226.809793559281;4243.0241044559925;4245.405643209953;4266.488021437447;4275.828966841323;4282.700210985232;4206.8737937861915;4229.154169166179;4236.57634236577;4249.936250956238;4278.786060696983;4136.648384887289;4208.158368326347;4254.595813397722;4261;4287.549807270254;4428.136513379892;4494.910101797946;4501.932471012938;4504.977475112636;4514.8194072237075;4752.120857641347;4932.80268789248;4937.629677774181;4939.431965323998;4942.629302802268;4841.709497430165;4932.901341973176;4942.135126352874;4967.981563779416;4980.402351717781;4553.521880202564;4577.7482238477205;4577.839775607904;4581.450225972904;4623.537646235383;4908.631852611068;5006.74966251686;5029.245613157982;5031.270465782514;5080.974595127001;4812.783424745895;4829.73436460991;4830.782614782343;4836.322914791932;4864.951350486521;4896;4900.460949295574;4904.043711476299;4908.361912951294;4949.1091603510995;4741.502142275081;4842.394700662418;4860.0765854488245;4889.144399730033;4910.926336104962;4882.462929077798;4891.633127515451;4892.608591312686;4894.461609222983;4936.950630493721;4119.670426365884;4133.0700592366475;4141.337386018223;4141.751494910255;4174.874753757392;3524.1542029912634;3606.531150950412;3651.8539258429364;3680.7791532508136;3682.447632855093;4070.57258987802;4121.196366708523;4195.895102622398;4280.614744672995;4305.268104422255;4961.875953101129;4972.328735620645;4983.127952608279;4989.3264409305;5034.622403319766;4100.933757223143;4278.379634952915;4282.571742825692;4287.7641729705165;4330.870073897788;4316.6546676265825;4358.0412309291905;4364.803583838671;4391.736495810262;4407.0524837160165;4661.300804879227;4683.414573178353;4688.413948256468;4691.437027556715;4724.8660321523275;4756.096341695067;4859.805607775649;4917.852464426073;4953.529414705597;4967.205247160437;4675.392199014106;4703.435587729495;4710.057988402402;4732.952670473252;4747.264174052889;4763.7141771493825;4772.642051846056;4787.497312782108;4791.185498465339;4817.5182481752945;4770.833020844254;4815.398075240595;4871.468036880758;4892;4925.679830810986;4757.904841903073;4759.881002974953;4770.761461926821;4774.40319960005;4813.302071199586;4748.310735332808;4767.165745994506;4768.690035147704;4786.329913811999;4794.232922732346;4546.499885012712;4651.209294419889;4688;4719.905601888012;4767.809287628456;4843.176659967884;4874.366332376911;4877.317175595348;4892.877678058077;4899.069176856386;4719.4100737407825;4739.336492890929;4742.288656701522;4767.189577771718;4782.952170478251 15:21:01 INFO - PROCESS | 13541 | |1;ext.html;472.176052787885;491.5649650059696;492.90881186980414;520.786477544207;546.696583396215;24349.26952191435;24744.25767226984;31365.84317078417;31594;31886.521702174487;34406.48390274148;34717.305653886906;34825;34830.65169348306;34965.30069398611;7575.356094731955;7714.190010048948;7733;7755;7758.340541054017;7609.657565409542;7706.499077559941;7706.922930770676;7707.730229441971;7710.306072453478;7710.074791025057;7823.10034346049;7890.684372625088;7993.96003019987;8001.5199088054615;7769.650365733527;7868.370530357586;7896.052473703135;7905.0513938327485;7916.208379162038;7697.923020769833;7751.379889608817;7823.569703666296;7837.333826624744;7886.369090472748;34783;34947.475787862946;35028.29943401143;35114.64885351165;35135.4729679055;2605.973940260592;2620.1222590432226;2677.531431999412;2735.9042433514733;2796.4127533218048;26559.747705849648;26837.865810671017;27116.59325110125;27183.86408067967;28181;3323.219043524794;3407.4207384744655;3419.2990436960613;3424.760266781326;3484.1986343140966;213600;214353;214711;215173;215396.99999999843;37053;48073.519264807604;48358.758206208746;48377;48484;35010.124746881535;35107;35407.64592354043;35414.64585354165;35470.822645886605;11073.778524429466;11179.161562882817;11192.10463162945;11220;11225.214235003634;8649.827003460021;8749.431286966326;8815.206631403205;8880.067592902653;9113.863292050624;12180;12241.877581224073;12461.501539938301;12577.371131443391;12645.43095560702;5221.921671174935;5230.712310822942;5265.262863199156;5291.788328466818;5371.650842695212;794.2216627704881;850.7235148576738;854.6026097864523;870.3254977392445;940.9153176214173;24659.876700616383;25302.367440814127;25550.744492555208;25655.615165772528;25665.8716706419;881.5988725130051;893.6648756716231;897.7306807957586;901.193431878465;911.4850109688005;12999.480020799252;13036.80444793329;13482.123661961941;14120.364583593762;14950.401983920521;303015;309116;310846;311153;311336;45210;45288.54711452843;45366.54633453689;45407.772961134986;45831.770841146244;1112.2714621922653;1150.6548035589121;1153.2849633227286;1157.311399717167;1265.4621785741208;26130.216093517225;26525.734742653098;26558.734412655627;26616.33459163459;26833.597496037964;35999;39317.6068239314;40194.799026004686;40399;40410.59589404186;252057;253766;254445;255353;256258;35524.822375887954;36044.45933311055;36123.819380902925;36300.27399452049;36572;39241.80379098086;39400.21199575935;39657.80171099126;39674.206515868944;40484.1903161941;31060;31160.688393116685;31210.843945780125;31777;31919.6808031926;31787.6821231794;31808;32262.516062258615;32304.35391292114;32557.34885302328;25144;32030.519542207352;32142.19644508906;35474.29051418906;35619.821900891366;31860.840695796374;32015.519767203044;34877.302453951284;35335.82332088323;35337.29325413426;25102.24693259205;25888;27656.723432765415;27844.30389240285;28278.57582136311 15:21:01 INFO - PROCESS | 13541 | |2;jquery.html;311.0667996011964;312.931155145868;315.92733671255615;317.063078602729;324.61208855417755;14962.32669529871;15102.92448537757;15374.69250614987;15643.530694079182;15665.060096394225;13888.93055534721;14481.986260961738;14781.630459238497;14786.408543658268;15165.6966860663;4850.442199147099;5116.232565115244;5122.410922743895;5124.103281925648;5126.307948426952;4747.098051370229;4930.013997200556;5034.723090230036;5118.232265160237;5137.948620513803;4888.266759985995;4903.338049363344;4920.114379411704;4934.0625281196635;4952.405711314647;4799.760011999386;4904.877378065541;5204.193350030713;5206;5251.264822924793;5022;5026.798928042874;5042.369703787027;5048.066107770038;5067.822626208065;10667.78664426715;13549.322533873266;18364.357247496275;18908.810911890843;18928.14823332953;1725.3874874419525;1755.2013833705632;1783.8840475369059;1815.863810214226;1970.7339509166366;8189.262966333059;8525.701600444017;8629.180227878342;8682.86975695365;8771.912280877174;1729.1267909705643;1734.6357264974245;1743.529247103275;1750.0899532243163;1783.010429211787;39766.602333976865;47812;54269;54504.45495545033;58263;9152.450852948845;9210.76973075665;9581.473018983883;9644.276679249084;9779.364341317792;12171.878281217252;12241.143119981694;12276.693082673004;12321.260724356567;12338.321392323509;6190.164327815777;6210.658413787195;6221.4089661482085;6283.560150789493;6312.842178945563;5689.0328644130595;5754.712264386764;5785.623934444247;5804.390538993345;5807;4077.4903137107863;4089.161721847014;4095.447114639545;4104.4048612950955;4134.1731653669385;1695.6439147779104;1708.4191374932334;1716.364944970369;1751.1506919144206;1761;800.8518424091445;832.7585000349952;880.5641207602278;918.6509126532009;938.0343781197777;15203.619909502351;15330;15366;15461.304241309168;15480.84519154794;807.5316316536395;818.7257268814894;859.7936495241222;875.9912400876037;892.3664198419066;8626.827463450696;8762.518061506678;8835.823283534293;8965.327600429864;8985.236254918274;366587;367961;377260;379698;379767.1128087926;43771;63112.368876311564;64013.35986640167;66099.33900661027;67313.32686673071;861.5046348349724;892.0499667853844;893.7318804358666;896.6054935828215;897.1477096758106;13693.520726774914;14066.929665352018;14259.714805703621;14260.786088208477;14309.141451512942;29425.55861662034;29746;30111.548326775555;30604.234894127825;30928.0721578353;36887.44668829916;37340.626593733716;37500.24999500049;37533.624663754104;37540.62459375481;6805.115335006615;6896.310368963063;6955.826104347432;7017.4386049116965;7126.966589844547;9221.86167207479;10356.378617282988;10713.464326783474;10910.672679819618;10983.39591322485;9575;9646.18007469373;9823.312368134162;9913.058259465339;9923.751906202402;9783.755406114904;9794.118529332394;9928.950355248466;9976.850347244652;9997.100260976547;9654.71035868925;9749.951250243703;9852.113309802153;10067.295289329677;10176.847347289648;7030.296970303133;7064.611446370499;7117.75087871922;7169.390601798906;7227.457940654367;8968.730938071869;9619.711408657751;9683.225341972766;9693.6122555097;9869.703908882744 15:21:01 INFO - PROCESS | 13541 | |3;mootools.html;1117.9105671546274;1125.4822781520506;1150.4420356127278;1454.9345279462416;1574.1971594486822;5847.093700476422;5990.8801823963495;6537.444317233035;6699.497537684669;6742.9325706742975;6461.19235095613;6602.570832895858;6617.602943823362;6639.070530125786;6650.235222949363;1991.1935666055272;2028.9797102028938;2041.2039304671116;2048.426440596628;2050.0467282713535;1983.9603207935832;1986.7715212750575;2001.6697244954564;2019.767726711425;2033.054629597237;1951.7462729845172;1955.892425916574;1958.4907923939807;1962.0484065228352;1963.8428925685982;2011.0447537419755;2022.2315520102413;2024.331970449748;2025.1798021801194;2026.493376655836;1946.4841816918529;1965.1255191439816;1981.4352909420745;1998.6902030185345;2021.1511165310606;6913.4123599494105;6933.965330173367;6960.686769095403;6960.756373526902;6997.545159564663;3956.3076461619103;4060.3909413587903;4068.8372465101656;4074.246264441088;4074.4295798588223;2511.8744062796786;2604.960925586118;2611.973880261211;2646.1267781632014;2656.893724251028;887.7647423432795;888.2716172738357;900.2213085680904;906.6600024990629;919.6091661044096;9391.154796068318;9490.050994900594;9515;9529;9532.571034303404;3519.7360197985254;3533.6819686228364;3610.5847827500174;3641.8907432776527;3657.926841463156;8122.06596241428;8130.430869839172;8165.714200002972;8196.672133114727;8223.424360294723;3983.14362412077;3985.7807820570147;4008.8797336079965;4012.297847876668;4020.4572382728543;3085.9074227773203;3552.9111772205383;3571.339302229096;3589.138606734365;3630.8729194478065;3211.341674956628;3220.2915358621067;3261.608606967179;3269.8201598912287;3270.4930735735998;1027.3681685763202;1042.5152304178594;1045.5713157605346;1062.3041907550567;1066.6906597086913;693.9340762627543;716.8709632266138;913.2511340700562;919.1268295119663;923.6259314977444;6277.372262773777;6359.523035772336;6360.045993101072;6461.289258181596;6464.25661048976;406.8087998640634;416.98910209332735;422.53310092347516;424.26813746288025;428.3275257845215;4946.480619534969;4967.677100988424;5026.698398096053;5054.292399064134;5071.873203169876;7819.100803407568;8147.307478864363;8157.3474122071275;8473.406861519758;8483.27892129176;7970.6413211405625;8056.355491560661;8117.066537348281;8121.269085782308;8131.2681858633005;6400.263969643457;6499.870002600016;6541.574797638138;6541.771038013647;6615.735370585219;6348.968255158695;6366;6387.904181437189;6405.903911441425;6423.229212494531;7244.710211591478;7362.300581444754;7413.703451862081;7623.123340815877;7641.35048520882;7492.812679683051;7723.266289702469;7742.8451430969935;7753.0696316440135;7773.144954055162;5236.711980841091;5917.733701983507;6006.249218847644;6092.512598991982;6111.755529778759;6476.481881449567;6515.478761699147;6544.280129185881;6569.901451478136;6593.571417857824;5498.780048798163;5617.32592088952;5619.100943848965;5648.830535083954;5753.021986262429;5460.563154947516;5736.770529178786;5847.44449277318;5895.587308888508;6015.639061656139;5874.676892770939;5891.351951285269;5942.762289508371;5975.34271230173;6041.093835924647;5659.292588426447;5673.3759286477625;5712.80005199816;5716.714164291852;5730.770769169187;5615.354234263112;5660.29246344207;5681.829545113653;5684.147377893184;5702.572307076903 15:21:01 INFO - PROCESS | 13541 | |4;prototype.html;271.8844491091286;277.07733248283216;278.8912324193564;285.31808976546057;287.8357045749941;5527.861803454915;5566.081596536576;5624.3531993820725;5690.943090569088;5700;5586.6368686035485;5653.4911857932775;5657.434256574341;5664.518515926151;5665.490105890469;4318.546552611978;4324.156789426071;4327;4328.913421731563;4333.65330773539;4307.956920430803;4316.287812510932;4318.460192475941;4319.589638984291;4320.805563749639;4283.207606592775;4285.442892423996;4286.635635970946;4287.035417031158;4301.677374196932;4281.272183728758;4281.7002809803325;4284.228838809013;4285.785710714483;4291.871243862689;3469.0113317704586;3598.3882739934274;3708.4993525873933;3709.332320182366;3712.053426376257;5349.358077030743;5358.5981051421295;5368.087425137736;5370.516653501204;5402;4812.494688057774;4817.349657796188;4828.7102773833685;4832.637552183565;4846.224604063368;5665.405132461074;5811.389804070596;5833.766649334021;5864.5894787364905;5870.765169393262;3880.4567360569545;3896.220755848813;3903.8048097595006;3905.5313362396696;3908.120672848615;6136.263648362181;6199.7290555436475;6215.81352559424;6216.471599914013;6234.875302493925;3982.920341593152;3991.6207960243732;4011.638952494231;4015.9799201004394;4016.116454380032;4060.1067765091634;4061.2283666103344;4062.086030643082;4068.613481719232;4073.0631954650003;4755.38180036593;4758.333833263346;4759.0719809636785;4760.309755085494;4762.904741905142;5676.659400435905;5861.648301101863;5862.325832529228;5864.736086876101;5869.383714709979;1395.9162450253018;1423.1390009044378;1427.2578259305103;1428.2287564715145;1429.8355689095679;919.7148883846029;921.5162039929091;931.1526510875207;957.2676902169845;959.0457494792726;4987.426445958688;5089;5096.770645320969;5097.903950650628;5101.387833460009;6223.159873417031;6288.276848162428;6290.654014029181;6291.779787707408;6296.118543403927;5159.74201289934;5160.509751573594;5160.509751573594;5163.070647283525;5187.844364669066;3299.950500742491;3318.6681331867103;3329.9167520812175;3342.448495998182;3347.414202514599;5791.189233507313;5803.564732645069;5810.767569297181;5858;5873.794417195378;6168.568200226031;6369.363063693686;6376.489880809524;6384.58500197495;6393.840153996094;5794.88410231793;5803.129530570448;5810.070388737781;5810.12848072784;5821.417858214145;6190.1952746142715;6214.564980451506;6221.097940798469;6221.3156552780065;6221.657808820377;5921.467067963904;6015.157877897185;6023.6385816851125;6040.788572399945;6050.848728781815;5741.6842073684675;5776.942230577641;5799.82600521985;5802.912956305574;5807.448292412214;3974.721769476109;3990.9201815964097;4031.5565287818904;4171.165766846703;4204.873853784391;6100.816975490742;6115.510759139169;6123.265208174869;6130.2030736004035;6134.877302454015;5875.265591801025;5878.617889837147;5888.882222355614;5897.262842144732;5897.734601943009;5878.559108066997;5890.410958904075;5899.085641725539;5909.734061967136;5912.852178695567;5725.312962444534;5766.538676905921;5771.971140144273;5776.768929242783;5785.334686511105;5812.622179558315;5976.223090998143;6011.879762404815;6016.939830601813;6017.909731354121;5790.7973220937065;5805.129230615273;5831.620944638585;5843.2695913010875;5853.853653658693 15:21:01 INFO - PROCESS | 13541 | |5;yui.html;522.3131581969712;617.1883972576065;656.0716586030767;668.9799306020822;675.2234929830696;10723.195760317978;10967.232293739442;11005.504752286157;11015.504302306395;11041.447927603627;10715.78568428631;10719.035286824204;10739.946300268488;10876;10896.618618348339;676.3135417551165;682.2665634442957;690.7133539581068;694.5797792335615;694.9756758513453;685.0717278088193;687.8452348221635;690.2924502385046;690.6063543780048;690.7133539581093;724.8948902409147;731.2249016043012;731.381982225019;731.5903094267201;731.963401829909;715.3347386930127;716.1871276101662;716.4268585131899;716.5843810589845;718.2566044144312;535.068979974841;536.07259441167;538.3862396867574;540.2544488605738;541.196323459662;10012.199024078056;10119.797604047952;10127.544260508295;10135.189184865267;10153.847692284622;10099.848502272398;10338.483075846252;10358.549803027583;10464.843027354596;10613.150947924147;8317.875231871527;8495.44779589331;8579.828403431897;8604.39769216155;8640.351973602004;3025.909222723322;3081.6302043754667;3081.7534597232393;3114.6106736657916;3145.1508092815043;44157.33763993575;44290.557094429285;44619.77690111561;44823.327650084946;44967.55032449666;8328.8334233315;8422.747317580483;8472.57637118154;8563.100874408097;8567.143285671384;13221.603351899459;13273.668158295926;13341.933290333487;13573;13618.863811361958;5657.264555607745;5821.505172060422;5830.41695830422;5848.064309710426;6021.939780602138;3470.826458677056;3470.8611655534;3516.367053930317;3615.4757560154158;3663.175785448306;2422.745611710745;2441.511697660475;2456.2017344363153;2463.6797216361756;2479.962800557993;448.6343629941587;456.66207006814716;458.275924040016;460.9976950115295;476.5187160967448;508.3493128795148;510.9284700141983;513.6994858008107;525.5007742644503;538.2491424462852;6334.113224148623;6356.586821856565;6460.612363258219;6495.8700825983215;6495.935040649628;475.69555484489956;497.9170304587508;520.8307300127474;522.9032628963654;530.9548688361456;3111.9533207001914;3145.182252614337;3175.079227024183;3184.268317029338;3218.4045951499047;50391.24413133806;50594.49405505898;50756.23865642018;50766.492335076175;51265.23102153471;44745.10509789786;44851.775741121084;44949;44994;45193.32210016852;38673.8397848065;38852.2229555413;39547.60452395497;41257;41855;6692.397684208445;6723.663816809238;7133.607651579213;7309.269073092648;7315.6342182889575;29967.100986970425;30024.69975300219;30222.244443889078;30272.394552108395;30649.54025689661;38202.617973819906;39065;39425;39677.404838928014;39860.800695997495;9050.366474346733;9589.568469418753;9669.419834809934;9670.419774813534;9685.515724213901;10125.696229113139;10232.59069637206;10297.12474439681;10669.626563070255;10878.347299162075;9793.608255669978;9910.058544438267;10359;10837.729056773644;11129.054030407182;9492.240620750184;9493.667721629987;9910.35582687123;10084.243681723754;10248.077673009466;9830.459324736921;9917.900820991987;9949.701508954742;10160.08559229673;10235.590576376862;8166.4283500154415;8383;8425.536595487061;8590.957045214735;8620.956895215484;8017;8503.914960850312;8550.828983420171;8878.5116818573;8945.418547794372 15:21:01 INFO - PROCESS | 13541 | __end_tp_report 15:21:01 INFO - PROCESS | 13541 | __start_cc_report 15:21:01 INFO - PROCESS | 13541 | _x_x_mozilla_cycle_collect,355 15:21:01 INFO - PROCESS | 13541 | __end_cc_report 15:21:01 INFO - PROCESS | 13541 | __startTimestamp1456874461694__endTimestamp 15:21:01 INFO - PROCESS | 13541 | 15:21:01 INFO - PROCESS | 13541 | ------- Summary: start ------- 15:21:01 INFO - PROCESS | 13541 | Number of tests: 6 15:21:01 INFO - PROCESS | 13541 | 15:21:01 INFO - PROCESS | 13541 | [#0] dojo.html Cycles:165 Average:4515.97 Median:4703.44 stddev:557.68 (11.9%) stddev-sans-first:539.38 15:21:01 INFO - PROCESS | 13541 | Values: 2628.6 2641.3 2658.4 2670.7 2680.6 4544.0 4577.5 4578.6 4611.7 4614.4 4473.5 4522.6 4554.7 4575.2 4600.8 4212.5 4262.7 4269.8 4270.9 4311.2 559.9 4114.1 4204.3 4224.3 4226.8 4243.0 4245.4 4266.5 4275.8 4282.7 4206.9 4229.2 4236.6 4249.9 4278.8 4136.6 4208.2 4254.6 4261.0 4287.5 4428.1 4494.9 4501.9 4505.0 4514.8 4752.1 4932.8 4937.6 4939.4 4942.6 4841.7 4932.9 4942.1 4968.0 4980.4 4553.5 4577.7 4577.8 4581.5 4623.5 4908.6 5006.7 5029.2 5031.3 5081.0 4812.8 4829.7 4830.8 4836.3 4865.0 4896.0 4900.5 4904.0 4908.4 4949.1 4741.5 4842.4 4860.1 4889.1 4910.9 4882.5 4891.6 4892.6 4894.5 4937.0 4119.7 4133.1 4141.3 4141.8 4174.9 3524.2 3606.5 3651.9 3680.8 3682.4 4070.6 4121.2 4195.9 4280.6 4305.3 4961.9 4972.3 4983.1 4989.3 5034.6 4100.9 4278.4 4282.6 4287.8 4330.9 4316.7 4358.0 4364.8 4391.7 4407.1 4661.3 4683.4 4688.4 4691.4 4724.9 4756.1 4859.8 4917.9 4953.5 4967.2 4675.4 4703.4 4710.1 4733.0 4747.3 4763.7 4772.6 4787.5 4791.2 4817.5 4770.8 4815.4 4871.5 4892.0 4925.7 4757.9 4759.9 4770.8 4774.4 4813.3 4748.3 4767.2 4768.7 4786.3 4794.2 4546.5 4651.2 4688.0 4719.9 4767.8 4843.2 4874.4 4877.3 4892.9 4899.1 4719.4 4739.3 4742.3 4767.2 4783.0 15:21:01 INFO - PROCESS | 13541 | 15:21:01 INFO - PROCESS | 13541 | [#1] ext.html Cycles:180 Average:40388.28 Median:34912.39 stddev:68643.20 (196.6%) stddev-sans-first:68770.34 15:21:01 INFO - PROCESS | 13541 | Values: 472.2 491.6 492.9 520.8 546.7 24349.3 24744.3 31365.8 31594.0 31886.5 34406.5 34717.3 34825.0 34830.7 34965.3 7575.4 7714.2 7733.0 7755.0 7758.3 7609.7 7706.5 7706.9 7707.7 7710.3 7710.1 7823.1 7890.7 7994.0 8001.5 7769.7 7868.4 7896.1 7905.1 7916.2 7697.9 7751.4 7823.6 7837.3 7886.4 34783.0 34947.5 35028.3 35114.6 35135.5 2606.0 2620.1 2677.5 2735.9 2796.4 26559.7 26837.9 27116.6 27183.9 28181.0 3323.2 3407.4 3419.3 3424.8 3484.2 213600.0 214353.0 214711.0 215173.0 215397.0 37053.0 48073.5 48358.8 48377.0 48484.0 35010.1 35107.0 35407.6 35414.6 35470.8 11073.8 11179.2 11192.1 11220.0 11225.2 8649.8 8749.4 8815.2 8880.1 9113.9 12180.0 12241.9 12461.5 12577.4 12645.4 5221.9 5230.7 5265.3 5291.8 5371.7 794.2 850.7 854.6 870.3 940.9 24659.9 25302.4 25550.7 25655.6 25665.9 881.6 893.7 897.7 901.2 911.5 12999.5 13036.8 13482.1 14120.4 14950.4 303015.0 309116.0 310846.0 311153.0 311336.0 45210.0 45288.5 45366.5 45407.8 45831.8 1112.3 1150.7 1153.3 1157.3 1265.5 26130.2 26525.7 26558.7 26616.3 26833.6 35999.0 39317.6 40194.8 40399.0 40410.6 252057.0 253766.0 254445.0 255353.0 256258.0 35524.8 36044.5 36123.8 36300.3 36572.0 39241.8 39400.2 39657.8 39674.2 40484.2 31060.0 31160.7 31210.8 31777.0 31919.7 31787.7 31808.0 32262.5 32304.4 32557.3 25144.0 32030.5 32142.2 35474.3 35619.8 31860.8 32015.5 34877.3 35335.8 35337.3 25102.2 25888.0 27656.7 27844.3 28278.6 15:21:01 INFO - PROCESS | 13541 | 15:21:01 INFO - PROCESS | 13541 | [#2] jquery.html Cycles:180 Average:21703.43 Median:5030.76 stddev:61232.49 (1217.2%) stddev-sans-first:61383.20 15:21:01 INFO - PROCESS | 13541 | Values: 311.1 312.9 315.9 317.1 324.6 14962.3 15102.9 15374.7 15643.5 15665.1 13888.9 14482.0 14781.6 14786.4 15165.7 4850.4 5116.2 5122.4 5124.1 5126.3 4747.1 4930.0 5034.7 5118.2 5137.9 4888.3 4903.3 4920.1 4934.1 4952.4 4799.8 4904.9 5204.2 5206.0 5251.3 5022.0 5026.8 5042.4 5048.1 5067.8 10667.8 13549.3 18364.4 18908.8 18928.1 1725.4 1755.2 1783.9 1815.9 1970.7 8189.3 8525.7 8629.2 8682.9 8771.9 1729.1 1734.6 1743.5 1750.1 1783.0 39766.6 47812.0 54269.0 54504.5 58263.0 9152.5 9210.8 9581.5 9644.3 9779.4 12171.9 12241.1 12276.7 12321.3 12338.3 6190.2 6210.7 6221.4 6283.6 6312.8 5689.0 5754.7 5785.6 5804.4 5807.0 4077.5 4089.2 4095.4 4104.4 4134.2 1695.6 1708.4 1716.4 1751.2 1761.0 800.9 832.8 880.6 918.7 938.0 15203.6 15330.0 15366.0 15461.3 15480.8 807.5 818.7 859.8 876.0 892.4 8626.8 8762.5 8835.8 8965.3 8985.2 366587.0 367961.0 377260.0 379698.0 379767.1 43771.0 63112.4 64013.4 66099.3 67313.3 861.5 892.0 893.7 896.6 897.1 13693.5 14066.9 14259.7 14260.8 14309.1 29425.6 29746.0 30111.5 30604.2 30928.1 36887.4 37340.6 37500.2 37533.6 37540.6 6805.1 6896.3 6955.8 7017.4 7127.0 9221.9 10356.4 10713.5 10910.7 10983.4 9575.0 9646.2 9823.3 9913.1 9923.8 9783.8 9794.1 9929.0 9976.9 9997.1 9654.7 9750.0 9852.1 10067.3 10176.8 7030.3 7064.6 7117.8 7169.4 7227.5 8968.7 9619.7 9683.2 9693.6 9869.7 15:21:01 INFO - PROCESS | 13541 | 15:21:01 INFO - PROCESS | 13541 | [#3] mootools.html Cycles:180 Average:4720.43 Median:5733.77 stddev:2512.19 (43.8%) stddev-sans-first:2504.64 15:21:01 INFO - PROCESS | 13541 | Values: 1117.9 1125.5 1150.4 1454.9 1574.2 5847.1 5990.9 6537.4 6699.5 6742.9 6461.2 6602.6 6617.6 6639.1 6650.2 1991.2 2029.0 2041.2 2048.4 2050.0 1984.0 1986.8 2001.7 2019.8 2033.1 1951.7 1955.9 1958.5 1962.0 1963.8 2011.0 2022.2 2024.3 2025.2 2026.5 1946.5 1965.1 1981.4 1998.7 2021.2 6913.4 6934.0 6960.7 6960.8 6997.5 3956.3 4060.4 4068.8 4074.2 4074.4 2511.9 2605.0 2612.0 2646.1 2656.9 887.8 888.3 900.2 906.7 919.6 9391.2 9490.1 9515.0 9529.0 9532.6 3519.7 3533.7 3610.6 3641.9 3657.9 8122.1 8130.4 8165.7 8196.7 8223.4 3983.1 3985.8 4008.9 4012.3 4020.5 3085.9 3552.9 3571.3 3589.1 3630.9 3211.3 3220.3 3261.6 3269.8 3270.5 1027.4 1042.5 1045.6 1062.3 1066.7 693.9 716.9 913.3 919.1 923.6 6277.4 6359.5 6360.0 6461.3 6464.3 406.8 417.0 422.5 424.3 428.3 4946.5 4967.7 5026.7 5054.3 5071.9 7819.1 8147.3 8157.3 8473.4 8483.3 7970.6 8056.4 8117.1 8121.3 8131.3 6400.3 6499.9 6541.6 6541.8 6615.7 6349.0 6366.0 6387.9 6405.9 6423.2 7244.7 7362.3 7413.7 7623.1 7641.4 7492.8 7723.3 7742.8 7753.1 7773.1 5236.7 5917.7 6006.2 6092.5 6111.8 6476.5 6515.5 6544.3 6569.9 6593.6 5498.8 5617.3 5619.1 5648.8 5753.0 5460.6 5736.8 5847.4 5895.6 6015.6 5874.7 5891.4 5942.8 5975.3 6041.1 5659.3 5673.4 5712.8 5716.7 5730.8 5615.4 5660.3 5681.8 5684.1 5702.6 15:21:01 INFO - PROCESS | 13541 | 15:21:01 INFO - PROCESS | 13541 | [#4] prototype.html Cycles:180 Average:4858.11 Median:5660.98 stddev:1478.07 (26.1%) stddev-sans-first:1441.57 15:21:01 INFO - PROCESS | 13541 | Values: 271.9 277.1 278.9 285.3 287.8 5527.9 5566.1 5624.4 5690.9 5700.0 5586.6 5653.5 5657.4 5664.5 5665.5 4318.5 4324.2 4327.0 4328.9 4333.7 4308.0 4316.3 4318.5 4319.6 4320.8 4283.2 4285.4 4286.6 4287.0 4301.7 4281.3 4281.7 4284.2 4285.8 4291.9 3469.0 3598.4 3708.5 3709.3 3712.1 5349.4 5358.6 5368.1 5370.5 5402.0 4812.5 4817.3 4828.7 4832.6 4846.2 5665.4 5811.4 5833.8 5864.6 5870.8 3880.5 3896.2 3903.8 3905.5 3908.1 6136.3 6199.7 6215.8 6216.5 6234.9 3982.9 3991.6 4011.6 4016.0 4016.1 4060.1 4061.2 4062.1 4068.6 4073.1 4755.4 4758.3 4759.1 4760.3 4762.9 5676.7 5861.6 5862.3 5864.7 5869.4 1395.9 1423.1 1427.3 1428.2 1429.8 919.7 921.5 931.2 957.3 959.0 4987.4 5089.0 5096.8 5097.9 5101.4 6223.2 6288.3 6290.7 6291.8 6296.1 5159.7 5160.5 5160.5 5163.1 5187.8 3300.0 3318.7 3329.9 3342.4 3347.4 5791.2 5803.6 5810.8 5858.0 5873.8 6168.6 6369.4 6376.5 6384.6 6393.8 5794.9 5803.1 5810.1 5810.1 5821.4 6190.2 6214.6 6221.1 6221.3 6221.7 5921.5 6015.2 6023.6 6040.8 6050.8 5741.7 5776.9 5799.8 5802.9 5807.4 3974.7 3990.9 4031.6 4171.2 4204.9 6100.8 6115.5 6123.3 6130.2 6134.9 5875.3 5878.6 5888.9 5897.3 5897.7 5878.6 5890.4 5899.1 5909.7 5912.9 5725.3 5766.5 5772.0 5776.8 5785.3 5812.6 5976.2 6011.9 6016.9 6017.9 5790.8 5805.1 5831.6 5843.3 5853.9 15:21:01 INFO - PROCESS | 13541 | 15:21:01 INFO - PROCESS | 13541 | [#5] yui.html Cycles:180 Average:11853.01 Median:50675.37 stddev:14154.24 (27.9%) stddev-sans-first:14168.37 15:21:01 INFO - PROCESS | 13541 | Values: 522.3 617.2 656.1 669.0 675.2 10723.2 10967.2 11005.5 11015.5 11041.4 10715.8 10719.0 10739.9 10876.0 10896.6 676.3 682.3 690.7 694.6 695.0 685.1 687.8 690.3 690.6 690.7 724.9 731.2 731.4 731.6 732.0 715.3 716.2 716.4 716.6 718.3 535.1 536.1 538.4 540.3 541.2 10012.2 10119.8 10127.5 10135.2 10153.8 10099.8 10338.5 10358.5 10464.8 10613.2 8317.9 8495.4 8579.8 8604.4 8640.4 3025.9 3081.6 3081.8 3114.6 3145.2 44157.3 44290.6 44619.8 44823.3 44967.6 8328.8 8422.7 8472.6 8563.1 8567.1 13221.6 13273.7 13341.9 13573.0 13618.9 5657.3 5821.5 5830.4 5848.1 6021.9 3470.8 3470.9 3516.4 3615.5 3663.2 2422.7 2441.5 2456.2 2463.7 2480.0 448.6 456.7 458.3 461.0 476.5 508.3 510.9 513.7 525.5 538.2 6334.1 6356.6 6460.6 6495.9 6495.9 475.7 497.9 520.8 522.9 531.0 3112.0 3145.2 3175.1 3184.3 3218.4 50391.2 50594.5 50756.2 50766.5 51265.2 44745.1 44851.8 44949.0 44994.0 45193.3 38673.8 38852.2 39547.6 41257.0 41855.0 6692.4 6723.7 7133.6 7309.3 7315.6 29967.1 30024.7 30222.2 30272.4 30649.5 38202.6 39065.0 39425.0 39677.4 39860.8 9050.4 9589.6 9669.4 9670.4 9685.5 10125.7 10232.6 10297.1 10669.6 10878.3 9793.6 9910.1 10359.0 10837.7 11129.1 9492.2 9493.7 9910.4 10084.2 10248.1 9830.5 9917.9 9949.7 10160.1 10235.6 8166.4 8383.0 8425.5 8591.0 8621.0 8017.0 8503.9 8550.8 8878.5 8945.4 15:21:01 INFO - PROCESS | 13541 | -------- Summary: end -------- 15:21:01 INFO - PROCESS | 13541 | 15:21:01 INFO - PROCESS | 13541 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:01 INFO - PROCESS | 13541 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:01 INFO - PROCESS | 13541 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:01 INFO - PROCESS | 13541 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:01 INFO - PROCESS | 13541 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:01 INFO - PROCESS | 13541 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:01 INFO - PROCESS | 13541 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:01 INFO - PROCESS | 13541 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:01 INFO - PROCESS | 13541 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:01 INFO - PROCESS | 13541 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:01 INFO - PROCESS | 13541 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:02 INFO - TEST-INFO | 13541: exit 0 15:21:02 INFO - TEST-OK | dromaeo_css | took 1114059ms 15:21:02 INFO - TEST-START | kraken 15:21:02 INFO - operating with platform_type : linux_ 15:21:02 INFO - Initialising browser for kraken test... 15:21:02 INFO - TEST-INFO | started process 13776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSs_dRQ/profile http://localhost:35886/getInfo.html) 15:21:05 INFO - PROCESS | 13776 | 15:21:05 INFO - PROCESS | 13776 | (process:13848): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:21:06 INFO - PROCESS | 13776 | __metrics Screen width/height:1600/1200 15:21:06 INFO - PROCESS | 13776 | colorDepth:24 15:21:06 INFO - PROCESS | 13776 | Browser inner width/height: 1024/697 15:21:06 INFO - PROCESS | 13776 | __metrics 15:21:06 ERROR - PROCESS | 13776 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:21:06 INFO - PROCESS | 13776 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:06 INFO - PROCESS | 13776 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:06 INFO - PROCESS | 13776 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:06 INFO - PROCESS | 13776 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:06 INFO - PROCESS | 13776 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:06 INFO - PROCESS | 13776 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:06 INFO - PROCESS | 13776 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:06 INFO - PROCESS | 13776 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:06 INFO - PROCESS | 13776 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:21:07 INFO - TEST-INFO | 13776: exit 0 15:21:07 INFO - Browser initialized. 15:21:07 INFO - Running cycle 1/1 for kraken test... 15:21:07 INFO - TEST-INFO | started process 13899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSs_dRQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:09 INFO - PROCESS | 13899 | 15:21:09 INFO - PROCESS | 13899 | (process:13956): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:21:19 INFO - PROCESS | 13899 | RSS: Main: 160645120 15:21:19 INFO - PROCESS | 13899 | 15:21:22 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:35886/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35886/tests/kraken/driver.html?testName=audio-beat-detection) 15:21:23 INFO - PROCESS | 13899 | RSS: Main: 168124416 15:21:23 INFO - PROCESS | 13899 | 15:21:25 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:35886/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35886/tests/kraken/driver.html?testName=audio-dft) 15:21:26 INFO - PROCESS | 13899 | RSS: Main: 169615360 15:21:26 INFO - PROCESS | 13899 | 15:21:29 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:35886/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35886/tests/kraken/driver.html?testName=audio-fft) 15:21:30 INFO - PROCESS | 13899 | RSS: Main: 163405824 15:21:30 INFO - PROCESS | 13899 | 15:21:32 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:35886/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35886/tests/kraken/driver.html?testName=audio-oscillator) 15:21:32 INFO - PROCESS | 13899 | RSS: Main: 165466112 15:21:32 INFO - PROCESS | 13899 | 15:21:34 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:35886/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35886/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:21:35 INFO - PROCESS | 13899 | RSS: Main: 165486592 15:21:35 INFO - PROCESS | 13899 | 15:21:38 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:35886/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35886/tests/kraken/driver.html?testName=imaging-darkroom) 15:21:39 INFO - PROCESS | 13899 | RSS: Main: 165744640 15:21:39 INFO - PROCESS | 13899 | 15:21:42 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:35886/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35886/tests/kraken/driver.html?testName=imaging-desaturate) 15:21:43 INFO - PROCESS | 13899 | RSS: Main: 164175872 15:21:43 INFO - PROCESS | 13899 | 15:21:46 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:35886/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35886/tests/kraken/driver.html?testName=json-parse-financial) 15:21:46 INFO - PROCESS | 13899 | RSS: Main: 164478976 15:21:46 INFO - PROCESS | 13899 | 15:21:48 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:35886/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35886/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:21:49 INFO - PROCESS | 13899 | RSS: Main: 164577280 15:21:49 INFO - PROCESS | 13899 | 15:21:51 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:35886/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35886/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:21:51 INFO - PROCESS | 13899 | RSS: Main: 163328000 15:21:51 INFO - PROCESS | 13899 | 15:21:53 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:35886/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35886/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:21:54 INFO - PROCESS | 13899 | RSS: Main: 165515264 15:21:54 INFO - PROCESS | 13899 | 15:21:57 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:35886/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:21:57 INFO - PROCESS | 13899 | RSS: Main: 163700736 15:21:57 INFO - PROCESS | 13899 | 15:22:00 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:35886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:22:00 INFO - PROCESS | 13899 | RSS: Main: 165285888 15:22:00 INFO - PROCESS | 13899 | 15:22:02 INFO - PROCESS | 13899 | Cycle 1(1): loaded http://localhost:35886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35886/tests/kraken/driver.html?testName=ai-astar) 15:22:03 INFO - PROCESS | 13899 | RSS: Main: 165724160 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | __start_tp_report 15:22:03 INFO - PROCESS | 13899 | _x_x_mozilla_page_load 15:22:03 INFO - PROCESS | 13899 | _x_x_mozilla_page_load_details 15:22:03 INFO - PROCESS | 13899 | |i|pagename|runs| 15:22:03 INFO - PROCESS | 13899 | |0;ai-astar;115;110;115;115;115;124;114;115;116;114 15:22:03 INFO - PROCESS | 13899 | |1;audio-beat-detection;154;139;155;175;142;163;158;136;192;134 15:22:03 INFO - PROCESS | 13899 | |2;audio-dft;163;164;164;164;165;175;164;163;165;163 15:22:03 INFO - PROCESS | 13899 | |3;audio-fft;74;77;75;74;74;124;73;73;73;75 15:22:03 INFO - PROCESS | 13899 | |4;audio-oscillator;94;97;147;96;96;95;136;96;96;134 15:22:03 INFO - PROCESS | 13899 | |5;imaging-gaussian-blur;117;118;118;118;117;118;118;118;118;118 15:22:03 INFO - PROCESS | 13899 | |6;imaging-darkroom;148;148;147;148;148;148;147;181;147;149 15:22:03 INFO - PROCESS | 13899 | |7;imaging-desaturate;96;97;97;97;96;97;97;96;96;98 15:22:03 INFO - PROCESS | 13899 | |8;json-parse-financial;68;71;73;67;69;68;68;75;68;65 15:22:03 INFO - PROCESS | 13899 | |9;json-stringify-tinderbox;69;72;71;71;71;71;71;72;72;71 15:22:03 INFO - PROCESS | 13899 | |10;stanford-crypto-aes;84;85;86;86;85;88;92;84;84;84 15:22:03 INFO - PROCESS | 13899 | |11;stanford-crypto-ccm;130;122;120;128;130;122;124;122;122;121 15:22:03 INFO - PROCESS | 13899 | |12;stanford-crypto-pbkdf2;146;143;154;150;151;138;141;152;153;141 15:22:03 INFO - PROCESS | 13899 | |13;stanford-crypto-sha256-iterative;73;74;78;72;72;71;71;72;72;71 15:22:03 INFO - PROCESS | 13899 | __end_tp_report 15:22:03 INFO - PROCESS | 13899 | __start_cc_report 15:22:03 INFO - PROCESS | 13899 | _x_x_mozilla_cycle_collect,869 15:22:03 INFO - PROCESS | 13899 | __end_cc_report 15:22:03 INFO - PROCESS | 13899 | __startTimestamp1456874523037__endTimestamp 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | ------- Summary: start ------- 15:22:03 INFO - PROCESS | 13899 | Number of tests: 14 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.00 stddev:3.47 (3.0%) stddev-sans-first:3.67 15:22:03 INFO - PROCESS | 13899 | Values: 115.0 110.0 115.0 115.0 115.0 124.0 114.0 115.0 116.0 114.0 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:156.50 stddev:18.47 (11.8%) stddev-sans-first:19.59 15:22:03 INFO - PROCESS | 13899 | Values: 154.0 139.0 155.0 175.0 142.0 163.0 158.0 136.0 192.0 134.0 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:3.59 (2.2%) stddev-sans-first:3.73 15:22:03 INFO - PROCESS | 13899 | Values: 163.0 164.0 164.0 164.0 165.0 175.0 164.0 163.0 165.0 163.0 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | [#3] audio-fft Cycles:10 Average:79.20 Median:74.00 stddev:15.79 (21.3%) stddev-sans-first:16.63 15:22:03 INFO - PROCESS | 13899 | Values: 74.0 77.0 75.0 74.0 74.0 124.0 73.0 73.0 73.0 75.0 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:96.00 stddev:21.18 (22.1%) stddev-sans-first:21.79 15:22:03 INFO - PROCESS | 13899 | Values: 94.0 97.0 147.0 96.0 96.0 95.0 136.0 96.0 96.0 134.0 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 15:22:03 INFO - PROCESS | 13899 | Values: 117.0 118.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:148.00 stddev:10.52 (7.1%) stddev-sans-first:11.10 15:22:03 INFO - PROCESS | 13899 | Values: 148.0 148.0 147.0 148.0 148.0 148.0 147.0 181.0 147.0 149.0 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 15:22:03 INFO - PROCESS | 13899 | Values: 96.0 97.0 97.0 97.0 96.0 97.0 97.0 96.0 96.0 98.0 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | [#8] json-parse-financial Cycles:10 Average:69.20 Median:68.50 stddev:2.97 (4.3%) stddev-sans-first:3.12 15:22:03 INFO - PROCESS | 13899 | Values: 68.0 71.0 73.0 67.0 69.0 68.0 68.0 75.0 68.0 65.0 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.00 stddev:0.88 (1.2%) stddev-sans-first:0.50 15:22:03 INFO - PROCESS | 13899 | Values: 69.0 72.0 71.0 71.0 71.0 71.0 71.0 72.0 72.0 71.0 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.50 stddev:2.53 (3.0%) stddev-sans-first:2.60 15:22:03 INFO - PROCESS | 13899 | Values: 84.0 85.0 86.0 86.0 85.0 88.0 92.0 84.0 84.0 84.0 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:123.00 stddev:3.78 (3.1%) stddev-sans-first:3.36 15:22:03 INFO - PROCESS | 13899 | Values: 130.0 122.0 120.0 128.0 130.0 122.0 124.0 122.0 122.0 121.0 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.90 Median:150.50 stddev:5.82 (3.9%) stddev-sans-first:6.16 15:22:03 INFO - PROCESS | 13899 | Values: 146.0 143.0 154.0 150.0 151.0 138.0 141.0 152.0 153.0 141.0 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:72.00 stddev:2.12 (2.9%) stddev-sans-first:2.24 15:22:03 INFO - PROCESS | 13899 | Values: 73.0 74.0 78.0 72.0 72.0 71.0 71.0 72.0 72.0 71.0 15:22:03 INFO - PROCESS | 13899 | -------- Summary: end -------- 15:22:03 INFO - PROCESS | 13899 | 15:22:03 INFO - PROCESS | 13899 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:22:03 INFO - PROCESS | 13899 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:22:03 INFO - PROCESS | 13899 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:22:03 INFO - PROCESS | 13899 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:22:03 INFO - PROCESS | 13899 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:22:03 INFO - PROCESS | 13899 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:22:03 INFO - PROCESS | 13899 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:22:03 INFO - TEST-INFO | 13899: exit 0 15:22:04 INFO - TEST-OK | kraken | took 61612ms 15:22:04 INFO - SUITE-END | took 1175s 15:22:04 INFO - Completed test suite (00:19:35) 15:22:04 INFO - Working with test: dromaeo_css 15:22:04 INFO - Generating results file: dromaeo_css 15:22:04 INFO - Working with test: kraken 15:22:04 INFO - Generating results file: kraken 15:22:04 INFO - javascript benchmark 15:22:04 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:22:04 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 15:22:04 INFO - process_Request line: dromaeo_css 5983.10 graph.html#tests=[[72,132,43]] 15:22:04 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:22:04 INFO - process_Request line: kraken 1558.30 graph.html#tests=[[232,132,43]] 15:22:04 INFO - RETURN: dromaeo_css: 5983.10 15:22:04 INFO - RETURN: kraken: 1558.30 15:22:04 INFO - javascript benchmark 15:22:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2628.6319915211884, 2641.339665083729, 2658.3619931216513, 2670.719574444682, 2680.6247125402447, 4544.045750392422, 4577.473590537089, 4578.587927086562, 4611.654125940555, 4614.353990441341, 4473.507914129451, 4522.638188944885, 4554.703944243622, 4575.222212223922, 4600.815967361302, 4212.473440819897, 4262.680298977573, 4269.765162916038, 4270.850520231777, 4311.1808756336195, 559.9333089402986, 4114.136031433388, 4204.306289462251, 4224.302990006645, 4226.809793559281, 4243.0241044559925, 4245.405643209953, 4266.488021437447, 4275.828966841323, 4282.700210985232, 4206.8737937861915, 4229.154169166179, 4236.57634236577, 4249.936250956238, 4278.786060696983, 4136.648384887289, 4208.158368326347, 4254.595813397722, 4261.0, 4287.549807270254, 4428.136513379892, 4494.910101797946, 4501.932471012938, 4504.977475112636, 4514.8194072237075, 4752.120857641347, 4932.80268789248, 4937.629677774181, 4939.431965323998, 4942.629302802268, 4841.709497430165, 4932.901341973176, 4942.135126352874, 4967.981563779416, 4980.402351717781, 4553.521880202564, 4577.7482238477205, 4577.839775607904, 4581.450225972904, 4623.537646235383, 4908.631852611068, 5006.74966251686, 5029.245613157982, 5031.270465782514, 5080.974595127001, 4812.783424745895, 4829.73436460991, 4830.782614782343, 4836.322914791932, 4864.951350486521, 4896.0, 4900.460949295574, 4904.043711476299, 4908.361912951294, 4949.1091603510995, 4741.502142275081, 4842.394700662418, 4860.0765854488245, 4889.144399730033, 4910.926336104962, 4882.462929077798, 4891.633127515451, 4892.608591312686, 4894.461609222983, 4936.950630493721, 4119.670426365884, 4133.0700592366475, 4141.337386018223, 4141.751494910255, 4174.874753757392, 3524.1542029912634, 3606.531150950412, 3651.8539258429364, 3680.7791532508136, 3682.447632855093, 4070.57258987802, 4121.196366708523, 4195.895102622398, 4280.614744672995, 4305.268104422255, 4961.875953101129, 4972.328735620645, 4983.127952608279, 4989.3264409305, 5034.622403319766, 4100.933757223143, 4278.379634952915, 4282.571742825692, 4287.7641729705165, 4330.870073897788, 4316.6546676265825, 4358.0412309291905, 4364.803583838671, 4391.736495810262, 4407.0524837160165, 4661.300804879227, 4683.414573178353, 4688.413948256468, 4691.437027556715, 4724.8660321523275, 4756.096341695067, 4859.805607775649, 4917.852464426073, 4953.529414705597, 4967.205247160437, 4675.392199014106, 4703.435587729495, 4710.057988402402, 4732.952670473252, 4747.264174052889, 4763.7141771493825, 4772.642051846056, 4787.497312782108, 4791.185498465339, 4817.5182481752945, 4770.833020844254, 4815.398075240595, 4871.468036880758, 4892.0, 4925.679830810986, 4757.904841903073, 4759.881002974953, 4770.761461926821, 4774.40319960005, 4813.302071199586, 4748.310735332808, 4767.165745994506, 4768.690035147704, 4786.329913811999, 4794.232922732346, 4546.499885012712, 4651.209294419889, 4688.0, 4719.905601888012, 4767.809287628456, 4843.176659967884, 4874.366332376911, 4877.317175595348, 4892.877678058077, 4899.069176856386, 4719.4100737407825, 4739.336492890929, 4742.288656701522, 4767.189577771718, 4782.952170478251], "unit": "score", "name": "dojo.html", "value": 4483.65960529971}, {"lowerIsBetter": false, "replicates": [472.176052787885, 491.5649650059696, 492.90881186980414, 520.786477544207, 546.696583396215, 24349.26952191435, 24744.25767226984, 31365.84317078417, 31594.0, 31886.521702174487, 34406.48390274148, 34717.305653886906, 34825.0, 34830.65169348306, 34965.30069398611, 7575.356094731955, 7714.190010048948, 7733.0, 7755.0, 7758.340541054017, 7609.657565409542, 7706.499077559941, 7706.922930770676, 7707.730229441971, 7710.306072453478, 7710.074791025057, 7823.10034346049, 7890.684372625088, 7993.96003019987, 8001.5199088054615, 7769.650365733527, 7868.370530357586, 7896.052473703135, 7905.0513938327485, 7916.208379162038, 7697.923020769833, 7751.379889608817, 7823.569703666296, 7837.333826624744, 7886.369090472748, 34783.0, 34947.475787862946, 35028.29943401143, 35114.64885351165, 35135.4729679055, 2605.973940260592, 2620.1222590432226, 2677.531431999412, 2735.9042433514733, 2796.4127533218048, 26559.747705849648, 26837.865810671017, 27116.59325110125, 27183.86408067967, 28181.0, 3323.219043524794, 3407.4207384744655, 3419.2990436960613, 3424.760266781326, 3484.1986343140966, 213600.0, 214353.0, 214711.0, 215173.0, 215396.99999999843, 37053.0, 48073.519264807604, 48358.758206208746, 48377.0, 48484.0, 35010.124746881535, 35107.0, 35407.64592354043, 35414.64585354165, 35470.822645886605, 11073.778524429466, 11179.161562882817, 11192.10463162945, 11220.0, 11225.214235003634, 8649.827003460021, 8749.431286966326, 8815.206631403205, 8880.067592902653, 9113.863292050624, 12180.0, 12241.877581224073, 12461.501539938301, 12577.371131443391, 12645.43095560702, 5221.921671174935, 5230.712310822942, 5265.262863199156, 5291.788328466818, 5371.650842695212, 794.2216627704881, 850.7235148576738, 854.6026097864523, 870.3254977392445, 940.9153176214173, 24659.876700616383, 25302.367440814127, 25550.744492555208, 25655.615165772528, 25665.8716706419, 881.5988725130051, 893.6648756716231, 897.7306807957586, 901.193431878465, 911.4850109688005, 12999.480020799252, 13036.80444793329, 13482.123661961941, 14120.364583593762, 14950.401983920521, 303015.0, 309116.0, 310846.0, 311153.0, 311336.0, 45210.0, 45288.54711452843, 45366.54633453689, 45407.772961134986, 45831.770841146244, 1112.2714621922653, 1150.6548035589121, 1153.2849633227286, 1157.311399717167, 1265.4621785741208, 26130.216093517225, 26525.734742653098, 26558.734412655627, 26616.33459163459, 26833.597496037964, 35999.0, 39317.6068239314, 40194.799026004686, 40399.0, 40410.59589404186, 252057.0, 253766.0, 254445.0, 255353.0, 256258.0, 35524.822375887954, 36044.45933311055, 36123.819380902925, 36300.27399452049, 36572.0, 39241.80379098086, 39400.21199575935, 39657.80171099126, 39674.206515868944, 40484.1903161941, 31060.0, 31160.688393116685, 31210.843945780125, 31777.0, 31919.6808031926, 31787.6821231794, 31808.0, 32262.516062258615, 32304.35391292114, 32557.34885302328, 25144.0, 32030.519542207352, 32142.19644508906, 35474.29051418906, 35619.821900891366, 31860.840695796374, 32015.519767203044, 34877.302453951284, 35335.82332088323, 35337.29325413426, 25102.24693259205, 25888.0, 27656.723432765415, 27844.30389240285, 28278.57582136311], "unit": "score", "name": "ext.html", "value": 15801.71919526066}, {"lowerIsBetter": false, "replicates": [311.0667996011964, 312.931155145868, 315.92733671255615, 317.063078602729, 324.61208855417755, 14962.32669529871, 15102.92448537757, 15374.69250614987, 15643.530694079182, 15665.060096394225, 13888.93055534721, 14481.986260961738, 14781.630459238497, 14786.408543658268, 15165.6966860663, 4850.442199147099, 5116.232565115244, 5122.410922743895, 5124.103281925648, 5126.307948426952, 4747.098051370229, 4930.013997200556, 5034.723090230036, 5118.232265160237, 5137.948620513803, 4888.266759985995, 4903.338049363344, 4920.114379411704, 4934.0625281196635, 4952.405711314647, 4799.760011999386, 4904.877378065541, 5204.193350030713, 5206.0, 5251.264822924793, 5022.0, 5026.798928042874, 5042.369703787027, 5048.066107770038, 5067.822626208065, 10667.78664426715, 13549.322533873266, 18364.357247496275, 18908.810911890843, 18928.14823332953, 1725.3874874419525, 1755.2013833705632, 1783.8840475369059, 1815.863810214226, 1970.7339509166366, 8189.262966333059, 8525.701600444017, 8629.180227878342, 8682.86975695365, 8771.912280877174, 1729.1267909705643, 1734.6357264974245, 1743.529247103275, 1750.0899532243163, 1783.010429211787, 39766.602333976865, 47812.0, 54269.0, 54504.45495545033, 58263.0, 9152.450852948845, 9210.76973075665, 9581.473018983883, 9644.276679249084, 9779.364341317792, 12171.878281217252, 12241.143119981694, 12276.693082673004, 12321.260724356567, 12338.321392323509, 6190.164327815777, 6210.658413787195, 6221.4089661482085, 6283.560150789493, 6312.842178945563, 5689.0328644130595, 5754.712264386764, 5785.623934444247, 5804.390538993345, 5807.0, 4077.4903137107863, 4089.161721847014, 4095.447114639545, 4104.4048612950955, 4134.1731653669385, 1695.6439147779104, 1708.4191374932334, 1716.364944970369, 1751.1506919144206, 1761.0, 800.8518424091445, 832.7585000349952, 880.5641207602278, 918.6509126532009, 938.0343781197777, 15203.619909502351, 15330.0, 15366.0, 15461.304241309168, 15480.84519154794, 807.5316316536395, 818.7257268814894, 859.7936495241222, 875.9912400876037, 892.3664198419066, 8626.827463450696, 8762.518061506678, 8835.823283534293, 8965.327600429864, 8985.236254918274, 366587.0, 367961.0, 377260.0, 379698.0, 379767.1128087926, 43771.0, 63112.368876311564, 64013.35986640167, 66099.33900661027, 67313.32686673071, 861.5046348349724, 892.0499667853844, 893.7318804358666, 896.6054935828215, 897.1477096758106, 13693.520726774914, 14066.929665352018, 14259.714805703621, 14260.786088208477, 14309.141451512942, 29425.55861662034, 29746.0, 30111.548326775555, 30604.234894127825, 30928.0721578353, 36887.44668829916, 37340.626593733716, 37500.24999500049, 37533.624663754104, 37540.62459375481, 6805.115335006615, 6896.310368963063, 6955.826104347432, 7017.4386049116965, 7126.966589844547, 9221.86167207479, 10356.378617282988, 10713.464326783474, 10910.672679819618, 10983.39591322485, 9575.0, 9646.18007469373, 9823.312368134162, 9913.058259465339, 9923.751906202402, 9783.755406114904, 9794.118529332394, 9928.950355248466, 9976.850347244652, 9997.100260976547, 9654.71035868925, 9749.951250243703, 9852.113309802153, 10067.295289329677, 10176.847347289648, 7030.296970303133, 7064.611446370499, 7117.75087871922, 7169.390601798906, 7227.457940654367, 8968.730938071869, 9619.711408657751, 9683.225341972766, 9693.6122555097, 9869.703908882744], "unit": "score", "name": "jquery.html", "value": 7433.439185258856}, {"lowerIsBetter": false, "replicates": [1117.9105671546274, 1125.4822781520506, 1150.4420356127278, 1454.9345279462416, 1574.1971594486822, 5847.093700476422, 5990.8801823963495, 6537.444317233035, 6699.497537684669, 6742.9325706742975, 6461.19235095613, 6602.570832895858, 6617.602943823362, 6639.070530125786, 6650.235222949363, 1991.1935666055272, 2028.9797102028938, 2041.2039304671116, 2048.426440596628, 2050.0467282713535, 1983.9603207935832, 1986.7715212750575, 2001.6697244954564, 2019.767726711425, 2033.054629597237, 1951.7462729845172, 1955.892425916574, 1958.4907923939807, 1962.0484065228352, 1963.8428925685982, 2011.0447537419755, 2022.2315520102413, 2024.331970449748, 2025.1798021801194, 2026.493376655836, 1946.4841816918529, 1965.1255191439816, 1981.4352909420745, 1998.6902030185345, 2021.1511165310606, 6913.4123599494105, 6933.965330173367, 6960.686769095403, 6960.756373526902, 6997.545159564663, 3956.3076461619103, 4060.3909413587903, 4068.8372465101656, 4074.246264441088, 4074.4295798588223, 2511.8744062796786, 2604.960925586118, 2611.973880261211, 2646.1267781632014, 2656.893724251028, 887.7647423432795, 888.2716172738357, 900.2213085680904, 906.6600024990629, 919.6091661044096, 9391.154796068318, 9490.050994900594, 9515.0, 9529.0, 9532.571034303404, 3519.7360197985254, 3533.6819686228364, 3610.5847827500174, 3641.8907432776527, 3657.926841463156, 8122.06596241428, 8130.430869839172, 8165.714200002972, 8196.672133114727, 8223.424360294723, 3983.14362412077, 3985.7807820570147, 4008.8797336079965, 4012.297847876668, 4020.4572382728543, 3085.9074227773203, 3552.9111772205383, 3571.339302229096, 3589.138606734365, 3630.8729194478065, 3211.341674956628, 3220.2915358621067, 3261.608606967179, 3269.8201598912287, 3270.4930735735998, 1027.3681685763202, 1042.5152304178594, 1045.5713157605346, 1062.3041907550567, 1066.6906597086913, 693.9340762627543, 716.8709632266138, 913.2511340700562, 919.1268295119663, 923.6259314977444, 6277.372262773777, 6359.523035772336, 6360.045993101072, 6461.289258181596, 6464.25661048976, 406.8087998640634, 416.98910209332735, 422.53310092347516, 424.26813746288025, 428.3275257845215, 4946.480619534969, 4967.677100988424, 5026.698398096053, 5054.292399064134, 5071.873203169876, 7819.100803407568, 8147.307478864363, 8157.3474122071275, 8473.406861519758, 8483.27892129176, 7970.6413211405625, 8056.355491560661, 8117.066537348281, 8121.269085782308, 8131.2681858633005, 6400.263969643457, 6499.870002600016, 6541.574797638138, 6541.771038013647, 6615.735370585219, 6348.968255158695, 6366.0, 6387.904181437189, 6405.903911441425, 6423.229212494531, 7244.710211591478, 7362.300581444754, 7413.703451862081, 7623.123340815877, 7641.35048520882, 7492.812679683051, 7723.266289702469, 7742.8451430969935, 7753.0696316440135, 7773.144954055162, 5236.711980841091, 5917.733701983507, 6006.249218847644, 6092.512598991982, 6111.755529778759, 6476.481881449567, 6515.478761699147, 6544.280129185881, 6569.901451478136, 6593.571417857824, 5498.780048798163, 5617.32592088952, 5619.100943848965, 5648.830535083954, 5753.021986262429, 5460.563154947516, 5736.770529178786, 5847.44449277318, 5895.587308888508, 6015.639061656139, 5874.676892770939, 5891.351951285269, 5942.762289508371, 5975.34271230173, 6041.093835924647, 5659.292588426447, 5673.3759286477625, 5712.80005199816, 5716.714164291852, 5730.770769169187, 5615.354234263112, 5660.29246344207, 5681.829545113653, 5684.147377893184, 5702.572307076903], "unit": "score", "name": "mootools.html", "value": 3784.9907664663865}, {"lowerIsBetter": false, "replicates": [271.8844491091286, 277.07733248283216, 278.8912324193564, 285.31808976546057, 287.8357045749941, 5527.861803454915, 5566.081596536576, 5624.3531993820725, 5690.943090569088, 5700.0, 5586.6368686035485, 5653.4911857932775, 5657.434256574341, 5664.518515926151, 5665.490105890469, 4318.546552611978, 4324.156789426071, 4327.0, 4328.913421731563, 4333.65330773539, 4307.956920430803, 4316.287812510932, 4318.460192475941, 4319.589638984291, 4320.805563749639, 4283.207606592775, 4285.442892423996, 4286.635635970946, 4287.035417031158, 4301.677374196932, 4281.272183728758, 4281.7002809803325, 4284.228838809013, 4285.785710714483, 4291.871243862689, 3469.0113317704586, 3598.3882739934274, 3708.4993525873933, 3709.332320182366, 3712.053426376257, 5349.358077030743, 5358.5981051421295, 5368.087425137736, 5370.516653501204, 5402.0, 4812.494688057774, 4817.349657796188, 4828.7102773833685, 4832.637552183565, 4846.224604063368, 5665.405132461074, 5811.389804070596, 5833.766649334021, 5864.5894787364905, 5870.765169393262, 3880.4567360569545, 3896.220755848813, 3903.8048097595006, 3905.5313362396696, 3908.120672848615, 6136.263648362181, 6199.7290555436475, 6215.81352559424, 6216.471599914013, 6234.875302493925, 3982.920341593152, 3991.6207960243732, 4011.638952494231, 4015.9799201004394, 4016.116454380032, 4060.1067765091634, 4061.2283666103344, 4062.086030643082, 4068.613481719232, 4073.0631954650003, 4755.38180036593, 4758.333833263346, 4759.0719809636785, 4760.309755085494, 4762.904741905142, 5676.659400435905, 5861.648301101863, 5862.325832529228, 5864.736086876101, 5869.383714709979, 1395.9162450253018, 1423.1390009044378, 1427.2578259305103, 1428.2287564715145, 1429.8355689095679, 919.7148883846029, 921.5162039929091, 931.1526510875207, 957.2676902169845, 959.0457494792726, 4987.426445958688, 5089.0, 5096.770645320969, 5097.903950650628, 5101.387833460009, 6223.159873417031, 6288.276848162428, 6290.654014029181, 6291.779787707408, 6296.118543403927, 5159.74201289934, 5160.509751573594, 5160.509751573594, 5163.070647283525, 5187.844364669066, 3299.950500742491, 3318.6681331867103, 3329.9167520812175, 3342.448495998182, 3347.414202514599, 5791.189233507313, 5803.564732645069, 5810.767569297181, 5858.0, 5873.794417195378, 6168.568200226031, 6369.363063693686, 6376.489880809524, 6384.58500197495, 6393.840153996094, 5794.88410231793, 5803.129530570448, 5810.070388737781, 5810.12848072784, 5821.417858214145, 6190.1952746142715, 6214.564980451506, 6221.097940798469, 6221.3156552780065, 6221.657808820377, 5921.467067963904, 6015.157877897185, 6023.6385816851125, 6040.788572399945, 6050.848728781815, 5741.6842073684675, 5776.942230577641, 5799.82600521985, 5802.912956305574, 5807.448292412214, 3974.721769476109, 3990.9201815964097, 4031.5565287818904, 4171.165766846703, 4204.873853784391, 6100.816975490742, 6115.510759139169, 6123.265208174869, 6130.2030736004035, 6134.877302454015, 5875.265591801025, 5878.617889837147, 5888.882222355614, 5897.262842144732, 5897.734601943009, 5878.559108066997, 5890.410958904075, 5899.085641725539, 5909.734061967136, 5912.852178695567, 5725.312962444534, 5766.538676905921, 5771.971140144273, 5776.768929242783, 5785.334686511105, 5812.622179558315, 5976.223090998143, 6011.879762404815, 6016.939830601813, 6017.909731354121, 5790.7973220937065, 5805.129230615273, 5831.620944638585, 5843.2695913010875, 5853.853653658693], "unit": "score", "name": "prototype.html", "value": 4362.808408131434}, {"lowerIsBetter": false, "replicates": [522.3131581969712, 617.1883972576065, 656.0716586030767, 668.9799306020822, 675.2234929830696, 10723.195760317978, 10967.232293739442, 11005.504752286157, 11015.504302306395, 11041.447927603627, 10715.78568428631, 10719.035286824204, 10739.946300268488, 10876.0, 10896.618618348339, 676.3135417551165, 682.2665634442957, 690.7133539581068, 694.5797792335615, 694.9756758513453, 685.0717278088193, 687.8452348221635, 690.2924502385046, 690.6063543780048, 690.7133539581093, 724.8948902409147, 731.2249016043012, 731.381982225019, 731.5903094267201, 731.963401829909, 715.3347386930127, 716.1871276101662, 716.4268585131899, 716.5843810589845, 718.2566044144312, 535.068979974841, 536.07259441167, 538.3862396867574, 540.2544488605738, 541.196323459662, 10012.199024078056, 10119.797604047952, 10127.544260508295, 10135.189184865267, 10153.847692284622, 10099.848502272398, 10338.483075846252, 10358.549803027583, 10464.843027354596, 10613.150947924147, 8317.875231871527, 8495.44779589331, 8579.828403431897, 8604.39769216155, 8640.351973602004, 3025.909222723322, 3081.6302043754667, 3081.7534597232393, 3114.6106736657916, 3145.1508092815043, 44157.33763993575, 44290.557094429285, 44619.77690111561, 44823.327650084946, 44967.55032449666, 8328.8334233315, 8422.747317580483, 8472.57637118154, 8563.100874408097, 8567.143285671384, 13221.603351899459, 13273.668158295926, 13341.933290333487, 13573.0, 13618.863811361958, 5657.264555607745, 5821.505172060422, 5830.41695830422, 5848.064309710426, 6021.939780602138, 3470.826458677056, 3470.8611655534, 3516.367053930317, 3615.4757560154158, 3663.175785448306, 2422.745611710745, 2441.511697660475, 2456.2017344363153, 2463.6797216361756, 2479.962800557993, 448.6343629941587, 456.66207006814716, 458.275924040016, 460.9976950115295, 476.5187160967448, 508.3493128795148, 510.9284700141983, 513.6994858008107, 525.5007742644503, 538.2491424462852, 6334.113224148623, 6356.586821856565, 6460.612363258219, 6495.8700825983215, 6495.935040649628, 475.69555484489956, 497.9170304587508, 520.8307300127474, 522.9032628963654, 530.9548688361456, 3111.9533207001914, 3145.182252614337, 3175.079227024183, 3184.268317029338, 3218.4045951499047, 50391.24413133806, 50594.49405505898, 50756.23865642018, 50766.492335076175, 51265.23102153471, 44745.10509789786, 44851.775741121084, 44949.0, 44994.0, 45193.32210016852, 38673.8397848065, 38852.2229555413, 39547.60452395497, 41257.0, 41855.0, 6692.397684208445, 6723.663816809238, 7133.607651579213, 7309.269073092648, 7315.6342182889575, 29967.100986970425, 30024.69975300219, 30222.244443889078, 30272.394552108395, 30649.54025689661, 38202.617973819906, 39065.0, 39425.0, 39677.404838928014, 39860.800695997495, 9050.366474346733, 9589.568469418753, 9669.419834809934, 9670.419774813534, 9685.515724213901, 10125.696229113139, 10232.59069637206, 10297.12474439681, 10669.626563070255, 10878.347299162075, 9793.608255669978, 9910.058544438267, 10359.0, 10837.729056773644, 11129.054030407182, 9492.240620750184, 9493.667721629987, 9910.35582687123, 10084.243681723754, 10248.077673009466, 9830.459324736921, 9917.900820991987, 9949.701508954742, 10160.08559229673, 10235.590576376862, 8166.4283500154415, 8383.0, 8425.536595487061, 8590.957045214735, 8620.956895215484, 8017.0, 8503.914960850312, 8550.828983420171, 8878.5116818573, 8945.418547794372], "unit": "score", "name": "yui.html", "value": 5274.200199205901}], "name": "dromaeo_css", "value": 5983.101465364706}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 115.0, 115.0, 115.0, 124.0, 114.0, 115.0, 116.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.3}, {"lowerIsBetter": true, "replicates": [154.0, 139.0, 155.0, 175.0, 142.0, 163.0, 158.0, 136.0, 192.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 154.8}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 164.0, 164.0, 165.0, 175.0, 164.0, 163.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 165.0}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 75.0, 74.0, 74.0, 124.0, 73.0, 73.0, 73.0, 75.0], "unit": "score", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [94.0, 97.0, 147.0, 96.0, 96.0, 95.0, 136.0, 96.0, 96.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.8}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 181.0, 147.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 151.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 98.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 73.0, 67.0, 69.0, 68.0, 68.0, 75.0, 68.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 69.2}, {"lowerIsBetter": true, "replicates": [69.0, 72.0, 71.0, 71.0, 71.0, 71.0, 71.0, 72.0, 72.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.1}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 86.0, 85.0, 88.0, 92.0, 84.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [130.0, 122.0, 120.0, 128.0, 130.0, 122.0, 124.0, 122.0, 122.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [146.0, 143.0, 154.0, 150.0, 151.0, 138.0, 141.0, 152.0, 153.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.9}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 78.0, 72.0, 72.0, 71.0, 71.0, 72.0, 72.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.6}], "name": "kraken", "value": 1558.3}]} 15:22:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1558.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "5983.10"}}} 15:22:04 INFO - Return code: 0 15:22:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:22:04 ERROR - # TBPL SUCCESS # 15:22:04 INFO - Running post-action listener: _resource_record_post_action 15:22:04 INFO - Running post-run listener: _resource_record_post_run 15:22:05 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 382312448; Read time: 0; Write time: 197512 15:22:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 94253056; Read time: 0; Write time: 55680 15:22:05 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 288059392; Read time: 0; Write time: 141832 15:22:05 INFO - Running post-run listener: _upload_blobber_files 15:22:05 INFO - Blob upload gear active. 15:22:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:22:05 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 15:22:05 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'] 15:22:05 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 15:22:06 INFO - (blobuploader) - INFO - Open directory for files ... 15:22:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:22:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:22:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:07 INFO - (blobuploader) - INFO - Done attempting. 15:22:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:22:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:22:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:08 INFO - (blobuploader) - INFO - Done attempting. 15:22:08 INFO - (blobuploader) - INFO - Iteration through files over. 15:22:08 INFO - Return code: 0 15:22:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:22:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:22:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29a2c2421fb8bad3e83357d40adc65a8cc06ceee8100b7d9b1ab1f6d2c411f49c479f9fe5ea731397b3433f472c780d4dc72aff53c9f2e588b408a19dc3622f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3f7f7d91aa0af52ff21373d45b4d7ac30161ffa14fea0d9c2413612106d999740e34c4c2cc5ad3703a6070bd2ead8f60b61d15dcb3a8a62487ce5ce5f1a2759"} 15:22:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:22:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:22:08 INFO - Contents: 15:22:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29a2c2421fb8bad3e83357d40adc65a8cc06ceee8100b7d9b1ab1f6d2c411f49c479f9fe5ea731397b3433f472c780d4dc72aff53c9f2e588b408a19dc3622f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3f7f7d91aa0af52ff21373d45b4d7ac30161ffa14fea0d9c2413612106d999740e34c4c2cc5ad3703a6070bd2ead8f60b61d15dcb3a8a62487ce5ce5f1a2759"} 15:22:08 INFO - Running post-run listener: copy_logs_to_upload_dir 15:22:08 INFO - Copying logs to upload dir... 15:22:08 INFO - mkdir: /builds/slave/test/build/upload/logs 15:22:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.350062 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-03-01 15:22:08.660095) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 15:22:08.665658) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537 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/29a2c2421fb8bad3e83357d40adc65a8cc06ceee8100b7d9b1ab1f6d2c411f49c479f9fe5ea731397b3433f472c780d4dc72aff53c9f2e588b408a19dc3622f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3f7f7d91aa0af52ff21373d45b4d7ac30161ffa14fea0d9c2413612106d999740e34c4c2cc5ad3703a6070bd2ead8f60b61d15dcb3a8a62487ce5ce5f1a2759"} build_url:https://queue.taskcluster.net/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011485 build_url: 'https://queue.taskcluster.net/v1/task/SNBp249tQXmAeh5uIkUy1Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29a2c2421fb8bad3e83357d40adc65a8cc06ceee8100b7d9b1ab1f6d2c411f49c479f9fe5ea731397b3433f472c780d4dc72aff53c9f2e588b408a19dc3622f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3f7f7d91aa0af52ff21373d45b4d7ac30161ffa14fea0d9c2413612106d999740e34c4c2cc5ad3703a6070bd2ead8f60b61d15dcb3a8a62487ce5ce5f1a2759"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 15:22:08.690362) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:22:08.690708) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456873227.262283-2104317537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:22:08.775106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 15:22:08.775456) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 15:22:08.775754) ========= ========= Total master_lag: 0.31 =========