builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1456835451.39 results: success (0) buildid: 20160301030244 builduid: 9cd00d0abf224634995088b64d45991b revision: 5cafa6f3019b57c43312a75e7d7d58aeb032f1bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:51.385537) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:51.386349) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:51.386634) ========= 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=0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006370 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:51.411759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:51.412055) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:51.484143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:51.484426) ========= 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=0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:51.552793) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:51.553077) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:51.553409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:51.553681) ========= 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=0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 04:30:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2016-03-01 04:30:51 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172022 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:51.743078) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:51.743389) ========= 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=0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014153 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:51.792375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:51.792680) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5cafa6f3019b57c43312a75e7d7d58aeb032f1bc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5cafa6f3019b57c43312a75e7d7d58aeb032f1bc --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=0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 04:30:51,963 truncating revision to first 12 chars 2016-03-01 04:30:51,963 Setting DEBUG logging. 2016-03-01 04:30:51,963 attempt 1/10 2016-03-01 04:30:51,964 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5cafa6f3019b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 04:30:52,206 unpacking tar archive at: mozilla-central-5cafa6f3019b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.552878 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:52.358548) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:52.358909) ========= echo 5cafa6f3019b57c43312a75e7d7d58aeb032f1bc in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5cafa6f3019b57c43312a75e7d7d58aeb032f1bc'] 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=0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5cafa6f3019b57c43312a75e7d7d58aeb032f1bc program finished with exit code 0 elapsedTime=0.003512 script_repo_revision: '5cafa6f3019b57c43312a75e7d7d58aeb032f1bc' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:52.406695) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:52.407036) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:52.416654) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-03-01 04:30:52.417016) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:30:52 INFO - MultiFileLogger online at 20160301 04:30:52 in /builds/slave/test 04:30:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:30:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:52 INFO - {'append_to_log': False, 04:30:52 INFO - 'base_work_dir': '/builds/slave/test', 04:30:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:30:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:52 INFO - 'branch': 'Firefox-Non-PGO', 04:30:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:52 INFO - 'config_files': ('talos/linux_config.py',), 04:30:52 INFO - 'default_actions': ('clobber', 04:30:52 INFO - 'read-buildbot-config', 04:30:52 INFO - 'download-and-extract', 04:30:52 INFO - 'populate-webroot', 04:30:52 INFO - 'create-virtualenv', 04:30:52 INFO - 'install', 04:30:52 INFO - 'run-tests'), 04:30:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:52 INFO - 'download_minidump_stackwalk': True, 04:30:52 INFO - 'download_symbols': 'ondemand', 04:30:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:52 INFO - 'installer_path': 'installer.exe', 04:30:52 INFO - 'log_level': 'info', 04:30:52 INFO - 'log_name': 'talos', 04:30:52 INFO - 'log_to_console': True, 04:30:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:30:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:30:52 INFO - 'opt_config_files': (), 04:30:52 INFO - 'pip_index': False, 04:30:52 INFO - 'sps_profile': False, 04:30:52 INFO - 'sps_profile_interval': 0, 04:30:52 INFO - 'suite': 'dromaeojs-e10s', 04:30:52 INFO - 'system_bits': '32', 04:30:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:52 INFO - 'title': 'talos-linux64-ix-058', 04:30:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:52 INFO - 'use_talos_json': True, 04:30:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:52 INFO - 'work_dir': 'build'} 04:30:52 INFO - ##### 04:30:52 INFO - ##### Running clobber step. 04:30:52 INFO - ##### 04:30:52 INFO - Running pre-action listener: _resource_record_pre_action 04:30:52 INFO - Running main action method: clobber 04:30:52 INFO - rmtree: /builds/slave/test/build 04:30:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:53 INFO - Running post-action listener: _resource_record_post_action 04:30:53 INFO - ##### 04:30:53 INFO - ##### Running read-buildbot-config step. 04:30:53 INFO - ##### 04:30:53 INFO - Running pre-action listener: _resource_record_pre_action 04:30:53 INFO - Running main action method: read_buildbot_config 04:30:53 INFO - Using buildbot properties: 04:30:53 INFO - { 04:30:53 INFO - "project": "", 04:30:53 INFO - "product": "firefox", 04:30:53 INFO - "script_repo_revision": "production", 04:30:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:30:53 INFO - "repository": "", 04:30:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:30:53 INFO - "buildid": "20160301030244", 04:30:53 INFO - "pgo_build": "False", 04:30:53 INFO - "basedir": "/builds/slave/test", 04:30:53 INFO - "buildnumber": 213, 04:30:53 INFO - "slavename": "talos-linux64-ix-058", 04:30:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:30:53 INFO - "platform": "ubuntu64_hw", 04:30:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:30:53 INFO - "branch": "mozilla-central", 04:30:53 INFO - "repo_path": "mozilla-central", 04:30:53 INFO - "revision": "5cafa6f3019b57c43312a75e7d7d58aeb032f1bc", 04:30:53 INFO - "stage_platform": "linux64", 04:30:53 INFO - "builduid": "9cd00d0abf224634995088b64d45991b", 04:30:53 INFO - "slavebuilddir": "test" 04:30:53 INFO - } 04:30:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 04:30:53 INFO - Running post-action listener: _resource_record_post_action 04:30:53 INFO - ##### 04:30:53 INFO - ##### Running download-and-extract step. 04:30:53 INFO - ##### 04:30:53 INFO - Running pre-action listener: _resource_record_pre_action 04:30:53 INFO - Running main action method: download_and_extract 04:30:53 INFO - mkdir: /builds/slave/test/build/tests 04:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:53 INFO - https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:30:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 04:30:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 04:30:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/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 04:30:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/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 04:30:54 INFO - Downloaded 1448 bytes. 04:30:54 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 04:30:54 INFO - Using the following test package requirements: 04:30:54 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:54 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:30:54 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:30:54 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:54 INFO - u'jsshell-linux-x86_64.zip'], 04:30:54 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:30:54 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:54 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:30:54 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:30:54 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:30:54 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:54 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:30:54 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:30: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')]} 04:30:54 INFO - https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:30:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:30:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:30:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/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 04:30:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/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 04:30:55 INFO - Downloaded 22077321 bytes. 04:30:55 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'] 04:30:55 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 04:30:56 INFO - Return code: 0 04:30:56 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 04:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:56 INFO - https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:30:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:30:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:30:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/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 04:30:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/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 04:31:11 INFO - Downloaded 22077321 bytes. 04:31:11 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'] 04:31:11 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 04:31:12 INFO - Return code: 0 04:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:12 INFO - https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:31:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/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 04:31:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/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 04:31:13 INFO - Downloaded 10713413 bytes. 04:31:13 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'] 04:31:13 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 04:31:13 INFO - Return code: 0 04:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:13 INFO - https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:31:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:31:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:31:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/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 04:31:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/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 04:31:18 INFO - Downloaded 54835213 bytes. 04:31:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:31:18 INFO - mkdir: /builds/slave/test/properties 04:31:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:18 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:18 INFO - Contents: 04:31:18 INFO - build_url:https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:31:18 INFO - Running post-action listener: _resource_record_post_action 04:31:18 INFO - Running post-action listener: set_extra_try_arguments 04:31:18 INFO - ##### 04:31:18 INFO - ##### Running populate-webroot step. 04:31:18 INFO - ##### 04:31:18 INFO - Running pre-action listener: _resource_record_pre_action 04:31:18 INFO - Running main action method: populate_webroot 04:31:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:18 INFO - '--tppagecycles', 04:31:18 INFO - '7'], 04:31:18 INFO - 'tests': ['tsvgm']}}, 04:31:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:31:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:31:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:31:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:31:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:18 INFO - 'talos_options': ['--e10s'], 04:31:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:18 INFO - 'tests': ['damp', 'tps']}, 04:31:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:18 INFO - 'talos_options': ['--e10s'], 04:31:18 INFO - 'tests': ['damp', 'tps']}, 04:31:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:31:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:18 INFO - 'other': {'tests': ['a11yr', 04:31:18 INFO - 'ts_paint', 04:31:18 INFO - 'tpaint', 04:31:18 INFO - 'sessionrestore', 04:31:18 INFO - 'sessionrestore_no_auto_restore']}, 04:31:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:31:18 INFO - 'tests': ['a11yr', 04:31:18 INFO - 'ts_paint', 04:31:18 INFO - 'tpaint', 04:31:18 INFO - 'sessionrestore', 04:31:18 INFO - 'sessionrestore_no_auto_restore']}, 04:31:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:31:18 INFO - 'tests': ['a11yr', 04:31:18 INFO - 'ts_paint', 04:31:18 INFO - 'tpaint', 04:31:18 INFO - 'sessionrestore', 04:31:18 INFO - 'sessionrestore_no_auto_restore']}, 04:31:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:31:18 INFO - 'tests': ['a11yr', 04:31:18 INFO - 'ts_paint', 04:31:18 INFO - 'tpaint', 04:31:18 INFO - 'sessionrestore', 04:31:18 INFO - 'sessionrestore_no_auto_restore']}, 04:31:18 INFO - 'other_l64': {'tests': ['a11yr', 04:31:18 INFO - 'ts_paint', 04:31:18 INFO - 'tpaint', 04:31:18 INFO - 'sessionrestore', 04:31:18 INFO - 'sessionrestore_no_auto_restore']}, 04:31:18 INFO - 'other_nol64': {'tests': ['a11yr', 04:31:18 INFO - 'ts_paint', 04:31:18 INFO - 'tpaint', 04:31:18 INFO - 'sessionrestore', 04:31:18 INFO - 'sessionrestore_no_auto_restore']}, 04:31:18 INFO - 'svgr': {'tests': ['tsvgx', 04:31:18 INFO - 'tsvgr_opacity', 04:31:18 INFO - 'tart', 04:31:18 INFO - 'tscrollx', 04:31:18 INFO - 'cart']}, 04:31:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:31:18 INFO - 'tests': ['tsvgx', 04:31:18 INFO - 'tsvgr_opacity', 04:31:18 INFO - 'tart', 04:31:18 INFO - 'tscrollx', 04:31:18 INFO - 'cart']}, 04:31:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:18 INFO - 'tests': ['tp5o']}, 04:31:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:18 INFO - 'talos_options': ['--e10s'], 04:31:18 INFO - 'tests': ['tp5o']}, 04:31:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:18 INFO - 'talos_options': ['--xperf_path', 04:31:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:18 INFO - 'tests': ['tp5n']}, 04:31:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:18 INFO - 'talos_options': ['--e10s', 04:31:18 INFO - '--xperf_path', 04:31:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:18 INFO - 'tests': ['tp5n']}}, 04:31:18 INFO - 'talos.zip': {'path': '', 04:31:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:18 INFO - Running post-action listener: _resource_record_post_action 04:31:18 INFO - ##### 04:31:18 INFO - ##### Running create-virtualenv step. 04:31:18 INFO - ##### 04:31:18 INFO - Running pre-action listener: _resource_record_pre_action 04:31:18 INFO - Running main action method: create_virtualenv 04:31:18 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:18 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 04:31:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:18 INFO - Using real prefix '/usr' 04:31:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:19 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:21 INFO - Installing pip.................done. 04:31:21 INFO - Return code: 0 04:31:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb519288f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd100>, '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 0x1efe000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efe490>, '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': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', '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 04:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:31:21 INFO - Using env: {'DISPLAY': ':0', 04:31:21 INFO - 'HOME': '/home/cltbld', 04:31:21 INFO - 'LANG': 'en_US.UTF-8', 04:31:21 INFO - 'LANGUAGE': 'en_US:en', 04:31:21 INFO - 'LOGNAME': 'cltbld', 04:31:21 INFO - 'MAIL': '/var/mail/cltbld', 04:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:21 INFO - 'MOZ_NO_REMOTE': '1', 04:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:21 INFO - 'NO_EM_RESTART': '1', 04:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:21 INFO - 'PWD': '/builds/slave/test', 04:31:21 INFO - 'SHELL': '/bin/bash', 04:31:21 INFO - 'SHLVL': '1', 04:31:21 INFO - 'TERM': 'linux', 04:31:21 INFO - 'TMOUT': '86400', 04:31:21 INFO - 'USER': 'cltbld', 04:31:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', 04:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:21 INFO - '_': '/tools/buildbot/bin/python'} 04:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:21 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 04:31:21 INFO - Cleaning up... 04:31:21 INFO - Return code: 0 04:31:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb519288f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd100>, '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 0x1efe000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efe490>, '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': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', '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 04:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:31:21 INFO - Using env: {'DISPLAY': ':0', 04:31:21 INFO - 'HOME': '/home/cltbld', 04:31:21 INFO - 'LANG': 'en_US.UTF-8', 04:31:21 INFO - 'LANGUAGE': 'en_US:en', 04:31:21 INFO - 'LOGNAME': 'cltbld', 04:31:21 INFO - 'MAIL': '/var/mail/cltbld', 04:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:21 INFO - 'MOZ_NO_REMOTE': '1', 04:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:21 INFO - 'NO_EM_RESTART': '1', 04:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:21 INFO - 'PWD': '/builds/slave/test', 04:31:21 INFO - 'SHELL': '/bin/bash', 04:31:21 INFO - 'SHLVL': '1', 04:31:21 INFO - 'TERM': 'linux', 04:31:21 INFO - 'TMOUT': '86400', 04:31:21 INFO - 'USER': 'cltbld', 04:31:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', 04:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:21 INFO - '_': '/tools/buildbot/bin/python'} 04:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:21 INFO - Downloading/unpacking psutil>=0.7.1 04:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:23 INFO - Installing collected packages: psutil 04:31:23 INFO - Running setup.py install for psutil 04:31:23 INFO - building 'psutil._psutil_linux' extension 04:31:23 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 04:31:24 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 04:31:24 INFO - building 'psutil._psutil_posix' extension 04:31:24 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 04:31:24 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 04:31:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:24 INFO - Successfully installed psutil 04:31:24 INFO - Cleaning up... 04:31:24 INFO - Return code: 0 04:31:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb519288f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd100>, '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 0x1efe000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efe490>, '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': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', '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 04:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:31:24 INFO - Using env: {'DISPLAY': ':0', 04:31:24 INFO - 'HOME': '/home/cltbld', 04:31:24 INFO - 'LANG': 'en_US.UTF-8', 04:31:24 INFO - 'LANGUAGE': 'en_US:en', 04:31:24 INFO - 'LOGNAME': 'cltbld', 04:31:24 INFO - 'MAIL': '/var/mail/cltbld', 04:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:24 INFO - 'MOZ_NO_REMOTE': '1', 04:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:24 INFO - 'NO_EM_RESTART': '1', 04:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:24 INFO - 'PWD': '/builds/slave/test', 04:31:24 INFO - 'SHELL': '/bin/bash', 04:31:24 INFO - 'SHLVL': '1', 04:31:24 INFO - 'TERM': 'linux', 04:31:24 INFO - 'TMOUT': '86400', 04:31:24 INFO - 'USER': 'cltbld', 04:31:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', 04:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:24 INFO - '_': '/tools/buildbot/bin/python'} 04:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:31:26 INFO - Installing collected packages: mozsystemmonitor 04:31:26 INFO - Running setup.py install for mozsystemmonitor 04:31:26 INFO - Successfully installed mozsystemmonitor 04:31:26 INFO - Cleaning up... 04:31:26 INFO - Return code: 0 04:31:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:26 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 0x7fb519288f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd100>, '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 0x1efe000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efe490>, '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': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', '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 04:31:26 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 04:31:26 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 04:31:26 INFO - Using env: {'DISPLAY': ':0', 04:31:26 INFO - 'HOME': '/home/cltbld', 04:31:26 INFO - 'LANG': 'en_US.UTF-8', 04:31:26 INFO - 'LANGUAGE': 'en_US:en', 04:31:26 INFO - 'LOGNAME': 'cltbld', 04:31:26 INFO - 'MAIL': '/var/mail/cltbld', 04:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:26 INFO - 'MOZ_NO_REMOTE': '1', 04:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:26 INFO - 'NO_EM_RESTART': '1', 04:31:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:26 INFO - 'PWD': '/builds/slave/test', 04:31:26 INFO - 'SHELL': '/bin/bash', 04:31:26 INFO - 'SHLVL': '1', 04:31:26 INFO - 'TERM': 'linux', 04:31:26 INFO - 'TMOUT': '86400', 04:31:26 INFO - 'USER': 'cltbld', 04:31:26 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', 04:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:26 INFO - '_': '/tools/buildbot/bin/python'} 04:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:26 INFO - Downloading/unpacking blobuploader==1.2.4 04:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:28 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:28 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 04:31:28 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 04:31:28 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 04:31:28 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 04:31:28 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 04:31:28 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 04:31:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:29 INFO - Downloading docopt-0.6.1.tar.gz 04:31:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:29 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:29 INFO - Running setup.py install for blobuploader 04:31:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:29 INFO - Running setup.py install for requests 04:31:29 INFO - Running setup.py install for docopt 04:31:30 INFO - Successfully installed blobuploader requests docopt 04:31:30 INFO - Cleaning up... 04:31:30 INFO - Return code: 0 04:31:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:30 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 0x7fb519288f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd100>, '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 0x1efe000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efe490>, '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': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', '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 04:31:30 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 04:31:30 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 04:31:30 INFO - Using env: {'DISPLAY': ':0', 04:31:30 INFO - 'HOME': '/home/cltbld', 04:31:30 INFO - 'LANG': 'en_US.UTF-8', 04:31:30 INFO - 'LANGUAGE': 'en_US:en', 04:31:30 INFO - 'LOGNAME': 'cltbld', 04:31:30 INFO - 'MAIL': '/var/mail/cltbld', 04:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:30 INFO - 'MOZ_NO_REMOTE': '1', 04:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:30 INFO - 'NO_EM_RESTART': '1', 04:31:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:30 INFO - 'PWD': '/builds/slave/test', 04:31:30 INFO - 'SHELL': '/bin/bash', 04:31:30 INFO - 'SHLVL': '1', 04:31:30 INFO - 'TERM': 'linux', 04:31:30 INFO - 'TMOUT': '86400', 04:31:30 INFO - 'USER': 'cltbld', 04:31:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', 04:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:30 INFO - '_': '/tools/buildbot/bin/python'} 04:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:30 INFO - Running setup.py (path:/tmp/pip-Z0y26Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:30 INFO - Running setup.py (path:/tmp/pip-EvDrrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:30 INFO - Running setup.py (path:/tmp/pip-_XQxlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:30 INFO - Running setup.py (path:/tmp/pip-rwPEXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:30 INFO - Running setup.py (path:/tmp/pip-MiCbQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:30 INFO - Running setup.py (path:/tmp/pip-733SLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:30 INFO - Running setup.py (path:/tmp/pip-18JLX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:30 INFO - Running setup.py (path:/tmp/pip-ZyVxK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:30 INFO - Running setup.py (path:/tmp/pip-psyYah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:30 INFO - Running setup.py (path:/tmp/pip-2ISwEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:31 INFO - Running setup.py (path:/tmp/pip-YYRBXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:31 INFO - Running setup.py (path:/tmp/pip-nShH4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:31 INFO - Running setup.py (path:/tmp/pip-N5Ktqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:31 INFO - Running setup.py (path:/tmp/pip-1_J5K0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:31 INFO - Running setup.py (path:/tmp/pip-0Mqups-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:31 INFO - Running setup.py (path:/tmp/pip-ikaGyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:31 INFO - Running setup.py (path:/tmp/pip-8iLko_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:31 INFO - Running setup.py install for manifestparser 04:31:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:31 INFO - Running setup.py install for mozcrash 04:31:31 INFO - Running setup.py install for mozdebug 04:31:31 INFO - Running setup.py install for mozdevice 04:31:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:31:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:31 INFO - Running setup.py install for mozfile 04:31:32 INFO - Running setup.py install for mozhttpd 04:31:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:32 INFO - Running setup.py install for mozinfo 04:31:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:32 INFO - Running setup.py install for mozInstall 04:31:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:32 INFO - Running setup.py install for mozleak 04:31:32 INFO - Running setup.py install for mozlog 04:31:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:32 INFO - Running setup.py install for moznetwork 04:31:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:32 INFO - Running setup.py install for mozprocess 04:31:32 INFO - Running setup.py install for mozprofile 04:31:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:32 INFO - Running setup.py install for mozrunner 04:31:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:33 INFO - Running setup.py install for mozscreenshot 04:31:33 INFO - Running setup.py install for moztest 04:31:33 INFO - Running setup.py install for mozversion 04:31:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:33 INFO - Cleaning up... 04:31:33 INFO - Return code: 0 04:31:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:33 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 0x7fb519288f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd100>, '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 0x1efe000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efe490>, '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': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', '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 04:31:33 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 04:31:33 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 04:31:33 INFO - Using env: {'DISPLAY': ':0', 04:31:33 INFO - 'HOME': '/home/cltbld', 04:31:33 INFO - 'LANG': 'en_US.UTF-8', 04:31:33 INFO - 'LANGUAGE': 'en_US:en', 04:31:33 INFO - 'LOGNAME': 'cltbld', 04:31:33 INFO - 'MAIL': '/var/mail/cltbld', 04:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:33 INFO - 'MOZ_NO_REMOTE': '1', 04:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:33 INFO - 'NO_EM_RESTART': '1', 04:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:33 INFO - 'PWD': '/builds/slave/test', 04:31:33 INFO - 'SHELL': '/bin/bash', 04:31:33 INFO - 'SHLVL': '1', 04:31:33 INFO - 'TERM': 'linux', 04:31:33 INFO - 'TMOUT': '86400', 04:31:33 INFO - 'USER': 'cltbld', 04:31:33 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', 04:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:33 INFO - '_': '/tools/buildbot/bin/python'} 04:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:33 INFO - Running setup.py (path:/tmp/pip-OeCYIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:33 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)) 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:33 INFO - Running setup.py (path:/tmp/pip-sPHVV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:33 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)) 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:33 INFO - Running setup.py (path:/tmp/pip-8Muu__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:33 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)) 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:33 INFO - Running setup.py (path:/tmp/pip-jzK0wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:33 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)) 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:33 INFO - Running setup.py (path:/tmp/pip-YRO797-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:33 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)) 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:33 INFO - Running setup.py (path:/tmp/pip-eeN8w0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:33 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)) 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:33 INFO - Running setup.py (path:/tmp/pip-BA15aT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:34 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)) 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:34 INFO - Running setup.py (path:/tmp/pip-qiawgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:34 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)) 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:34 INFO - Running setup.py (path:/tmp/pip-3HDZCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:34 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)) 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:34 INFO - Running setup.py (path:/tmp/pip-7mh8cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:34 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)) 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:34 INFO - Running setup.py (path:/tmp/pip-ZBq4Qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:34 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)) 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:34 INFO - Running setup.py (path:/tmp/pip-vDuwpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:34 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)) 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:34 INFO - Running setup.py (path:/tmp/pip-K1NBf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:34 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)) 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:34 INFO - Running setup.py (path:/tmp/pip-tM2N0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:34 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)) 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:34 INFO - Running setup.py (path:/tmp/pip-DD1Yk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:34 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)) 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:34 INFO - Running setup.py (path:/tmp/pip-nKzyf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:34 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)) 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:34 INFO - Running setup.py (path:/tmp/pip-Ox4fTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:34 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)) 04:31:34 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)) 04:31:34 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)) 04:31:34 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)) 04:31:34 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)) 04:31:34 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)) 04:31:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:36 INFO - Downloading blessings-1.6.tar.gz 04:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:36 INFO - Installing collected packages: blessings 04:31:36 INFO - Running setup.py install for blessings 04:31:36 INFO - Successfully installed blessings 04:31:36 INFO - Cleaning up... 04:31:36 INFO - Return code: 0 04:31:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:37 INFO - Reading from file tmpfile_stdout 04:31:37 INFO - Current package versions: 04:31:37 INFO - argparse == 1.2.1 04:31:37 INFO - blessings == 1.6 04:31:37 INFO - blobuploader == 1.2.4 04:31:37 INFO - docopt == 0.6.1 04:31:37 INFO - manifestparser == 1.1 04:31:37 INFO - mozInstall == 1.12 04:31:37 INFO - mozcrash == 0.16 04:31:37 INFO - mozdebug == 0.1 04:31:37 INFO - mozdevice == 0.48 04:31:37 INFO - mozfile == 1.2 04:31:37 INFO - mozhttpd == 0.7 04:31:37 INFO - mozinfo == 0.9 04:31:37 INFO - mozleak == 0.1 04:31:37 INFO - mozlog == 3.1 04:31:37 INFO - moznetwork == 0.27 04:31:37 INFO - mozprocess == 0.22 04:31:37 INFO - mozprofile == 0.28 04:31:37 INFO - mozrunner == 6.11 04:31:37 INFO - mozscreenshot == 0.1 04:31:37 INFO - mozsystemmonitor == 0.0 04:31:37 INFO - moztest == 0.7 04:31:37 INFO - mozversion == 1.4 04:31:37 INFO - psutil == 3.1.1 04:31:37 INFO - requests == 1.2.3 04:31:37 INFO - wsgiref == 0.1.2 04:31:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:37 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 0x7fb519288f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd100>, '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 0x1efe000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efe490>, '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': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', '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 04:31:37 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 04:31:37 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 04:31:37 INFO - Using env: {'DISPLAY': ':0', 04:31:37 INFO - 'HOME': '/home/cltbld', 04:31:37 INFO - 'LANG': 'en_US.UTF-8', 04:31:37 INFO - 'LANGUAGE': 'en_US:en', 04:31:37 INFO - 'LOGNAME': 'cltbld', 04:31:37 INFO - 'MAIL': '/var/mail/cltbld', 04:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:37 INFO - 'MOZ_NO_REMOTE': '1', 04:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:37 INFO - 'NO_EM_RESTART': '1', 04:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:37 INFO - 'PWD': '/builds/slave/test', 04:31:37 INFO - 'SHELL': '/bin/bash', 04:31:37 INFO - 'SHLVL': '1', 04:31:37 INFO - 'TERM': 'linux', 04:31:37 INFO - 'TMOUT': '86400', 04:31:37 INFO - 'USER': 'cltbld', 04:31:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', 04:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:37 INFO - '_': '/tools/buildbot/bin/python'} 04:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:37 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)) 04:31:37 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)) 04:31:37 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)) 04:31:37 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)) 04:31:37 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)) 04:31:37 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)) 04:31:37 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)) 04:31:37 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)) 04:31:37 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)) 04:31:37 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)) 04:31:37 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)) 04:31:37 INFO - Cleaning up... 04:31:37 INFO - Return code: 0 04:31:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb519288f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd100>, '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 0x1efe000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efe490>, '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': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', '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 04:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:31:37 INFO - Using env: {'DISPLAY': ':0', 04:31:37 INFO - 'HOME': '/home/cltbld', 04:31:37 INFO - 'LANG': 'en_US.UTF-8', 04:31:37 INFO - 'LANGUAGE': 'en_US:en', 04:31:37 INFO - 'LOGNAME': 'cltbld', 04:31:37 INFO - 'MAIL': '/var/mail/cltbld', 04:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:37 INFO - 'MOZ_NO_REMOTE': '1', 04:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:37 INFO - 'NO_EM_RESTART': '1', 04:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:37 INFO - 'PWD': '/builds/slave/test', 04:31:37 INFO - 'SHELL': '/bin/bash', 04:31:37 INFO - 'SHLVL': '1', 04:31:37 INFO - 'TERM': 'linux', 04:31:37 INFO - 'TMOUT': '86400', 04:31:37 INFO - 'USER': 'cltbld', 04:31:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', 04:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:37 INFO - '_': '/tools/buildbot/bin/python'} 04:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:37 INFO - Downloading/unpacking jsonschema 04:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:39 INFO - Downloading/unpacking functools32 (from jsonschema) 04:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:39 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:39 INFO - warning: no files found matching '*.txt' 04:31:39 INFO - no previously-included directories found matching 'build' 04:31:39 INFO - no previously-included directories found matching 'dist' 04:31:39 INFO - no previously-included directories found matching '.git*' 04:31:39 INFO - Installing collected packages: jsonschema, functools32 04:31:39 INFO - Running setup.py install for functools32 04:31:39 INFO - warning: no files found matching '*.txt' 04:31:39 INFO - no previously-included directories found matching 'build' 04:31:39 INFO - no previously-included directories found matching 'dist' 04:31:39 INFO - no previously-included directories found matching '.git*' 04:31:39 INFO - Successfully installed jsonschema functools32 04:31:39 INFO - Cleaning up... 04:31:39 INFO - Return code: 0 04:31:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb519288f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd100>, '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 0x1efe000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efe490>, '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': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', '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 04:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:31:39 INFO - Using env: {'DISPLAY': ':0', 04:31:39 INFO - 'HOME': '/home/cltbld', 04:31:39 INFO - 'LANG': 'en_US.UTF-8', 04:31:39 INFO - 'LANGUAGE': 'en_US:en', 04:31:39 INFO - 'LOGNAME': 'cltbld', 04:31:39 INFO - 'MAIL': '/var/mail/cltbld', 04:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:39 INFO - 'MOZ_NO_REMOTE': '1', 04:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:39 INFO - 'NO_EM_RESTART': '1', 04:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:39 INFO - 'PWD': '/builds/slave/test', 04:31:39 INFO - 'SHELL': '/bin/bash', 04:31:39 INFO - 'SHLVL': '1', 04:31:39 INFO - 'TERM': 'linux', 04:31:39 INFO - 'TMOUT': '86400', 04:31:39 INFO - 'USER': 'cltbld', 04:31:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', 04:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:39 INFO - '_': '/tools/buildbot/bin/python'} 04:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:40 INFO - Downloading/unpacking flake8 04:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:31:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:31:41 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 04:31:41 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 04:31:41 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 04:31:41 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 04:31:41 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 04:31:41 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 04:31:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:31:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:31:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:42 INFO - no previously-included directories found matching 'docs/_build' 04:31:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:31:42 INFO - Running setup.py install for pep8 04:31:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:42 INFO - no previously-included directories found matching 'docs/_build' 04:31:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:31:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:31:42 INFO - Cleaning up... 04:31:42 INFO - Return code: 0 04:31:42 INFO - Running post-action listener: _resource_record_post_action 04:31:42 INFO - Running post-action listener: _start_resource_monitoring 04:31:42 INFO - Starting resource monitoring. 04:31:42 INFO - ##### 04:31:42 INFO - ##### Running install step. 04:31:42 INFO - ##### 04:31:42 INFO - Running pre-action listener: _resource_record_pre_action 04:31:42 INFO - Running main action method: install 04:31:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:43 INFO - Reading from file tmpfile_stdout 04:31:43 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:43 INFO - Reading from file tmpfile_stdout 04:31:43 INFO - Output received: 04:31:43 INFO - Usage: mozinstall [options] installer 04:31:43 INFO - Options: 04:31:43 INFO - -h, --help show this help message and exit 04:31:43 INFO - -d DEST, --destination=DEST 04:31:43 INFO - Directory to install application into. [default: 04:31:43 INFO - "/builds/slave/test"] 04:31:43 INFO - --app=APP Application being installed. [default: firefox] 04:31:43 INFO - mkdir: /builds/slave/test/build/application 04:31:43 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'] 04:31:43 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 04:31:58 INFO - Reading from file tmpfile_stdout 04:31:58 INFO - Output received: 04:31:58 INFO - /builds/slave/test/build/application/firefox/firefox 04:31:58 INFO - Running post-action listener: _resource_record_post_action 04:31:58 INFO - ##### 04:31:58 INFO - ##### Running run-tests step. 04:31:58 INFO - ##### 04:31:58 INFO - Running pre-action listener: _resource_record_pre_action 04:31:58 INFO - Running main action method: run_tests 04:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:59 INFO - Python 2.7.3 04:31:59 INFO - Return code: 0 04:31:59 INFO - grabbing minidump binary from tooltool 04:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:59 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 0x1efd100>, '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 0x1efe000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efe490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31:59 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 04:31:59 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 04:31:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:59 INFO - Return code: 0 04:31:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:31:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:31:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:32:00 INFO - Return code: 0 04:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 04:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 04:32:00 INFO - Using env: {'DISPLAY': ':0', 04:32:00 INFO - 'HOME': '/home/cltbld', 04:32:00 INFO - 'LANG': 'en_US.UTF-8', 04:32:00 INFO - 'LANGUAGE': 'en_US:en', 04:32:00 INFO - 'LOGNAME': 'cltbld', 04:32:00 INFO - 'MAIL': '/var/mail/cltbld', 04:32:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:00 INFO - 'MOZ_NO_REMOTE': '1', 04:32:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:00 INFO - 'NO_EM_RESTART': '1', 04:32:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:00 INFO - 'PWD': '/builds/slave/test', 04:32:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:00 INFO - 'SHELL': '/bin/bash', 04:32:00 INFO - 'SHLVL': '1', 04:32:00 INFO - 'TERM': 'linux', 04:32:00 INFO - 'TMOUT': '86400', 04:32:00 INFO - 'USER': 'cltbld', 04:32:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545', 04:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:00 INFO - '_': '/tools/buildbot/bin/python'} 04:32:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 04:32:00 INFO - mozversion application_buildid: 20160301030244 04:32:00 INFO - mozversion application_changeset: 5cafa6f3019b57c43312a75e7d7d58aeb032f1bc 04:32:00 INFO - mozversion application_display_name: Nightly 04:32:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:00 INFO - mozversion application_name: Firefox 04:32:00 INFO - mozversion application_remotingname: firefox 04:32:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:32:00 INFO - mozversion application_vendor: Mozilla 04:32:00 INFO - mozversion application_version: 47.0a1 04:32:00 INFO - mozversion platform_buildid: 20160301030244 04:32:00 INFO - mozversion platform_changeset: 5cafa6f3019b57c43312a75e7d7d58aeb032f1bc 04:32:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:32:00 INFO - mozversion platform_version: 47.0a1 04:32:00 INFO - using testdate: 1456835520 04:32:00 INFO - actual date: 1456835520 04:32:00 INFO - starting webserver on 'localhost:38618' 04:32:00 INFO - SUITE-START | Running 2 tests 04:32:00 INFO - TEST-START | dromaeo_css 04:32:00 INFO - operating with platform_type : linux_ 04:32:00 INFO - Initialising browser for dromaeo_css test... 04:32:00 INFO - TEST-INFO | started process 15806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx0oxCt/profile http://localhost:38618/getInfo.html) 04:32:04 INFO - PROCESS | 15806 | 04:32:04 INFO - PROCESS | 15806 | (process:15887): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:32:05 INFO - PROCESS | 15806 | __metrics Screen width/height:1600/1200 04:32:05 INFO - PROCESS | 15806 | colorDepth:24 04:32:05 INFO - PROCESS | 15806 | Browser inner width/height: 1024/697 04:32:05 INFO - PROCESS | 15806 | __metrics 04:32:05 ERROR - PROCESS | 15806 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:32:05 INFO - PROCESS | 15806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:32:05 INFO - PROCESS | 15806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:32:05 INFO - PROCESS | 15806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:32:05 INFO - PROCESS | 15806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:32:05 INFO - PROCESS | 15806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:32:05 INFO - PROCESS | 15806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:32:05 INFO - PROCESS | 15806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:32:05 INFO - PROCESS | 15806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:32:05 INFO - PROCESS | 15806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:32:06 INFO - TEST-INFO | 15806: exit 0 04:32:06 INFO - Browser initialized. 04:32:06 INFO - Running cycle 1/1 for dromaeo_css test... 04:32:06 INFO - TEST-INFO | started process 15938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx0oxCt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:08 INFO - PROCESS | 15938 | 04:32:08 INFO - PROCESS | 15938 | (process:15996): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:32:18 INFO - PROCESS | 15938 | RSS: Main: 161001472 04:32:18 INFO - PROCESS | 15938 | 04:33:08 INFO - PROCESS | 15938 | 1456835588170 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] 04:35:19 INFO - PROCESS | 15938 | Cycle 1(1): loaded http://localhost:38618/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38618/tests/dromaeo/cssquery-ext.html) 04:35:20 INFO - PROCESS | 15938 | RSS: Main: 169926656 04:35:20 INFO - PROCESS | 15938 | 04:38:22 INFO - PROCESS | 15938 | Cycle 1(1): loaded http://localhost:38618/tests/dromaeo/cssquery-ext.html (next: http://localhost:38618/tests/dromaeo/cssquery-jquery.html) 04:38:23 INFO - PROCESS | 15938 | RSS: Main: 166027264 04:38:23 INFO - PROCESS | 15938 | 04:41:25 INFO - PROCESS | 15938 | Cycle 1(1): loaded http://localhost:38618/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38618/tests/dromaeo/cssquery-mootools.html) 04:41:25 INFO - PROCESS | 15938 | RSS: Main: 166129664 04:41:25 INFO - PROCESS | 15938 | 04:44:27 INFO - PROCESS | 15938 | Cycle 1(1): loaded http://localhost:38618/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38618/tests/dromaeo/cssquery-prototype.html) 04:44:28 INFO - PROCESS | 15938 | RSS: Main: 164151296 04:44:28 INFO - PROCESS | 15938 | 04:47:30 INFO - PROCESS | 15938 | Cycle 1(1): loaded http://localhost:38618/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38618/tests/dromaeo/cssquery-yui.html) 04:47:31 INFO - PROCESS | 15938 | RSS: Main: 164065280 04:47:31 INFO - PROCESS | 15938 | 04:50:33 INFO - PROCESS | 15938 | Cycle 1(1): loaded http://localhost:38618/tests/dromaeo/cssquery-yui.html (next: http://localhost:38618/tests/dromaeo/cssquery-dojo.html) 04:50:34 INFO - PROCESS | 15938 | RSS: Main: 168378368 04:50:34 INFO - PROCESS | 15938 | 04:50:34 INFO - PROCESS | 15938 | __start_tp_report 04:50:34 INFO - PROCESS | 15938 | _x_x_mozilla_page_load 04:50:34 INFO - PROCESS | 15938 | _x_x_mozilla_page_load_details 04:50:34 INFO - PROCESS | 15938 | |i|pagename|runs| 04:50:34 INFO - PROCESS | 15938 | |0;dojo.html;2651.456451427457;2682.7585517303437;2712.4575084983007;2722.714115017923;2729.8225615335;4431.202383570956;4530.614897733688;4591.839285624999;4614.8846278843;4634.745089020103;4514.210013247685;4522.592966633002;4543.318502224668;4557.680962332638;4624.791884365203;4189.9790501047455;4194.0982688721915;4211.8525851595205;4366.803493842769;4371.890702732441;4100.077482566428;4165.729227600196;4277.14457108578;4292.720973136752;4326.58897404746;4196.3705444183315;4214.515330736974;4228;4238.364245363205;4254.489461264668;4220.978895105535;4223.87328380146;4227.936580951288;4251.91496170078;4268.9146217075795;4051.1897620476025;4181.414601955728;4211.989122610551;4289.420928174688;4289.892752681177;4528.1622899763315;4534.546545345472;4555.08898220354;4566.49768525462;4617.607503362218;4879.682820616648;4903.092927808367;4908.410990681141;4917.213245880677;4963.975180124076;4765.142274390609;4849.83025594106;4904.975475122637;4932.753362331869;4947.356843610343;4499.235130027903;4499.910001799978;4504.81980720774;4506.752128632957;4534.77326133692;4842.951570484321;4945.208766597327;4945.530174633404;4955.603551715854;4991.126552853309;4801.807927682923;4829.541193586604;4837.250226214942;4861.1006963711825;4884;4794.976025119852;4810.278458231223;4862.586680132228;4876.878078048077;4947;4611.700239484423;4794.760261986887;4804.615630749532;4804.735739534359;4850.466448690641;4645.233536466513;4654.092451971833;4655.44134703831;4656.930146047812;4662.53374662531;3979;3996.080901392696;4034.1931613676793;4035.1727895781296;4067.776272305052;3532.116970757311;3544.3442963051402;3545.4681797730545;3561.857525698995;3573.8391772370305;4135.710500264952;4233.216854881856;4241.85469923119;4275.893102672458;4277.679174061957;4891.559759621651;4924.778384972685;4929.507049295042;4945.579625731782;4969.875753106201;4242.490901091889;4243.193793179286;4253.3194688849635;4305.612494875476;4312.288472402081;4265.3815196796295;4289.463817022872;4341.587549182823;4345.608895199447;4354.368616550646;4596.632269418438;4599.6550258731395;4606.101810147056;4645.465771436193;4646.233371493666;4807.134715751058;4859.271109333628;4868.3427737255015;4874.829380971649;4908.190148625579;4503.887402814956;4625.306204069417;4638.953610463852;4682;4733.715977041388;4826.8069277228515;4859.271109333628;4862.586680132228;4866.610671146229;4887.047025829929;4912.238603016538;4947.356843610308;4952.975235123801;4953.0589188054155;4984.40187177541;4606.101810146989;4629.560191781776;4780.689255198401;4810.903781924272;4817.590504807131;4595.632349411972;4684.953150468588;4721.4570324413135;4727.078219747116;4789.544993225638;4625.884352891205;4649.3026046092;4655.580997710223;4663.370444989883;4696.694714843524;4613.169629466728;4799.736014519235;4828.806847726051;4843.709377437365;4875.585575226004;4664.300354946785;4668.066386722601;4676.111538807616;4680.110778951988;4711.787969541448 04:50:34 INFO - PROCESS | 15938 | |1;ext.html;476.4687373578461;520.0560981818003;526.5419085395705;541.0612587161274;544.7358031354795;29531.852340738293;29810.40379192415;29824.552631710514;29912;29999.400011999747;30693.846530767372;31144.22139446515;31328.68671313286;31392.21519462009;31440.371192576134;7353.448491363142;7440.888386674177;7508.849823003537;7514.0607424071995;7523.623818809065;7199.496035277532;7540.17058123606;7543.849123017536;7601.315881570657;7614.2766437188375;7598.658060387296;7748.7675369739;7761.3402860756905;7777.922220777805;7786.1435242123325;7678.117016543085;7721;7751.22487751226;7764.572948487831;7789.2989630932925;7534.547927124335;7674.769756907246;7709.537427754297;7727.38180945523;7749.031371078615;30906.53640195399;31046.22384440407;31425.214369640715;31431.842840785877;31559.84220078908;2129.9787002130092;2622.1740151852105;2760.3789147441867;2860.8426536540483;3181.347823696137;23907.641385379233;24029.27912162638;24117.879410602836;24136;24488.632670509956;2803.635527381448;3286.5891763529557;3340.9665903340897;3424.2466657335594;3476.8609255629744;185871;186119.0694046521;186235;186838;186855;46350.304745428846;46654;46802.531974680496;46821.29768053414;46821.29768053482;54301.45698543043;54366.72816635971;54420;54422.72788636031;54519;13164.934175329254;13219.206847589176;13353.532626358225;13447.596572102853;13490.595282141552;9093.681721139728;9100.180983711498;9112.954435227914;9192.908070919206;9254.907450925539;17239.310427582757;17514.299428022736;17533.561660958323;17550.912245438947;17613.7357939631;6775.695093720795;6861.108055952794;6962.756303529352;7020.350217698837;7099.2545782693105;733.8679037773145;778.696308439709;800.9439339246197;809.8299357134949;897.5960817632092;22603.321900343017;22798.65802012971;23163.53672926532;23693;23934;883.4566741454088;921.1755478846395;935.8409070458039;1018.8166130096654;1042.5621239079605;12575.452716297757;12605.432755526022;12790.656981016858;12843.807342889864;12844.743105137844;322623;322928;324024;325920;326657;42490.57509424866;43122.13755724868;43320.566794332284;43683.34474982878;43986.34020489695;998.6904059741504;1099.5766629847567;1126.7859106769524;1127.610974213895;1138.573035111833;22495.66256506121;23435.76564234336;23512.529749404574;23592;23802.52394952126;34524.654753452145;34851.825740871136;35095.29809403849;35096.47355289622;35538;249234;249354;250874;251516;252329;27804.86097569499;28150.2962425941;35649.82175089108;36335.45496817497;36454.8177259112;32846.34307313888;32932.1766955828;33316.009874371375;33597.14424273964;34005.82997085098;28768;28791;28877.27806804847;29160.854195728887;29183.97856075027;28230.648104176395;30478.69521304847;30694.232644184074;30844.22889427782;31222.375552489277;27948.580771288853;31500.684993149775;31954.20114497156;32899.67100328966;33750;26037.21888343353;26142.34644133912;27871.581926270715;28290.57564136581;28293;22655.660165097866;22920.770792291863;23003.884980575658;23016.194433194756;23034.308970730905 04:50:34 INFO - PROCESS | 15938 | |2;jquery.html;295.6245568128477;303.92857678445563;309.2762934732725;311.15366203925316;320.9743220542357;11235.550577976872;11815.822762658567;14525.201113938729;15100.697986040273;15114.924425377885;13279.601611951657;13733.313334333294;14205.14769113854;14343.713125737479;14391;4602.976985115078;4742.525747425248;4767.523247675239;4769.236922092466;4769.856904292877;4639.118567472169;4664.183767840615;4674.929876051845;4685.1566717990745;4688.390509233795;4511.3233015047845;4703.929441058387;4711.387519622444;4713.835015774449;4720.244760838266;4650.534946505356;4656.394668693082;4664;4666.23007203811;4675.625949923998;4175.039740859619;4176.853810116631;4180.47744031996;4204.726692764991;4612.769361531943;10591.099756520705;10662.20033497483;10683.091937185349;10807.351558906412;10822.675319740341;1715.2281473337048;1723.1987125986477;1758.2527425844094;1770.3803668715975;1770.6724256012678;7983.481073730247;8304.335653147733;8449.957750211272;8467.449615774955;8667.39328247023;1720.9741853872201;1753.8246175382487;1781.118346418518;1801.5856353038744;1833.7799464064265;48721.51278487205;51809.481905180844;53513.73243133799;54979;56341.71829140828;9161.404508706913;9342.532873356306;9360.906390936003;9468.242540596873;9531.189848862785;11940.761184776256;12118.272903625812;12153.69615759613;12153.99459089258;12168.634940951786;6183.536234782409;6194.721237544321;6362.141110950055;6445;6526.967365163144;5981.401859814071;6218.253809542884;6263.060540918898;6275.090111933835;6287.779927702509;3886.242182774332;3951.091249012743;4030.415589739471;4035.8183881724804;4117.402976568381;1643.9260233289292;1662.1938359895441;1690.5858064774209;1718.1752758675905;1723.5691077230692;793.2384910485998;795.5902710104301;888.7778055486128;890.7906641939139;898.4429653614801;14489.927550362181;14623;14820.407183712747;15037.774433383507;15332.923335383251;785.9978527377639;790.1387487638501;798.9214560343606;803.4094940218935;815.8001289684065;8221.712240071689;8289.171082891662;8441.493510389397;8454.15458454162;8558.957205213934;353414;359513;364236;365711;368744;64739;64972;65046;65565.34434655687;66614;765.5598031132122;848.4061157189992;860.0883063952231;866.0603245478726;867.6009035843583;13129.737405252032;13240;13289.800652990407;13621.455141794217;13626.318684065955;31422.842885785423;31518.684813151576;31991.84004079965;32085.518717218794;32583.511247331782;43016.354754678076;44261.557384425745;44543;44628.33057504075;45140.32289515725;6675.265720770809;6681.331866813474;6827.965860170667;6876.931230687629;6888.931110688829;9209.585568649562;10031.648892289028;10344.637937672145;10726.946365268124;10985.001824170144;9136.26909847224;9303.813923721353;9344;9447.102525260088;9745.902540974499;9284.628614855601;9486;9638.518074096408;9669.70990870275;9738.513074346112;9301.162895339452;9441.763955901157;9452.810943781224;9566.712998610054;9608.66369677058;6611.140551728245;6631.900521492085;6662.433693135944;6783.457323414016;7044.401225895651;7868.645910934136;8097.311728503143;9505;9596.280278979244;9687.854682179914 04:50:34 INFO - PROCESS | 15938 | |3;mootools.html;1236.338558871004;1257.8427696537933;1259.8299229604002;1530.1431198528833;1539.9538013859587;6027.969860150704;6622.834429139274;6684.231313398961;6910.17077950646;6911.170659520858;7001.544899581524;7046.788596342105;7056.047433596463;7073.717051317941;7088.539244949075;1996.4210378990076;2014.3352693611073;2023.5952809438172;2023.908924098419;2023.959520809583;1965.3514340267677;1982.9206831726713;1986.324649619129;2023.3929821053698;2041.6427125253097;1937.273522429089;1979.1885327015927;1981.4253866378733;1982.9305974290903;1984.3650031989769;2003.3489116037274;2019.8687085339407;2023.0188358646044;2030.2792508659509;2030.6547886859269;1957.7748558915764;1977.0213744196571;1993.362124120282;2007.8293345065688;2022.4438279473115;7070.292970702889;7102.467314951347;7113.715451381939;7149.785506434815;7156.391706704936;3901.1222474943193;3988.5213774346976;4001.679865610773;4010.037590978144;4011.1576568920564;2416.4079800448826;2471.666325046114;2484.763947424992;2526.065355818359;2633.9868300658372;796.5817945578559;799.7880561651167;847.3094428041127;866.592701430333;870.5386145342978;9587.233021358275;9637.65072889803;9647.276454265959;9677.758056048584;9679.951600242024;3550.0155442715636;3573.5354403927845;3607.1162565171176;3644.344018076719;3657.8719744808805;8193.959030204811;8269.09040005599;8274.8345033099;8289;8292.875606865902;3849.634284742945;3865.053061999828;3870.3613903706137;3875.7286989911;3903.1998440319667;3057.7095175958248;3406.454967205285;3441.1225137589754;3454.792712437262;3463.6363181866045;3012.819230846156;3049.0395525409426;3062.9846850765603;3075.876964921378;3076.077176846937;989.4162444157981;991.2763682511807;995.7062666513395;998.5356809083811;998.7453199434098;932.6735642525198;948.2982592881218;965.2181732796317;973.8733964584559;976.2921881635757;6270.059491076375;6343.302236753953;6357.586756860789;6379.330170332141;6405.807825765234;383.7812446905237;384.04373110953526;390.0502276955622;390.564520559574;391.5282085087463;4971.2543118531785;4989.027139707795;5021.372328458942;5049.469805670426;5055.140626093499;8228.83542329162;8280.04779450359;8353.874691879626;8424.241818236265;8575.185357391038;8348.373871959628;8361.205685459872;8381.706640267683;8394.370422218359;8416.326693864476;6220.502359811204;6570.934290657128;6575.605463672195;6670.499712521483;6698.095757072831;6415.839604009937;6501.934980650133;6517.152770139852;6520.087187793618;6539.182602174728;7318.451116166202;7371.926280737124;7418.295261950106;7474.439417043852;7497.062867141607;7619.619019049136;7634.198409167179;7637.389008879165;7699.037620297463;7798.571078590505;5182.067227899014;5599.0761524349655;5855.121731740273;5949.970250148722;6047.395260474093;5939.970300148644;5943;5944.970275148597;5971.253593300838;6005.969970150121;5358.544523715528;5402.405735369028;5449.836504904859;5577.6653400796085;5615.691136987505;5304.461706105186;5314.1497360422145;5357.571394288526;5373.892522149613;5431.864203394946;5868.647881127146;6031.215941927521;6041.18444010053;6098.603590766586;6103.05402662588;5523.530499907392;5627.015272327244;5647.124695672177;5825.737841797045;5845.1232315153065;5626.24045753818;5637.915431268616;5713;5753.280839895013;5760.913586296293 04:50:34 INFO - PROCESS | 15938 | |4;prototype.html;278.8800815649271;284.343167283575;284.6318629006664;286.91966249450155;287.67780086303316;5530.2303262955875;5603.7478313475885;5606.831795046155;5611.2144299798065;5612.522935550478;5279.5512381447625;5417.891642167155;5440.455954404558;5514.834554963348;5530.281063461744;4121.340585506319;4183.079722461053;4237.597428244312;4242.448481697375;4253.936190957138;4236.639885609711;4259.467566554181;4273.529911709709;4276.850310239142;4284.935725964097;4215.030542975118;4222.535521092677;4236.428082208909;4242.9151416971645;4244.214820258262;4234.216669916075;4235.343521754133;4238.19474299882;4238.5761423857675;4240.809163587646;3707.1658876752786;3708.128589781399;3710.239400922804;3716.349638813197;3718.851245950159;5332.573394128461;5334.91997620036;5336.039512887717;5340.092184328673;5343.732813359316;4637.907241855178;4857.368542089541;4868.707877527359;4878.951210487885;4885.56029957302;5768.278965129359;5795.768169273224;5800.24596802413;5804.912926306109;5823.970880145572;3891.085594885228;3892.0853599404118;3894.3768996960634;3905.8437662493466;3906;6024.638521688713;6085.695715214221;6096.451319381277;6118.449339559461;6118.571699981003;4119.361498967605;4121.649659778893;4125.29869922114;4128.649064829463;4147;4189.07840275139;4189.518205406356;4194.538600753915;4196.727212731163;4200.411942328076;4632.467266264355;4815.398075240595;4817.975910120497;4824.107540105092;4841.346418233564;5780.653160810365;5821.039528477754;5821.039528477839;5823.650580965155;5832.358440571534;1460.306354481634;1468.544751127154;1489.4786824611515;1492.8581784730434;1493.9775903361458;988.19462138357;988.962384641766;995.9890710928413;1003.1573478278282;1016.9796604067877;5011.899762004739;5024.924626130611;5039.77321020555;5053.418856831438;5060.696358218445;5992.221011268507;6000.519958403317;6004.699765011732;6018.488428483541;6019.69901504923;5004.249362595567;5019.899602007939;5035.597152227813;5049.2426136079885;5060.620453466005;3099.705527974839;3178.126015345752;3220.8228547430117;3226.451503244407;3230.2570408806105;5668.801591944262;5678.5741069419955;5695;5699;5707.200991861143;6199.721012554446;6226.937730622726;6227.221597300338;6247.500199983991;6253.030780229072;5696.971515142398;5707.1153971134545;5712.485876271156;5723.370429252779;5735.741891614971;5879.617824841372;6045.697715114315;6050.334463209131;6068.4841788448475;6073.939260607514;5921.644701317935;5946.464818166212;5955.612885162451;5959.970200149145;5971.701414929323;5682.829515114553;5725.513331366714;5730.484256416942;5735.4551317624755;5744.396838332083;3944.684425246031;3988.9202215956097;3994.500687414073;3998.8000599969305;3998.8200530975596;5986.760529578768;5990.101484777319;6034.185384972972;6036.0644100164545;6037.969810150921;5604.635698679573;5746.597738158289;5767.250257466502;5819.243498345188;5826.126081087871;5787.305523337058;5794.594378393472;5798.536117110705;5814.069748840166;5820.476157145878;5629.268195134607;5638.351589567253;5645.68948707825;5656.321241450888;5660.632058916157;5795.188673585617;5842.152887831156;5855.414458554281;5865.208196893535;5875.764969401176;5603.243562119224;5624.465675760796;5637.774489020393;5662.886742265214;5671 04:50:34 INFO - PROCESS | 15938 | |5;yui.html;601.305492156559;604.3684349854402;613.8373331067265;620.6710443464964;634.1850721822458;10558.947205263972;10776.084032857207;10875.564977400914;10928.852470490603;10984.505697243634;10948.124150067995;11196.888031119706;11213.719657008578;11218.326900385982;11319.094472442206;633.8256979330687;636.573495757841;641.3137942401632;645.7094307561592;646.5700309294338;580.4108829538022;612.7487730030688;613.7299588181208;617.1945610977672;617.9741628896033;530.7956436771851;636.2015670333725;636.6084857812435;649.217692680319;651.0494677770461;579.0966092895097;617.8393617659395;621.0156901311427;626.9310375858652;628.7862126876884;452.1003203624796;453.6484224725831;457;465.1650287733526;484.8206163719411;10560.94719526405;10769.56921723138;10771.461426928701;10803.783924321548;10837.18721095921;10369.429681367597;10469.267151299413;10649.946750266277;10896.945515272451;11220.551177952872;8503.362247831375;8539.957300213522;10055.849162262572;10288.845667314996;10528.947355263252;3144.371125774854;3172.333809899924;3202.087405089538;3237.8219197944104;3255.3326568053494;39169;39607.20785584301;39686.20627587432;39781;39959.20081598381;8502.14978502145;8787.692430764893;8866.42368246062;8927.910720892838;9031.412958157698;14931;15026.924865375822;15063.171525566198;15179.620509487131;15270.31283592241;5938.524918006549;5985.191999080155;5988.580799344091;6021.0968354746265;6133.570650054543;3070.7643467887196;3109.595752552154;3318.1704573856537;3399.6940275375337;3455.861765529401;2523.634073059433;2566.396896729267;2567.0373609896287;2567.3453269416177;2570.0747730816893;443.20887216318715;449.3529317782383;454.33666846404617;456.9543045695404;459.1826548743242;452.4412350746825;454.863540937724;513.9794408223629;536.3188750287113;542.2733537060358;6964.129483814523;7062.23238783243;7076.221615622278;7154.678039488235;7213.495055346076;438.6863392674253;466.747956103707;510.7140001599116;520.5081198267601;527.7071225469901;3099.7210251077513;3195.025517217271;3567.126054116706;3580.4629305604367;3621.63783621641;49062;49491.75254123707;49816.501834981915;49844.750776245884;50015.49984500181;41569.58430415718;43052.78473607612;45693.54306456893;45979.77010114928;46064.7696761514;40040.799796000836;40727.18545629071;40865.978350541474;40869.79565102096;40993.38509922354;6672.599644021374;7016.649167541705;7135.357817796424;7278;7455.7017719290625;31159.949206603902;31646.841765791025;32266.83866580652;32282.35435291234;32303;36571;36715.63284367122;37936.430953535164;40151.59848401479;40449.79775101106;8796.428232164888;9145.817083658423;9203.03368146335;9385.483798391155;9439.905600943903;9743.75640608962;9790.559424825757;9956.751081223027;9972.700818975442;10464.947675261576;9275.16523512887;9290.1174388433;9579.952100239454;9597.568109434953;9606.855897161688;8289.336853051862;8821.558922053744;8969.192772650233;9069.093090690878;9181.632734690538;8822.25010874083;9069.138431848964;9115.635374585208;9237.907620923705;9297.953510232675;8161;8434.24091831738;8559.486430814171;8881.245094167069;9102.863457048283;8679.609417576097;8708.869366959627;8878.689245876363;9015.323850711355;9189.678361257324 04:50:34 INFO - PROCESS | 15938 | __end_tp_report 04:50:34 INFO - PROCESS | 15938 | __start_cc_report 04:50:34 INFO - PROCESS | 15938 | _x_x_mozilla_cycle_collect,343 04:50:34 INFO - PROCESS | 15938 | __end_cc_report 04:50:34 INFO - PROCESS | 15938 | __startTimestamp1456836634129__endTimestamp 04:50:34 INFO - PROCESS | 15938 | 04:50:34 INFO - PROCESS | 15938 | ------- Summary: start ------- 04:50:34 INFO - PROCESS | 15938 | Number of tests: 6 04:50:34 INFO - PROCESS | 15938 | 04:50:34 INFO - PROCESS | 15938 | [#0] dojo.html Cycles:165 Average:4507.09 Median:4625.31 stddev:453.58 (9.8%) stddev-sans-first:430.98 04:50:34 INFO - PROCESS | 15938 | Values: 2651.5 2682.8 2712.5 2722.7 2729.8 4431.2 4530.6 4591.8 4614.9 4634.7 4514.2 4522.6 4543.3 4557.7 4624.8 4190.0 4194.1 4211.9 4366.8 4371.9 4100.1 4165.7 4277.1 4292.7 4326.6 4196.4 4214.5 4228.0 4238.4 4254.5 4221.0 4223.9 4227.9 4251.9 4268.9 4051.2 4181.4 4212.0 4289.4 4289.9 4528.2 4534.5 4555.1 4566.5 4617.6 4879.7 4903.1 4908.4 4917.2 4964.0 4765.1 4849.8 4905.0 4932.8 4947.4 4499.2 4499.9 4504.8 4506.8 4534.8 4843.0 4945.2 4945.5 4955.6 4991.1 4801.8 4829.5 4837.3 4861.1 4884.0 4795.0 4810.3 4862.6 4876.9 4947.0 4611.7 4794.8 4804.6 4804.7 4850.5 4645.2 4654.1 4655.4 4656.9 4662.5 3979.0 3996.1 4034.2 4035.2 4067.8 3532.1 3544.3 3545.5 3561.9 3573.8 4135.7 4233.2 4241.9 4275.9 4277.7 4891.6 4924.8 4929.5 4945.6 4969.9 4242.5 4243.2 4253.3 4305.6 4312.3 4265.4 4289.5 4341.6 4345.6 4354.4 4596.6 4599.7 4606.1 4645.5 4646.2 4807.1 4859.3 4868.3 4874.8 4908.2 4503.9 4625.3 4639.0 4682.0 4733.7 4826.8 4859.3 4862.6 4866.6 4887.0 4912.2 4947.4 4953.0 4953.1 4984.4 4606.1 4629.6 4780.7 4810.9 4817.6 4595.6 4685.0 4721.5 4727.1 4789.5 4625.9 4649.3 4655.6 4663.4 4696.7 4613.2 4799.7 4828.8 4843.7 4875.6 4664.3 4668.1 4676.1 4680.1 4711.8 04:50:34 INFO - PROCESS | 15938 | 04:50:34 INFO - PROCESS | 15938 | [#1] ext.html Cycles:180 Average:39400.39 Median:17567.77 stddev:68305.34 (388.8%) stddev-sans-first:68434.43 04:50:34 INFO - PROCESS | 15938 | Values: 476.5 520.1 526.5 541.1 544.7 29531.9 29810.4 29824.6 29912.0 29999.4 30693.8 31144.2 31328.7 31392.2 31440.4 7353.4 7440.9 7508.8 7514.1 7523.6 7199.5 7540.2 7543.8 7601.3 7614.3 7598.7 7748.8 7761.3 7777.9 7786.1 7678.1 7721.0 7751.2 7764.6 7789.3 7534.5 7674.8 7709.5 7727.4 7749.0 30906.5 31046.2 31425.2 31431.8 31559.8 2130.0 2622.2 2760.4 2860.8 3181.3 23907.6 24029.3 24117.9 24136.0 24488.6 2803.6 3286.6 3341.0 3424.2 3476.9 185871.0 186119.1 186235.0 186838.0 186855.0 46350.3 46654.0 46802.5 46821.3 46821.3 54301.5 54366.7 54420.0 54422.7 54519.0 13164.9 13219.2 13353.5 13447.6 13490.6 9093.7 9100.2 9113.0 9192.9 9254.9 17239.3 17514.3 17533.6 17550.9 17613.7 6775.7 6861.1 6962.8 7020.4 7099.3 733.9 778.7 800.9 809.8 897.6 22603.3 22798.7 23163.5 23693.0 23934.0 883.5 921.2 935.8 1018.8 1042.6 12575.5 12605.4 12790.7 12843.8 12844.7 322623.0 322928.0 324024.0 325920.0 326657.0 42490.6 43122.1 43320.6 43683.3 43986.3 998.7 1099.6 1126.8 1127.6 1138.6 22495.7 23435.8 23512.5 23592.0 23802.5 34524.7 34851.8 35095.3 35096.5 35538.0 249234.0 249354.0 250874.0 251516.0 252329.0 27804.9 28150.3 35649.8 36335.5 36454.8 32846.3 32932.2 33316.0 33597.1 34005.8 28768.0 28791.0 28877.3 29160.9 29184.0 28230.6 30478.7 30694.2 30844.2 31222.4 27948.6 31500.7 31954.2 32899.7 33750.0 26037.2 26142.3 27871.6 28290.6 28293.0 22655.7 22920.8 23003.9 23016.2 23034.3 04:50:34 INFO - PROCESS | 15938 | 04:50:34 INFO - PROCESS | 15938 | [#2] jquery.html Cycles:180 Average:21403.54 Median:4696.16 stddev:59544.52 (1267.9%) stddev-sans-first:59690.46 04:50:34 INFO - PROCESS | 15938 | Values: 295.6 303.9 309.3 311.2 321.0 11235.6 11815.8 14525.2 15100.7 15114.9 13279.6 13733.3 14205.1 14343.7 14391.0 4603.0 4742.5 4767.5 4769.2 4769.9 4639.1 4664.2 4674.9 4685.2 4688.4 4511.3 4703.9 4711.4 4713.8 4720.2 4650.5 4656.4 4664.0 4666.2 4675.6 4175.0 4176.9 4180.5 4204.7 4612.8 10591.1 10662.2 10683.1 10807.4 10822.7 1715.2 1723.2 1758.3 1770.4 1770.7 7983.5 8304.3 8450.0 8467.4 8667.4 1721.0 1753.8 1781.1 1801.6 1833.8 48721.5 51809.5 53513.7 54979.0 56341.7 9161.4 9342.5 9360.9 9468.2 9531.2 11940.8 12118.3 12153.7 12154.0 12168.6 6183.5 6194.7 6362.1 6445.0 6527.0 5981.4 6218.3 6263.1 6275.1 6287.8 3886.2 3951.1 4030.4 4035.8 4117.4 1643.9 1662.2 1690.6 1718.2 1723.6 793.2 795.6 888.8 890.8 898.4 14489.9 14623.0 14820.4 15037.8 15332.9 786.0 790.1 798.9 803.4 815.8 8221.7 8289.2 8441.5 8454.2 8559.0 353414.0 359513.0 364236.0 365711.0 368744.0 64739.0 64972.0 65046.0 65565.3 66614.0 765.6 848.4 860.1 866.1 867.6 13129.7 13240.0 13289.8 13621.5 13626.3 31422.8 31518.7 31991.8 32085.5 32583.5 43016.4 44261.6 44543.0 44628.3 45140.3 6675.3 6681.3 6828.0 6876.9 6888.9 9209.6 10031.6 10344.6 10726.9 10985.0 9136.3 9303.8 9344.0 9447.1 9745.9 9284.6 9486.0 9638.5 9669.7 9738.5 9301.2 9441.8 9452.8 9566.7 9608.7 6611.1 6631.9 6662.4 6783.5 7044.4 7868.6 8097.3 9505.0 9596.3 9687.9 04:50:34 INFO - PROCESS | 15938 | 04:50:34 INFO - PROCESS | 15938 | [#3] mootools.html Cycles:180 Average:4718.16 Median:5835.43 stddev:2552.86 (43.7%) stddev-sans-first:2546.61 04:50:34 INFO - PROCESS | 15938 | Values: 1236.3 1257.8 1259.8 1530.1 1540.0 6028.0 6622.8 6684.2 6910.2 6911.2 7001.5 7046.8 7056.0 7073.7 7088.5 1996.4 2014.3 2023.6 2023.9 2024.0 1965.4 1982.9 1986.3 2023.4 2041.6 1937.3 1979.2 1981.4 1982.9 1984.4 2003.3 2019.9 2023.0 2030.3 2030.7 1957.8 1977.0 1993.4 2007.8 2022.4 7070.3 7102.5 7113.7 7149.8 7156.4 3901.1 3988.5 4001.7 4010.0 4011.2 2416.4 2471.7 2484.8 2526.1 2634.0 796.6 799.8 847.3 866.6 870.5 9587.2 9637.7 9647.3 9677.8 9680.0 3550.0 3573.5 3607.1 3644.3 3657.9 8194.0 8269.1 8274.8 8289.0 8292.9 3849.6 3865.1 3870.4 3875.7 3903.2 3057.7 3406.5 3441.1 3454.8 3463.6 3012.8 3049.0 3063.0 3075.9 3076.1 989.4 991.3 995.7 998.5 998.7 932.7 948.3 965.2 973.9 976.3 6270.1 6343.3 6357.6 6379.3 6405.8 383.8 384.0 390.1 390.6 391.5 4971.3 4989.0 5021.4 5049.5 5055.1 8228.8 8280.0 8353.9 8424.2 8575.2 8348.4 8361.2 8381.7 8394.4 8416.3 6220.5 6570.9 6575.6 6670.5 6698.1 6415.8 6501.9 6517.2 6520.1 6539.2 7318.5 7371.9 7418.3 7474.4 7497.1 7619.6 7634.2 7637.4 7699.0 7798.6 5182.1 5599.1 5855.1 5950.0 6047.4 5940.0 5943.0 5945.0 5971.3 6006.0 5358.5 5402.4 5449.8 5577.7 5615.7 5304.5 5314.1 5357.6 5373.9 5431.9 5868.6 6031.2 6041.2 6098.6 6103.1 5523.5 5627.0 5647.1 5825.7 5845.1 5626.2 5637.9 5713.0 5753.3 5760.9 04:50:34 INFO - PROCESS | 15938 | 04:50:34 INFO - PROCESS | 15938 | [#4] prototype.html Cycles:180 Average:4794.93 Median:5522.53 stddev:1428.87 (25.9%) stddev-sans-first:1392.09 04:50:34 INFO - PROCESS | 15938 | Values: 278.9 284.3 284.6 286.9 287.7 5530.2 5603.7 5606.8 5611.2 5612.5 5279.6 5417.9 5440.5 5514.8 5530.3 4121.3 4183.1 4237.6 4242.4 4253.9 4236.6 4259.5 4273.5 4276.9 4284.9 4215.0 4222.5 4236.4 4242.9 4244.2 4234.2 4235.3 4238.2 4238.6 4240.8 3707.2 3708.1 3710.2 3716.3 3718.9 5332.6 5334.9 5336.0 5340.1 5343.7 4637.9 4857.4 4868.7 4879.0 4885.6 5768.3 5795.8 5800.2 5804.9 5824.0 3891.1 3892.1 3894.4 3905.8 3906.0 6024.6 6085.7 6096.5 6118.4 6118.6 4119.4 4121.6 4125.3 4128.6 4147.0 4189.1 4189.5 4194.5 4196.7 4200.4 4632.5 4815.4 4818.0 4824.1 4841.3 5780.7 5821.0 5821.0 5823.7 5832.4 1460.3 1468.5 1489.5 1492.9 1494.0 988.2 989.0 996.0 1003.2 1017.0 5011.9 5024.9 5039.8 5053.4 5060.7 5992.2 6000.5 6004.7 6018.5 6019.7 5004.2 5019.9 5035.6 5049.2 5060.6 3099.7 3178.1 3220.8 3226.5 3230.3 5668.8 5678.6 5695.0 5699.0 5707.2 6199.7 6226.9 6227.2 6247.5 6253.0 5697.0 5707.1 5712.5 5723.4 5735.7 5879.6 6045.7 6050.3 6068.5 6073.9 5921.6 5946.5 5955.6 5960.0 5971.7 5682.8 5725.5 5730.5 5735.5 5744.4 3944.7 3988.9 3994.5 3998.8 3998.8 5986.8 5990.1 6034.2 6036.1 6038.0 5604.6 5746.6 5767.3 5819.2 5826.1 5787.3 5794.6 5798.5 5814.1 5820.5 5629.3 5638.4 5645.7 5656.3 5660.6 5795.2 5842.2 5855.4 5865.2 5875.8 5603.2 5624.5 5637.8 5662.9 5671.0 04:50:34 INFO - PROCESS | 15938 | 04:50:34 INFO - PROCESS | 15938 | [#5] yui.html Cycles:180 Average:11765.22 Median:49830.63 stddev:13807.40 (27.7%) stddev-sans-first:13820.68 04:50:34 INFO - PROCESS | 15938 | Values: 601.3 604.4 613.8 620.7 634.2 10558.9 10776.1 10875.6 10928.9 10984.5 10948.1 11196.9 11213.7 11218.3 11319.1 633.8 636.6 641.3 645.7 646.6 580.4 612.7 613.7 617.2 618.0 530.8 636.2 636.6 649.2 651.0 579.1 617.8 621.0 626.9 628.8 452.1 453.6 457.0 465.2 484.8 10560.9 10769.6 10771.5 10803.8 10837.2 10369.4 10469.3 10649.9 10896.9 11220.6 8503.4 8540.0 10055.8 10288.8 10528.9 3144.4 3172.3 3202.1 3237.8 3255.3 39169.0 39607.2 39686.2 39781.0 39959.2 8502.1 8787.7 8866.4 8927.9 9031.4 14931.0 15026.9 15063.2 15179.6 15270.3 5938.5 5985.2 5988.6 6021.1 6133.6 3070.8 3109.6 3318.2 3399.7 3455.9 2523.6 2566.4 2567.0 2567.3 2570.1 443.2 449.4 454.3 457.0 459.2 452.4 454.9 514.0 536.3 542.3 6964.1 7062.2 7076.2 7154.7 7213.5 438.7 466.7 510.7 520.5 527.7 3099.7 3195.0 3567.1 3580.5 3621.6 49062.0 49491.8 49816.5 49844.8 50015.5 41569.6 43052.8 45693.5 45979.8 46064.8 40040.8 40727.2 40866.0 40869.8 40993.4 6672.6 7016.6 7135.4 7278.0 7455.7 31159.9 31646.8 32266.8 32282.4 32303.0 36571.0 36715.6 37936.4 40151.6 40449.8 8796.4 9145.8 9203.0 9385.5 9439.9 9743.8 9790.6 9956.8 9972.7 10464.9 9275.2 9290.1 9580.0 9597.6 9606.9 8289.3 8821.6 8969.2 9069.1 9181.6 8822.3 9069.1 9115.6 9237.9 9298.0 8161.0 8434.2 8559.5 8881.2 9102.9 8679.6 8708.9 8878.7 9015.3 9189.7 04:50:34 INFO - PROCESS | 15938 | -------- Summary: end -------- 04:50:34 INFO - PROCESS | 15938 | 04:50:34 INFO - PROCESS | 15938 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:34 INFO - PROCESS | 15938 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:34 INFO - PROCESS | 15938 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:34 INFO - PROCESS | 15938 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:34 INFO - PROCESS | 15938 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:34 INFO - PROCESS | 15938 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:34 INFO - PROCESS | 15938 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:34 INFO - PROCESS | 15938 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:34 INFO - TEST-INFO | 15938: exit 0 04:50:34 INFO - TEST-OK | dromaeo_css | took 1114607ms 04:50:34 INFO - TEST-START | kraken 04:50:34 INFO - operating with platform_type : linux_ 04:50:34 INFO - Initialising browser for kraken test... 04:50:34 INFO - TEST-INFO | started process 16177 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZwFchq/profile http://localhost:38618/getInfo.html) 04:50:38 INFO - PROCESS | 16177 | 04:50:38 INFO - PROCESS | 16177 | (process:16247): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:50:39 INFO - PROCESS | 16177 | __metrics Screen width/height:1600/1200 04:50:39 INFO - PROCESS | 16177 | colorDepth:24 04:50:39 INFO - PROCESS | 16177 | Browser inner width/height: 1024/697 04:50:39 INFO - PROCESS | 16177 | __metrics 04:50:40 ERROR - PROCESS | 16177 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:50:40 INFO - PROCESS | 16177 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:40 INFO - PROCESS | 16177 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:40 INFO - PROCESS | 16177 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:40 INFO - PROCESS | 16177 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:40 INFO - PROCESS | 16177 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:40 INFO - PROCESS | 16177 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:40 INFO - PROCESS | 16177 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:40 INFO - PROCESS | 16177 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:40 INFO - PROCESS | 16177 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:41 INFO - TEST-INFO | 16177: exit 0 04:50:41 INFO - Browser initialized. 04:50:41 INFO - Running cycle 1/1 for kraken test... 04:50:41 INFO - TEST-INFO | started process 16298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZwFchq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:42 INFO - PROCESS | 16298 | 04:50:42 INFO - PROCESS | 16298 | (process:16358): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:50:53 INFO - PROCESS | 16298 | RSS: Main: 161263616 04:50:53 INFO - PROCESS | 16298 | 04:50:55 INFO - PROCESS | 16298 | Cycle 1(1): loaded http://localhost:38618/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38618/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:56 INFO - PROCESS | 16298 | RSS: Main: 168116224 04:50:56 INFO - PROCESS | 16298 | 04:50:59 INFO - PROCESS | 16298 | Cycle 1(1): loaded http://localhost:38618/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38618/tests/kraken/driver.html?testName=audio-dft) 04:50:59 INFO - PROCESS | 16298 | RSS: Main: 170033152 04:50:59 INFO - PROCESS | 16298 | 04:51:02 INFO - PROCESS | 16298 | Cycle 1(1): loaded http://localhost:38618/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38618/tests/kraken/driver.html?testName=audio-fft) 04:51:03 INFO - PROCESS | 16298 | RSS: Main: 164593664 04:51:03 INFO - PROCESS | 16298 | 04:51:05 INFO - PROCESS | 16298 | Cycle 1(1): loaded http://localhost:38618/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38618/tests/kraken/driver.html?testName=audio-oscillator) 04:51:05 INFO - PROCESS | 16298 | RSS: Main: 164917248 04:51:05 INFO - PROCESS | 16298 | 04:51:08 INFO - PROCESS | 16298 | Cycle 1(1): loaded http://localhost:38618/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38618/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:51:08 INFO - PROCESS | 16298 | RSS: Main: 165154816 04:51:08 INFO - PROCESS | 16298 | 04:51:12 INFO - PROCESS | 16298 | Cycle 1(1): loaded http://localhost:38618/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38618/tests/kraken/driver.html?testName=imaging-darkroom) 04:51:12 INFO - PROCESS | 16298 | RSS: Main: 163676160 04:51:12 INFO - PROCESS | 16298 | 04:51:16 INFO - PROCESS | 16298 | Cycle 1(1): loaded http://localhost:38618/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38618/tests/kraken/driver.html?testName=imaging-desaturate) 04:51:16 INFO - PROCESS | 16298 | RSS: Main: 166068224 04:51:16 INFO - PROCESS | 16298 | 04:51:19 INFO - PROCESS | 16298 | Cycle 1(1): loaded http://localhost:38618/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38618/tests/kraken/driver.html?testName=json-parse-financial) 04:51:20 INFO - PROCESS | 16298 | RSS: Main: 166461440 04:51:20 INFO - PROCESS | 16298 | 04:51:22 INFO - PROCESS | 16298 | Cycle 1(1): loaded http://localhost:38618/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38618/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:22 INFO - PROCESS | 16298 | RSS: Main: 167522304 04:51:22 INFO - PROCESS | 16298 | 04:51:24 INFO - PROCESS | 16298 | Cycle 1(1): loaded http://localhost:38618/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38618/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:25 INFO - PROCESS | 16298 | RSS: Main: 166686720 04:51:25 INFO - PROCESS | 16298 | 04:51:27 INFO - PROCESS | 16298 | Cycle 1(1): loaded http://localhost:38618/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38618/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:27 INFO - PROCESS | 16298 | RSS: Main: 166846464 04:51:27 INFO - PROCESS | 16298 | 04:51:30 INFO - PROCESS | 16298 | Cycle 1(1): loaded http://localhost:38618/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38618/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:31 INFO - PROCESS | 16298 | RSS: Main: 167481344 04:51:31 INFO - PROCESS | 16298 | 04:51:33 INFO - PROCESS | 16298 | Cycle 1(1): loaded http://localhost:38618/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38618/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:34 INFO - PROCESS | 16298 | RSS: Main: 166739968 04:51:34 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | Cycle 1(1): loaded http://localhost:38618/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38618/tests/kraken/driver.html?testName=ai-astar) 04:51:36 INFO - PROCESS | 16298 | RSS: Main: 168972288 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | __start_tp_report 04:51:36 INFO - PROCESS | 16298 | _x_x_mozilla_page_load 04:51:36 INFO - PROCESS | 16298 | _x_x_mozilla_page_load_details 04:51:36 INFO - PROCESS | 16298 | |i|pagename|runs| 04:51:36 INFO - PROCESS | 16298 | |0;ai-astar;115;110;114;114;115;126;114;113;113;113 04:51:36 INFO - PROCESS | 16298 | |1;audio-beat-detection;159;130;156;177;130;161;159;139;177;139 04:51:36 INFO - PROCESS | 16298 | |2;audio-dft;163;163;161;160;163;162;168;159;166;165 04:51:36 INFO - PROCESS | 16298 | |3;audio-fft;77;76;74;76;74;75;139;75;73;77 04:51:36 INFO - PROCESS | 16298 | |4;audio-oscillator;94;93;140;96;95;95;136;96;95;139 04:51:36 INFO - PROCESS | 16298 | |5;imaging-gaussian-blur;118;118;117;118;117;118;118;118;117;118 04:51:36 INFO - PROCESS | 16298 | |6;imaging-darkroom;148;149;147;147;150;149;148;148;147;148 04:51:36 INFO - PROCESS | 16298 | |7;imaging-desaturate;96;97;96;95;96;96;96;96;95;96 04:51:36 INFO - PROCESS | 16298 | |8;json-parse-financial;68;75;66;67;66;67;67;69;67;66 04:51:36 INFO - PROCESS | 16298 | |9;json-stringify-tinderbox;70;72;70;70;71;71;71;72;70;70 04:51:36 INFO - PROCESS | 16298 | |10;stanford-crypto-aes;84;84;87;85;92;85;85;84;86;86 04:51:36 INFO - PROCESS | 16298 | |11;stanford-crypto-ccm;130;131;130;123;121;123;125;132;128;133 04:51:36 INFO - PROCESS | 16298 | |12;stanford-crypto-pbkdf2;144;152;153;162;151;145;152;152;156;153 04:51:36 INFO - PROCESS | 16298 | |13;stanford-crypto-sha256-iterative;72;71;73;73;72;72;72;73;73;72 04:51:36 INFO - PROCESS | 16298 | __end_tp_report 04:51:36 INFO - PROCESS | 16298 | __start_cc_report 04:51:36 INFO - PROCESS | 16298 | _x_x_mozilla_cycle_collect,878 04:51:36 INFO - PROCESS | 16298 | __end_cc_report 04:51:36 INFO - PROCESS | 16298 | __startTimestamp1456836696443__endTimestamp 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | ------- Summary: start ------- 04:51:36 INFO - PROCESS | 16298 | Number of tests: 14 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | [#0] ai-astar Cycles:10 Average:114.70 Median:114.00 stddev:4.22 (3.7%) stddev-sans-first:4.47 04:51:36 INFO - PROCESS | 16298 | Values: 115.0 110.0 114.0 114.0 115.0 126.0 114.0 113.0 113.0 113.0 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:159.00 stddev:17.47 (11.0%) stddev-sans-first:18.38 04:51:36 INFO - PROCESS | 16298 | Values: 159.0 130.0 156.0 177.0 130.0 161.0 159.0 139.0 177.0 139.0 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:2.75 (1.7%) stddev-sans-first:2.92 04:51:36 INFO - PROCESS | 16298 | Values: 163.0 163.0 161.0 160.0 163.0 162.0 168.0 159.0 166.0 165.0 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.50 stddev:20.21 (26.8%) stddev-sans-first:21.37 04:51:36 INFO - PROCESS | 16298 | Values: 77.0 76.0 74.0 76.0 74.0 75.0 139.0 75.0 73.0 77.0 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:95.00 stddev:21.04 (22.1%) stddev-sans-first:21.71 04:51:36 INFO - PROCESS | 16298 | Values: 94.0 93.0 140.0 96.0 95.0 95.0 136.0 96.0 95.0 139.0 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:51:36 INFO - PROCESS | 16298 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 117.0 118.0 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 04:51:36 INFO - PROCESS | 16298 | Values: 148.0 149.0 147.0 147.0 150.0 149.0 148.0 148.0 147.0 148.0 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:51:36 INFO - PROCESS | 16298 | Values: 96.0 97.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | [#8] json-parse-financial Cycles:10 Average:67.80 Median:67.00 stddev:2.70 (4.0%) stddev-sans-first:2.86 04:51:36 INFO - PROCESS | 16298 | Values: 68.0 75.0 66.0 67.0 66.0 67.0 67.0 69.0 67.0 66.0 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 04:51:36 INFO - PROCESS | 16298 | Values: 70.0 72.0 70.0 70.0 71.0 71.0 71.0 72.0 70.0 70.0 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.50 stddev:2.39 (2.8%) stddev-sans-first:2.45 04:51:36 INFO - PROCESS | 16298 | Values: 84.0 84.0 87.0 85.0 92.0 85.0 85.0 84.0 86.0 86.0 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:130.00 stddev:4.27 (3.3%) stddev-sans-first:4.44 04:51:36 INFO - PROCESS | 16298 | Values: 130.0 131.0 130.0 123.0 121.0 123.0 125.0 132.0 128.0 133.0 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:152.50 stddev:5.08 (3.3%) stddev-sans-first:4.48 04:51:36 INFO - PROCESS | 16298 | Values: 144.0 152.0 153.0 162.0 151.0 145.0 152.0 152.0 156.0 153.0 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.50 stddev:0.67 (0.9%) stddev-sans-first:0.71 04:51:36 INFO - PROCESS | 16298 | Values: 72.0 71.0 73.0 73.0 72.0 72.0 72.0 73.0 73.0 72.0 04:51:36 INFO - PROCESS | 16298 | -------- Summary: end -------- 04:51:36 INFO - PROCESS | 16298 | 04:51:36 INFO - PROCESS | 16298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:51:36 INFO - PROCESS | 16298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:51:36 INFO - PROCESS | 16298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:51:36 INFO - PROCESS | 16298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:51:36 INFO - PROCESS | 16298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:51:36 INFO - PROCESS | 16298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:51:36 INFO - PROCESS | 16298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:51:37 INFO - TEST-INFO | 16298: exit 0 04:51:37 INFO - TEST-OK | kraken | took 62501ms 04:51:37 INFO - SUITE-END | took 1177s 04:51:37 INFO - Completed test suite (00:19:37) 04:51:37 INFO - Working with test: dromaeo_css 04:51:37 INFO - Generating results file: dromaeo_css 04:51:37 INFO - Working with test: kraken 04:51:37 INFO - Generating results file: kraken 04:51:37 INFO - javascript benchmark 04:51:37 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:51:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:51:37 INFO - process_Request line: dromaeo_css 5901.77 graph.html#tests=[[72,94,43]] 04:51:37 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:51:37 INFO - process_Request line: kraken 1557.80 graph.html#tests=[[232,94,43]] 04:51:37 INFO - RETURN: dromaeo_css: 5901.77 04:51:37 INFO - RETURN: kraken: 1557.80 04:51:37 INFO - javascript benchmark 04:51:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2651.456451427457, 2682.7585517303437, 2712.4575084983007, 2722.714115017923, 2729.8225615335, 4431.202383570956, 4530.614897733688, 4591.839285624999, 4614.8846278843, 4634.745089020103, 4514.210013247685, 4522.592966633002, 4543.318502224668, 4557.680962332638, 4624.791884365203, 4189.9790501047455, 4194.0982688721915, 4211.8525851595205, 4366.803493842769, 4371.890702732441, 4100.077482566428, 4165.729227600196, 4277.14457108578, 4292.720973136752, 4326.58897404746, 4196.3705444183315, 4214.515330736974, 4228.0, 4238.364245363205, 4254.489461264668, 4220.978895105535, 4223.87328380146, 4227.936580951288, 4251.91496170078, 4268.9146217075795, 4051.1897620476025, 4181.414601955728, 4211.989122610551, 4289.420928174688, 4289.892752681177, 4528.1622899763315, 4534.546545345472, 4555.08898220354, 4566.49768525462, 4617.607503362218, 4879.682820616648, 4903.092927808367, 4908.410990681141, 4917.213245880677, 4963.975180124076, 4765.142274390609, 4849.83025594106, 4904.975475122637, 4932.753362331869, 4947.356843610343, 4499.235130027903, 4499.910001799978, 4504.81980720774, 4506.752128632957, 4534.77326133692, 4842.951570484321, 4945.208766597327, 4945.530174633404, 4955.603551715854, 4991.126552853309, 4801.807927682923, 4829.541193586604, 4837.250226214942, 4861.1006963711825, 4884.0, 4794.976025119852, 4810.278458231223, 4862.586680132228, 4876.878078048077, 4947.0, 4611.700239484423, 4794.760261986887, 4804.615630749532, 4804.735739534359, 4850.466448690641, 4645.233536466513, 4654.092451971833, 4655.44134703831, 4656.930146047812, 4662.53374662531, 3979.0, 3996.080901392696, 4034.1931613676793, 4035.1727895781296, 4067.776272305052, 3532.116970757311, 3544.3442963051402, 3545.4681797730545, 3561.857525698995, 3573.8391772370305, 4135.710500264952, 4233.216854881856, 4241.85469923119, 4275.893102672458, 4277.679174061957, 4891.559759621651, 4924.778384972685, 4929.507049295042, 4945.579625731782, 4969.875753106201, 4242.490901091889, 4243.193793179286, 4253.3194688849635, 4305.612494875476, 4312.288472402081, 4265.3815196796295, 4289.463817022872, 4341.587549182823, 4345.608895199447, 4354.368616550646, 4596.632269418438, 4599.6550258731395, 4606.101810147056, 4645.465771436193, 4646.233371493666, 4807.134715751058, 4859.271109333628, 4868.3427737255015, 4874.829380971649, 4908.190148625579, 4503.887402814956, 4625.306204069417, 4638.953610463852, 4682.0, 4733.715977041388, 4826.8069277228515, 4859.271109333628, 4862.586680132228, 4866.610671146229, 4887.047025829929, 4912.238603016538, 4947.356843610308, 4952.975235123801, 4953.0589188054155, 4984.40187177541, 4606.101810146989, 4629.560191781776, 4780.689255198401, 4810.903781924272, 4817.590504807131, 4595.632349411972, 4684.953150468588, 4721.4570324413135, 4727.078219747116, 4789.544993225638, 4625.884352891205, 4649.3026046092, 4655.580997710223, 4663.370444989883, 4696.694714843524, 4613.169629466728, 4799.736014519235, 4828.806847726051, 4843.709377437365, 4875.585575226004, 4664.300354946785, 4668.066386722601, 4676.111538807616, 4680.110778951988, 4711.787969541448], "unit": "score", "name": "dojo.html", "value": 4480.171977220059}, {"lowerIsBetter": false, "replicates": [476.4687373578461, 520.0560981818003, 526.5419085395705, 541.0612587161274, 544.7358031354795, 29531.852340738293, 29810.40379192415, 29824.552631710514, 29912.0, 29999.400011999747, 30693.846530767372, 31144.22139446515, 31328.68671313286, 31392.21519462009, 31440.371192576134, 7353.448491363142, 7440.888386674177, 7508.849823003537, 7514.0607424071995, 7523.623818809065, 7199.496035277532, 7540.17058123606, 7543.849123017536, 7601.315881570657, 7614.2766437188375, 7598.658060387296, 7748.7675369739, 7761.3402860756905, 7777.922220777805, 7786.1435242123325, 7678.117016543085, 7721.0, 7751.22487751226, 7764.572948487831, 7789.2989630932925, 7534.547927124335, 7674.769756907246, 7709.537427754297, 7727.38180945523, 7749.031371078615, 30906.53640195399, 31046.22384440407, 31425.214369640715, 31431.842840785877, 31559.84220078908, 2129.9787002130092, 2622.1740151852105, 2760.3789147441867, 2860.8426536540483, 3181.347823696137, 23907.641385379233, 24029.27912162638, 24117.879410602836, 24136.0, 24488.632670509956, 2803.635527381448, 3286.5891763529557, 3340.9665903340897, 3424.2466657335594, 3476.8609255629744, 185871.0, 186119.0694046521, 186235.0, 186838.0, 186855.0, 46350.304745428846, 46654.0, 46802.531974680496, 46821.29768053414, 46821.29768053482, 54301.45698543043, 54366.72816635971, 54420.0, 54422.72788636031, 54519.0, 13164.934175329254, 13219.206847589176, 13353.532626358225, 13447.596572102853, 13490.595282141552, 9093.681721139728, 9100.180983711498, 9112.954435227914, 9192.908070919206, 9254.907450925539, 17239.310427582757, 17514.299428022736, 17533.561660958323, 17550.912245438947, 17613.7357939631, 6775.695093720795, 6861.108055952794, 6962.756303529352, 7020.350217698837, 7099.2545782693105, 733.8679037773145, 778.696308439709, 800.9439339246197, 809.8299357134949, 897.5960817632092, 22603.321900343017, 22798.65802012971, 23163.53672926532, 23693.0, 23934.0, 883.4566741454088, 921.1755478846395, 935.8409070458039, 1018.8166130096654, 1042.5621239079605, 12575.452716297757, 12605.432755526022, 12790.656981016858, 12843.807342889864, 12844.743105137844, 322623.0, 322928.0, 324024.0, 325920.0, 326657.0, 42490.57509424866, 43122.13755724868, 43320.566794332284, 43683.34474982878, 43986.34020489695, 998.6904059741504, 1099.5766629847567, 1126.7859106769524, 1127.610974213895, 1138.573035111833, 22495.66256506121, 23435.76564234336, 23512.529749404574, 23592.0, 23802.52394952126, 34524.654753452145, 34851.825740871136, 35095.29809403849, 35096.47355289622, 35538.0, 249234.0, 249354.0, 250874.0, 251516.0, 252329.0, 27804.86097569499, 28150.2962425941, 35649.82175089108, 36335.45496817497, 36454.8177259112, 32846.34307313888, 32932.1766955828, 33316.009874371375, 33597.14424273964, 34005.82997085098, 28768.0, 28791.0, 28877.27806804847, 29160.854195728887, 29183.97856075027, 28230.648104176395, 30478.69521304847, 30694.232644184074, 30844.22889427782, 31222.375552489277, 27948.580771288853, 31500.684993149775, 31954.20114497156, 32899.67100328966, 33750.0, 26037.21888343353, 26142.34644133912, 27871.581926270715, 28290.57564136581, 28293.0, 22655.660165097866, 22920.770792291863, 23003.884980575658, 23016.194433194756, 23034.308970730905], "unit": "score", "name": "ext.html", "value": 15557.15204457478}, {"lowerIsBetter": false, "replicates": [295.6245568128477, 303.92857678445563, 309.2762934732725, 311.15366203925316, 320.9743220542357, 11235.550577976872, 11815.822762658567, 14525.201113938729, 15100.697986040273, 15114.924425377885, 13279.601611951657, 13733.313334333294, 14205.14769113854, 14343.713125737479, 14391.0, 4602.976985115078, 4742.525747425248, 4767.523247675239, 4769.236922092466, 4769.856904292877, 4639.118567472169, 4664.183767840615, 4674.929876051845, 4685.1566717990745, 4688.390509233795, 4511.3233015047845, 4703.929441058387, 4711.387519622444, 4713.835015774449, 4720.244760838266, 4650.534946505356, 4656.394668693082, 4664.0, 4666.23007203811, 4675.625949923998, 4175.039740859619, 4176.853810116631, 4180.47744031996, 4204.726692764991, 4612.769361531943, 10591.099756520705, 10662.20033497483, 10683.091937185349, 10807.351558906412, 10822.675319740341, 1715.2281473337048, 1723.1987125986477, 1758.2527425844094, 1770.3803668715975, 1770.6724256012678, 7983.481073730247, 8304.335653147733, 8449.957750211272, 8467.449615774955, 8667.39328247023, 1720.9741853872201, 1753.8246175382487, 1781.118346418518, 1801.5856353038744, 1833.7799464064265, 48721.51278487205, 51809.481905180844, 53513.73243133799, 54979.0, 56341.71829140828, 9161.404508706913, 9342.532873356306, 9360.906390936003, 9468.242540596873, 9531.189848862785, 11940.761184776256, 12118.272903625812, 12153.69615759613, 12153.99459089258, 12168.634940951786, 6183.536234782409, 6194.721237544321, 6362.141110950055, 6445.0, 6526.967365163144, 5981.401859814071, 6218.253809542884, 6263.060540918898, 6275.090111933835, 6287.779927702509, 3886.242182774332, 3951.091249012743, 4030.415589739471, 4035.8183881724804, 4117.402976568381, 1643.9260233289292, 1662.1938359895441, 1690.5858064774209, 1718.1752758675905, 1723.5691077230692, 793.2384910485998, 795.5902710104301, 888.7778055486128, 890.7906641939139, 898.4429653614801, 14489.927550362181, 14623.0, 14820.407183712747, 15037.774433383507, 15332.923335383251, 785.9978527377639, 790.1387487638501, 798.9214560343606, 803.4094940218935, 815.8001289684065, 8221.712240071689, 8289.171082891662, 8441.493510389397, 8454.15458454162, 8558.957205213934, 353414.0, 359513.0, 364236.0, 365711.0, 368744.0, 64739.0, 64972.0, 65046.0, 65565.34434655687, 66614.0, 765.5598031132122, 848.4061157189992, 860.0883063952231, 866.0603245478726, 867.6009035843583, 13129.737405252032, 13240.0, 13289.800652990407, 13621.455141794217, 13626.318684065955, 31422.842885785423, 31518.684813151576, 31991.84004079965, 32085.518717218794, 32583.511247331782, 43016.354754678076, 44261.557384425745, 44543.0, 44628.33057504075, 45140.32289515725, 6675.265720770809, 6681.331866813474, 6827.965860170667, 6876.931230687629, 6888.931110688829, 9209.585568649562, 10031.648892289028, 10344.637937672145, 10726.946365268124, 10985.001824170144, 9136.26909847224, 9303.813923721353, 9344.0, 9447.102525260088, 9745.902540974499, 9284.628614855601, 9486.0, 9638.518074096408, 9669.70990870275, 9738.513074346112, 9301.162895339452, 9441.763955901157, 9452.810943781224, 9566.712998610054, 9608.66369677058, 6611.140551728245, 6631.900521492085, 6662.433693135944, 6783.457323414016, 7044.401225895651, 7868.645910934136, 8097.311728503143, 9505.0, 9596.280278979244, 9687.854682179914], "unit": "score", "name": "jquery.html", "value": 7167.403281096373}, {"lowerIsBetter": false, "replicates": [1236.338558871004, 1257.8427696537933, 1259.8299229604002, 1530.1431198528833, 1539.9538013859587, 6027.969860150704, 6622.834429139274, 6684.231313398961, 6910.17077950646, 6911.170659520858, 7001.544899581524, 7046.788596342105, 7056.047433596463, 7073.717051317941, 7088.539244949075, 1996.4210378990076, 2014.3352693611073, 2023.5952809438172, 2023.908924098419, 2023.959520809583, 1965.3514340267677, 1982.9206831726713, 1986.324649619129, 2023.3929821053698, 2041.6427125253097, 1937.273522429089, 1979.1885327015927, 1981.4253866378733, 1982.9305974290903, 1984.3650031989769, 2003.3489116037274, 2019.8687085339407, 2023.0188358646044, 2030.2792508659509, 2030.6547886859269, 1957.7748558915764, 1977.0213744196571, 1993.362124120282, 2007.8293345065688, 2022.4438279473115, 7070.292970702889, 7102.467314951347, 7113.715451381939, 7149.785506434815, 7156.391706704936, 3901.1222474943193, 3988.5213774346976, 4001.679865610773, 4010.037590978144, 4011.1576568920564, 2416.4079800448826, 2471.666325046114, 2484.763947424992, 2526.065355818359, 2633.9868300658372, 796.5817945578559, 799.7880561651167, 847.3094428041127, 866.592701430333, 870.5386145342978, 9587.233021358275, 9637.65072889803, 9647.276454265959, 9677.758056048584, 9679.951600242024, 3550.0155442715636, 3573.5354403927845, 3607.1162565171176, 3644.344018076719, 3657.8719744808805, 8193.959030204811, 8269.09040005599, 8274.8345033099, 8289.0, 8292.875606865902, 3849.634284742945, 3865.053061999828, 3870.3613903706137, 3875.7286989911, 3903.1998440319667, 3057.7095175958248, 3406.454967205285, 3441.1225137589754, 3454.792712437262, 3463.6363181866045, 3012.819230846156, 3049.0395525409426, 3062.9846850765603, 3075.876964921378, 3076.077176846937, 989.4162444157981, 991.2763682511807, 995.7062666513395, 998.5356809083811, 998.7453199434098, 932.6735642525198, 948.2982592881218, 965.2181732796317, 973.8733964584559, 976.2921881635757, 6270.059491076375, 6343.302236753953, 6357.586756860789, 6379.330170332141, 6405.807825765234, 383.7812446905237, 384.04373110953526, 390.0502276955622, 390.564520559574, 391.5282085087463, 4971.2543118531785, 4989.027139707795, 5021.372328458942, 5049.469805670426, 5055.140626093499, 8228.83542329162, 8280.04779450359, 8353.874691879626, 8424.241818236265, 8575.185357391038, 8348.373871959628, 8361.205685459872, 8381.706640267683, 8394.370422218359, 8416.326693864476, 6220.502359811204, 6570.934290657128, 6575.605463672195, 6670.499712521483, 6698.095757072831, 6415.839604009937, 6501.934980650133, 6517.152770139852, 6520.087187793618, 6539.182602174728, 7318.451116166202, 7371.926280737124, 7418.295261950106, 7474.439417043852, 7497.062867141607, 7619.619019049136, 7634.198409167179, 7637.389008879165, 7699.037620297463, 7798.571078590505, 5182.067227899014, 5599.0761524349655, 5855.121731740273, 5949.970250148722, 6047.395260474093, 5939.970300148644, 5943.0, 5944.970275148597, 5971.253593300838, 6005.969970150121, 5358.544523715528, 5402.405735369028, 5449.836504904859, 5577.6653400796085, 5615.691136987505, 5304.461706105186, 5314.1497360422145, 5357.571394288526, 5373.892522149613, 5431.864203394946, 5868.647881127146, 6031.215941927521, 6041.18444010053, 6098.603590766586, 6103.05402662588, 5523.530499907392, 5627.015272327244, 5647.124695672177, 5825.737841797045, 5845.1232315153065, 5626.24045753818, 5637.915431268616, 5713.0, 5753.280839895013, 5760.913586296293], "unit": "score", "name": "mootools.html", "value": 3767.9209218309256}, {"lowerIsBetter": false, "replicates": [278.8800815649271, 284.343167283575, 284.6318629006664, 286.91966249450155, 287.67780086303316, 5530.2303262955875, 5603.7478313475885, 5606.831795046155, 5611.2144299798065, 5612.522935550478, 5279.5512381447625, 5417.891642167155, 5440.455954404558, 5514.834554963348, 5530.281063461744, 4121.340585506319, 4183.079722461053, 4237.597428244312, 4242.448481697375, 4253.936190957138, 4236.639885609711, 4259.467566554181, 4273.529911709709, 4276.850310239142, 4284.935725964097, 4215.030542975118, 4222.535521092677, 4236.428082208909, 4242.9151416971645, 4244.214820258262, 4234.216669916075, 4235.343521754133, 4238.19474299882, 4238.5761423857675, 4240.809163587646, 3707.1658876752786, 3708.128589781399, 3710.239400922804, 3716.349638813197, 3718.851245950159, 5332.573394128461, 5334.91997620036, 5336.039512887717, 5340.092184328673, 5343.732813359316, 4637.907241855178, 4857.368542089541, 4868.707877527359, 4878.951210487885, 4885.56029957302, 5768.278965129359, 5795.768169273224, 5800.24596802413, 5804.912926306109, 5823.970880145572, 3891.085594885228, 3892.0853599404118, 3894.3768996960634, 3905.8437662493466, 3906.0, 6024.638521688713, 6085.695715214221, 6096.451319381277, 6118.449339559461, 6118.571699981003, 4119.361498967605, 4121.649659778893, 4125.29869922114, 4128.649064829463, 4147.0, 4189.07840275139, 4189.518205406356, 4194.538600753915, 4196.727212731163, 4200.411942328076, 4632.467266264355, 4815.398075240595, 4817.975910120497, 4824.107540105092, 4841.346418233564, 5780.653160810365, 5821.039528477754, 5821.039528477839, 5823.650580965155, 5832.358440571534, 1460.306354481634, 1468.544751127154, 1489.4786824611515, 1492.8581784730434, 1493.9775903361458, 988.19462138357, 988.962384641766, 995.9890710928413, 1003.1573478278282, 1016.9796604067877, 5011.899762004739, 5024.924626130611, 5039.77321020555, 5053.418856831438, 5060.696358218445, 5992.221011268507, 6000.519958403317, 6004.699765011732, 6018.488428483541, 6019.69901504923, 5004.249362595567, 5019.899602007939, 5035.597152227813, 5049.2426136079885, 5060.620453466005, 3099.705527974839, 3178.126015345752, 3220.8228547430117, 3226.451503244407, 3230.2570408806105, 5668.801591944262, 5678.5741069419955, 5695.0, 5699.0, 5707.200991861143, 6199.721012554446, 6226.937730622726, 6227.221597300338, 6247.500199983991, 6253.030780229072, 5696.971515142398, 5707.1153971134545, 5712.485876271156, 5723.370429252779, 5735.741891614971, 5879.617824841372, 6045.697715114315, 6050.334463209131, 6068.4841788448475, 6073.939260607514, 5921.644701317935, 5946.464818166212, 5955.612885162451, 5959.970200149145, 5971.701414929323, 5682.829515114553, 5725.513331366714, 5730.484256416942, 5735.4551317624755, 5744.396838332083, 3944.684425246031, 3988.9202215956097, 3994.500687414073, 3998.8000599969305, 3998.8200530975596, 5986.760529578768, 5990.101484777319, 6034.185384972972, 6036.0644100164545, 6037.969810150921, 5604.635698679573, 5746.597738158289, 5767.250257466502, 5819.243498345188, 5826.126081087871, 5787.305523337058, 5794.594378393472, 5798.536117110705, 5814.069748840166, 5820.476157145878, 5629.268195134607, 5638.351589567253, 5645.68948707825, 5656.321241450888, 5660.632058916157, 5795.188673585617, 5842.152887831156, 5855.414458554281, 5865.208196893535, 5875.764969401176, 5603.243562119224, 5624.465675760796, 5637.774489020393, 5662.886742265214, 5671.0], "unit": "score", "name": "prototype.html", "value": 4325.51732120701}, {"lowerIsBetter": false, "replicates": [601.305492156559, 604.3684349854402, 613.8373331067265, 620.6710443464964, 634.1850721822458, 10558.947205263972, 10776.084032857207, 10875.564977400914, 10928.852470490603, 10984.505697243634, 10948.124150067995, 11196.888031119706, 11213.719657008578, 11218.326900385982, 11319.094472442206, 633.8256979330687, 636.573495757841, 641.3137942401632, 645.7094307561592, 646.5700309294338, 580.4108829538022, 612.7487730030688, 613.7299588181208, 617.1945610977672, 617.9741628896033, 530.7956436771851, 636.2015670333725, 636.6084857812435, 649.217692680319, 651.0494677770461, 579.0966092895097, 617.8393617659395, 621.0156901311427, 626.9310375858652, 628.7862126876884, 452.1003203624796, 453.6484224725831, 457.0, 465.1650287733526, 484.8206163719411, 10560.94719526405, 10769.56921723138, 10771.461426928701, 10803.783924321548, 10837.18721095921, 10369.429681367597, 10469.267151299413, 10649.946750266277, 10896.945515272451, 11220.551177952872, 8503.362247831375, 8539.957300213522, 10055.849162262572, 10288.845667314996, 10528.947355263252, 3144.371125774854, 3172.333809899924, 3202.087405089538, 3237.8219197944104, 3255.3326568053494, 39169.0, 39607.20785584301, 39686.20627587432, 39781.0, 39959.20081598381, 8502.14978502145, 8787.692430764893, 8866.42368246062, 8927.910720892838, 9031.412958157698, 14931.0, 15026.924865375822, 15063.171525566198, 15179.620509487131, 15270.31283592241, 5938.524918006549, 5985.191999080155, 5988.580799344091, 6021.0968354746265, 6133.570650054543, 3070.7643467887196, 3109.595752552154, 3318.1704573856537, 3399.6940275375337, 3455.861765529401, 2523.634073059433, 2566.396896729267, 2567.0373609896287, 2567.3453269416177, 2570.0747730816893, 443.20887216318715, 449.3529317782383, 454.33666846404617, 456.9543045695404, 459.1826548743242, 452.4412350746825, 454.863540937724, 513.9794408223629, 536.3188750287113, 542.2733537060358, 6964.129483814523, 7062.23238783243, 7076.221615622278, 7154.678039488235, 7213.495055346076, 438.6863392674253, 466.747956103707, 510.7140001599116, 520.5081198267601, 527.7071225469901, 3099.7210251077513, 3195.025517217271, 3567.126054116706, 3580.4629305604367, 3621.63783621641, 49062.0, 49491.75254123707, 49816.501834981915, 49844.750776245884, 50015.49984500181, 41569.58430415718, 43052.78473607612, 45693.54306456893, 45979.77010114928, 46064.7696761514, 40040.799796000836, 40727.18545629071, 40865.978350541474, 40869.79565102096, 40993.38509922354, 6672.599644021374, 7016.649167541705, 7135.357817796424, 7278.0, 7455.7017719290625, 31159.949206603902, 31646.841765791025, 32266.83866580652, 32282.35435291234, 32303.0, 36571.0, 36715.63284367122, 37936.430953535164, 40151.59848401479, 40449.79775101106, 8796.428232164888, 9145.817083658423, 9203.03368146335, 9385.483798391155, 9439.905600943903, 9743.75640608962, 9790.559424825757, 9956.751081223027, 9972.700818975442, 10464.947675261576, 9275.16523512887, 9290.1174388433, 9579.952100239454, 9597.568109434953, 9606.855897161688, 8289.336853051862, 8821.558922053744, 8969.192772650233, 9069.093090690878, 9181.632734690538, 8822.25010874083, 9069.138431848964, 9115.635374585208, 9237.907620923705, 9297.953510232675, 8161.0, 8434.24091831738, 8559.486430814171, 8881.245094167069, 9102.863457048283, 8679.609417576097, 8708.869366959627, 8878.689245876363, 9015.323850711355, 9189.678361257324], "unit": "score", "name": "yui.html", "value": 5189.467976099781}], "name": "dromaeo_css", "value": 5901.7674460264025}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 114.0, 114.0, 115.0, 126.0, 114.0, 113.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [159.0, 130.0, 156.0, 177.0, 130.0, 161.0, 159.0, 139.0, 177.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 152.7}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 161.0, 160.0, 163.0, 162.0, 168.0, 159.0, 166.0, 165.0], "unit": "score", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 74.0, 76.0, 74.0, 75.0, 139.0, 75.0, 73.0, 77.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 140.0, 96.0, 95.0, 95.0, 136.0, 96.0, 95.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.7}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 147.0, 147.0, 150.0, 149.0, 148.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [68.0, 75.0, 66.0, 67.0, 66.0, 67.0, 67.0, 69.0, 67.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 67.8}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 70.0, 70.0, 71.0, 71.0, 71.0, 72.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.7}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 87.0, 85.0, 92.0, 85.0, 85.0, 84.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [130.0, 131.0, 130.0, 123.0, 121.0, 123.0, 125.0, 132.0, 128.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.6}, {"lowerIsBetter": true, "replicates": [144.0, 152.0, 153.0, 162.0, 151.0, 145.0, 152.0, 152.0, 156.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.0}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 73.0, 73.0, 72.0, 72.0, 72.0, 73.0, 73.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.3}], "name": "kraken", "value": 1557.8}]} 04:51:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1557.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "5901.77"}}} 04:51:37 INFO - Return code: 0 04:51:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:51:37 ERROR - # TBPL SUCCESS # 04:51:37 INFO - Running post-action listener: _resource_record_post_action 04:51:37 INFO - Running post-run listener: _resource_record_post_run 04:51:38 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 229376; Write bytes: 488669184; Read time: 48; Write time: 375268 04:51:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 195260416; Read time: 0; Write time: 201772 04:51:38 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 229376; Write bytes: 293408768; Read time: 48; Write time: 173496 04:51:38 INFO - Running post-run listener: _upload_blobber_files 04:51:38 INFO - Blob upload gear active. 04:51:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:38 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 04:51:38 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:51:38 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:51:39 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:51:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:51:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:40 INFO - (blobuploader) - INFO - Done attempting. 04:51:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:51:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:40 INFO - (blobuploader) - INFO - Done attempting. 04:51:40 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:40 INFO - Return code: 0 04:51:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87d6e1f755bf4a12e89f70133dee4b1aa3a26c37818ecec0f1d1387c24fcc6f42245989aba500ee3051044d411edb89414b43c9ad16ef162e9f688c4838c08b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d01482fe2d5eddb81b6556b932d0d09bd576a86e680f4ab6e70c125a261f08d9dbb8878fa4b1a7f74e18ee2d95369e8c8133d4fbe8c141bd9b415551392644d"} 04:51:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:40 INFO - Contents: 04:51:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87d6e1f755bf4a12e89f70133dee4b1aa3a26c37818ecec0f1d1387c24fcc6f42245989aba500ee3051044d411edb89414b43c9ad16ef162e9f688c4838c08b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d01482fe2d5eddb81b6556b932d0d09bd576a86e680f4ab6e70c125a261f08d9dbb8878fa4b1a7f74e18ee2d95369e8c8133d4fbe8c141bd9b415551392644d"} 04:51:40 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:40 INFO - Copying logs to upload dir... 04:51:40 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.358264 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-03-01 04:51:40.789722) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:40.793336) ========= 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=0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545 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/Firefox-Non-PGO/sha512/87d6e1f755bf4a12e89f70133dee4b1aa3a26c37818ecec0f1d1387c24fcc6f42245989aba500ee3051044d411edb89414b43c9ad16ef162e9f688c4838c08b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d01482fe2d5eddb81b6556b932d0d09bd576a86e680f4ab6e70c125a261f08d9dbb8878fa4b1a7f74e18ee2d95369e8c8133d4fbe8c141bd9b415551392644d"} build_url:https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/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/Firefox-Non-PGO/sha512/87d6e1f755bf4a12e89f70133dee4b1aa3a26c37818ecec0f1d1387c24fcc6f42245989aba500ee3051044d411edb89414b43c9ad16ef162e9f688c4838c08b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d01482fe2d5eddb81b6556b932d0d09bd576a86e680f4ab6e70c125a261f08d9dbb8878fa4b1a7f74e18ee2d95369e8c8133d4fbe8c141bd9b415551392644d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:40.817403) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:40.817695) ========= 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=0e2a256762fed810e2f0f810000001b3-1456833644.523017-427164545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:40.903737) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 04:51:40.904060) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 04:51:40.904343) ========= ========= Total master_lag: 0.30 =========