builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1456838751.06 results: success (0) buildid: 20160301035440 builduid: 5e85e88376174906985f69bb8a085699 revision: bb1dbd40af536693f138bcfd4111760aef17723f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.064579) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.065281) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.065733) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006363 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.094137) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.094857) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.110221) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.110900) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004657 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.163525) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.164267) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.164984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.165502) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 05:25: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 05:25:51 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162807 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.342602) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.342976) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019226 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.393288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.393805) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bb1dbd40af536693f138bcfd4111760aef17723f --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 bb1dbd40af536693f138bcfd4111760aef17723f --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=652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 05:25:51,457 truncating revision to first 12 chars 2016-03-01 05:25:51,457 Setting DEBUG logging. 2016-03-01 05:25:51,457 attempt 1/10 2016-03-01 05:25:51,457 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bb1dbd40af53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 05:25:51,730 unpacking tar archive at: mozilla-central-bb1dbd40af53/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567109 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.974438) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:51.974829) ========= echo bb1dbd40af536693f138bcfd4111760aef17723f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bb1dbd40af536693f138bcfd4111760aef17723f'] 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=652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False bb1dbd40af536693f138bcfd4111760aef17723f program finished with exit code 0 elapsedTime=0.004092 script_repo_revision: 'bb1dbd40af536693f138bcfd4111760aef17723f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:52.025328) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:52.025677) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 05:25:52.035433) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-01 05:25:52.035751) ========= /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=652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:25:52 INFO - MultiFileLogger online at 20160301 05:25:52 in /builds/slave/test 05:25: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 05:25:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:25:52 INFO - {'append_to_log': False, 05:25:52 INFO - 'base_work_dir': '/builds/slave/test', 05:25:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:25:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:25:52 INFO - 'branch': 'Firefox-Non-PGO', 05:25:52 INFO - 'buildbot_json_path': 'buildprops.json', 05:25:52 INFO - 'config_files': ('talos/linux_config.py',), 05:25:52 INFO - 'default_actions': ('clobber', 05:25:52 INFO - 'read-buildbot-config', 05:25:52 INFO - 'download-and-extract', 05:25:52 INFO - 'populate-webroot', 05:25:52 INFO - 'create-virtualenv', 05:25:52 INFO - 'install', 05:25:52 INFO - 'run-tests'), 05:25:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:25:52 INFO - 'download_minidump_stackwalk': True, 05:25:52 INFO - 'download_symbols': 'ondemand', 05:25:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:25:52 INFO - 'tooltool.py': '/tools/tooltool.py', 05:25:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:25:52 INFO - '/tools/misc-python/virtualenv.py')}, 05:25:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:25:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:25:52 INFO - 'installer_path': 'installer.exe', 05:25:52 INFO - 'log_level': 'info', 05:25:52 INFO - 'log_name': 'talos', 05:25:52 INFO - 'log_to_console': True, 05:25:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:25:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:25:52 INFO - 'opt_config_files': (), 05:25:52 INFO - 'pip_index': False, 05:25:52 INFO - 'sps_profile': False, 05:25:52 INFO - 'sps_profile_interval': 0, 05:25:52 INFO - 'suite': 'dromaeojs-e10s', 05:25:52 INFO - 'system_bits': '32', 05:25:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:25:52 INFO - 'title': 'talos-linux64-ix-046', 05:25:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:25:52 INFO - 'use_talos_json': True, 05:25:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:25:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:25:52 INFO - 'work_dir': 'build'} 05:25:52 INFO - ##### 05:25:52 INFO - ##### Running clobber step. 05:25:52 INFO - ##### 05:25:52 INFO - Running pre-action listener: _resource_record_pre_action 05:25:52 INFO - Running main action method: clobber 05:25:52 INFO - rmtree: /builds/slave/test/build 05:25:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:25:53 INFO - Running post-action listener: _resource_record_post_action 05:25:53 INFO - ##### 05:25:53 INFO - ##### Running read-buildbot-config step. 05:25:53 INFO - ##### 05:25:53 INFO - Running pre-action listener: _resource_record_pre_action 05:25:53 INFO - Running main action method: read_buildbot_config 05:25:53 INFO - Using buildbot properties: 05:25:53 INFO - { 05:25:53 INFO - "project": "", 05:25:53 INFO - "product": "firefox", 05:25:53 INFO - "script_repo_revision": "production", 05:25:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:25:53 INFO - "repository": "", 05:25:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:25:53 INFO - "buildid": "20160301035440", 05:25:53 INFO - "pgo_build": "False", 05:25:53 INFO - "basedir": "/builds/slave/test", 05:25:53 INFO - "buildnumber": 214, 05:25:53 INFO - "slavename": "talos-linux64-ix-046", 05:25:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:25:53 INFO - "platform": "ubuntu64_hw", 05:25:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 05:25:53 INFO - "branch": "mozilla-central", 05:25:53 INFO - "repo_path": "mozilla-central", 05:25:53 INFO - "revision": "bb1dbd40af536693f138bcfd4111760aef17723f", 05:25:53 INFO - "stage_platform": "linux64", 05:25:53 INFO - "builduid": "5e85e88376174906985f69bb8a085699", 05:25:53 INFO - "slavebuilddir": "test" 05:25:53 INFO - } 05:25:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:25:53 INFO - Running post-action listener: _resource_record_post_action 05:25:53 INFO - ##### 05:25:53 INFO - ##### Running download-and-extract step. 05:25:53 INFO - ##### 05:25:53 INFO - Running pre-action listener: _resource_record_pre_action 05:25:53 INFO - Running main action method: download_and_extract 05:25:53 INFO - mkdir: /builds/slave/test/build/tests 05:25: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')]} 05:25:53 INFO - https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:25:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:25:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:25:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/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 05:25:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/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 05:25:53 INFO - Downloaded 1448 bytes. 05:25:53 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:25:53 INFO - Using the following test package requirements: 05:25:53 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:25:53 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:25:53 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:25:53 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:53 INFO - u'jsshell-linux-x86_64.zip'], 05:25:53 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:25:53 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:25:53 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:25:53 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:25:53 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:25:53 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:25:53 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:25:53 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:25: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')]} 05:25:53 INFO - https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:25:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:25:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:25:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/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 05:25:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/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 05:25:55 INFO - Downloaded 22077416 bytes. 05:25: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'] 05:25: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 05:25:56 INFO - Return code: 0 05:25: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 05:25: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')]} 05:25:56 INFO - https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:25:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:25:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:25:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/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 05:25:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/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 05:25:59 INFO - Downloaded 22077416 bytes. 05:25:59 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'] 05:25:59 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 05:26:00 INFO - Return code: 0 05:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:00 INFO - https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:26:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:26:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:26:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/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 05:26:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/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 05:26:01 INFO - Downloaded 10713413 bytes. 05:26:01 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'] 05:26:01 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 05:26:01 INFO - Return code: 0 05:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:01 INFO - https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:26:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:26:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:26:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/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 05:26:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/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 05:26:05 INFO - Downloaded 54836349 bytes. 05:26:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:26:05 INFO - mkdir: /builds/slave/test/properties 05:26:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:26:05 INFO - Writing to file /builds/slave/test/properties/build_url 05:26:05 INFO - Contents: 05:26:06 INFO - build_url:https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:26:06 INFO - Running post-action listener: _resource_record_post_action 05:26:06 INFO - Running post-action listener: set_extra_try_arguments 05:26:06 INFO - ##### 05:26:06 INFO - ##### Running populate-webroot step. 05:26:06 INFO - ##### 05:26:06 INFO - Running pre-action listener: _resource_record_pre_action 05:26:06 INFO - Running main action method: populate_webroot 05:26:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:26:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:26:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:26:06 INFO - '--tppagecycles', 05:26:06 INFO - '7'], 05:26:06 INFO - 'tests': ['tsvgm']}}, 05:26:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:26:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:26:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:26:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:26:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:26:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:26:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:06 INFO - 'talos_options': ['--e10s'], 05:26:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:06 INFO - 'tests': ['damp', 'tps']}, 05:26:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:06 INFO - 'talos_options': ['--e10s'], 05:26:06 INFO - 'tests': ['damp', 'tps']}, 05:26:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:26:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:26:06 INFO - 'other': {'tests': ['a11yr', 05:26:06 INFO - 'ts_paint', 05:26:06 INFO - 'tpaint', 05:26:06 INFO - 'sessionrestore', 05:26:06 INFO - 'sessionrestore_no_auto_restore']}, 05:26:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:26:06 INFO - 'tests': ['a11yr', 05:26:06 INFO - 'ts_paint', 05:26:06 INFO - 'tpaint', 05:26:06 INFO - 'sessionrestore', 05:26:06 INFO - 'sessionrestore_no_auto_restore']}, 05:26:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:26:06 INFO - 'tests': ['a11yr', 05:26:06 INFO - 'ts_paint', 05:26:06 INFO - 'tpaint', 05:26:06 INFO - 'sessionrestore', 05:26:06 INFO - 'sessionrestore_no_auto_restore']}, 05:26:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:26:06 INFO - 'tests': ['a11yr', 05:26:06 INFO - 'ts_paint', 05:26:06 INFO - 'tpaint', 05:26:06 INFO - 'sessionrestore', 05:26:06 INFO - 'sessionrestore_no_auto_restore']}, 05:26:06 INFO - 'other_l64': {'tests': ['a11yr', 05:26:06 INFO - 'ts_paint', 05:26:06 INFO - 'tpaint', 05:26:06 INFO - 'sessionrestore', 05:26:06 INFO - 'sessionrestore_no_auto_restore']}, 05:26:06 INFO - 'other_nol64': {'tests': ['a11yr', 05:26:06 INFO - 'ts_paint', 05:26:06 INFO - 'tpaint', 05:26:06 INFO - 'sessionrestore', 05:26:06 INFO - 'sessionrestore_no_auto_restore']}, 05:26:06 INFO - 'svgr': {'tests': ['tsvgx', 05:26:06 INFO - 'tsvgr_opacity', 05:26:06 INFO - 'tart', 05:26:06 INFO - 'tscrollx', 05:26:06 INFO - 'cart']}, 05:26:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:26:06 INFO - 'tests': ['tsvgx', 05:26:06 INFO - 'tsvgr_opacity', 05:26:06 INFO - 'tart', 05:26:06 INFO - 'tscrollx', 05:26:06 INFO - 'cart']}, 05:26:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:06 INFO - 'tests': ['tp5o']}, 05:26:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:06 INFO - 'talos_options': ['--e10s'], 05:26:06 INFO - 'tests': ['tp5o']}, 05:26:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:06 INFO - 'talos_options': ['--xperf_path', 05:26:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:06 INFO - 'tests': ['tp5n']}, 05:26:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:06 INFO - 'talos_options': ['--e10s', 05:26:06 INFO - '--xperf_path', 05:26:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:06 INFO - 'tests': ['tp5n']}}, 05:26:06 INFO - 'talos.zip': {'path': '', 05:26:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:26:06 INFO - Running post-action listener: _resource_record_post_action 05:26:06 INFO - ##### 05:26:06 INFO - ##### Running create-virtualenv step. 05:26:06 INFO - ##### 05:26:06 INFO - Running pre-action listener: _resource_record_pre_action 05:26:06 INFO - Running main action method: create_virtualenv 05:26:06 INFO - Creating virtualenv /builds/slave/test/build/venv 05:26:06 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 05:26:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:26:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:26:06 INFO - Using real prefix '/usr' 05:26:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:26:07 INFO - Installing distribute.............................................................................................................................................................................................done. 05:26:09 INFO - Installing pip.................done. 05:26:09 INFO - Return code: 0 05:26:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:09 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 0x7fb31c82af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa100>, '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 0x23ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', '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 05:26:09 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 05:26:09 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 05:26:09 INFO - Using env: {'DISPLAY': ':0', 05:26:09 INFO - 'HOME': '/home/cltbld', 05:26:09 INFO - 'LANG': 'en_US.UTF-8', 05:26:09 INFO - 'LANGUAGE': 'en_US:en', 05:26:09 INFO - 'LOGNAME': 'cltbld', 05:26:09 INFO - 'MAIL': '/var/mail/cltbld', 05:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:09 INFO - 'MOZ_NO_REMOTE': '1', 05:26:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:09 INFO - 'NO_EM_RESTART': '1', 05:26:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:09 INFO - 'PWD': '/builds/slave/test', 05:26:09 INFO - 'SHELL': '/bin/bash', 05:26:09 INFO - 'SHLVL': '1', 05:26:09 INFO - 'TERM': 'linux', 05:26:09 INFO - 'TMOUT': '86400', 05:26:09 INFO - 'USER': 'cltbld', 05:26:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', 05:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:09 INFO - '_': '/tools/buildbot/bin/python'} 05:26:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:09 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 05:26:09 INFO - Cleaning up... 05:26:09 INFO - Return code: 0 05:26:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:09 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 0x7fb31c82af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa100>, '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 0x23ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', '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 05:26:09 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 05:26:09 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 05:26:09 INFO - Using env: {'DISPLAY': ':0', 05:26:09 INFO - 'HOME': '/home/cltbld', 05:26:09 INFO - 'LANG': 'en_US.UTF-8', 05:26:09 INFO - 'LANGUAGE': 'en_US:en', 05:26:09 INFO - 'LOGNAME': 'cltbld', 05:26:09 INFO - 'MAIL': '/var/mail/cltbld', 05:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:09 INFO - 'MOZ_NO_REMOTE': '1', 05:26:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:09 INFO - 'NO_EM_RESTART': '1', 05:26:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:09 INFO - 'PWD': '/builds/slave/test', 05:26:09 INFO - 'SHELL': '/bin/bash', 05:26:09 INFO - 'SHLVL': '1', 05:26:09 INFO - 'TERM': 'linux', 05:26:09 INFO - 'TMOUT': '86400', 05:26:09 INFO - 'USER': 'cltbld', 05:26:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', 05:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:09 INFO - '_': '/tools/buildbot/bin/python'} 05:26:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:09 INFO - Downloading/unpacking psutil>=0.7.1 05:26:09 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 05:26:09 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 05:26:09 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 05:26:09 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 05:26:09 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 05:26:09 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 05:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:26:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:11 INFO - Installing collected packages: psutil 05:26:11 INFO - Running setup.py install for psutil 05:26:11 INFO - building 'psutil._psutil_linux' extension 05:26:11 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 05:26:11 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 05:26:11 INFO - building 'psutil._psutil_posix' extension 05:26:11 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 05:26:12 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 05:26:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:12 INFO - Successfully installed psutil 05:26:12 INFO - Cleaning up... 05:26:12 INFO - Return code: 0 05:26:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:26: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')]} 05:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26: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')]} 05:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:12 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 0x7fb31c82af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa100>, '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 0x23ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', '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 05:26:12 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 05:26:12 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 05:26:12 INFO - Using env: {'DISPLAY': ':0', 05:26:12 INFO - 'HOME': '/home/cltbld', 05:26:12 INFO - 'LANG': 'en_US.UTF-8', 05:26:12 INFO - 'LANGUAGE': 'en_US:en', 05:26:12 INFO - 'LOGNAME': 'cltbld', 05:26:12 INFO - 'MAIL': '/var/mail/cltbld', 05:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:12 INFO - 'MOZ_NO_REMOTE': '1', 05:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:12 INFO - 'NO_EM_RESTART': '1', 05:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:12 INFO - 'PWD': '/builds/slave/test', 05:26:12 INFO - 'SHELL': '/bin/bash', 05:26:12 INFO - 'SHLVL': '1', 05:26:12 INFO - 'TERM': 'linux', 05:26:12 INFO - 'TMOUT': '86400', 05:26:12 INFO - 'USER': 'cltbld', 05:26:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', 05:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:12 INFO - '_': '/tools/buildbot/bin/python'} 05:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:26:12 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 05:26:12 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 05:26:12 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 05:26:12 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 05:26:12 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 05:26:12 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 05:26:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:26:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:26:14 INFO - Installing collected packages: mozsystemmonitor 05:26:14 INFO - Running setup.py install for mozsystemmonitor 05:26:14 INFO - Successfully installed mozsystemmonitor 05:26:14 INFO - Cleaning up... 05:26:14 INFO - Return code: 0 05:26:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:26:14 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')]} 05:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:14 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')]} 05:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:14 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 0x7fb31c82af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa100>, '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 0x23ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', '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 05:26:14 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 05:26:14 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 05:26:14 INFO - Using env: {'DISPLAY': ':0', 05:26:14 INFO - 'HOME': '/home/cltbld', 05:26:14 INFO - 'LANG': 'en_US.UTF-8', 05:26:14 INFO - 'LANGUAGE': 'en_US:en', 05:26:14 INFO - 'LOGNAME': 'cltbld', 05:26:14 INFO - 'MAIL': '/var/mail/cltbld', 05:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:14 INFO - 'MOZ_NO_REMOTE': '1', 05:26:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:14 INFO - 'NO_EM_RESTART': '1', 05:26:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:14 INFO - 'PWD': '/builds/slave/test', 05:26:14 INFO - 'SHELL': '/bin/bash', 05:26:14 INFO - 'SHLVL': '1', 05:26:14 INFO - 'TERM': 'linux', 05:26:14 INFO - 'TMOUT': '86400', 05:26:14 INFO - 'USER': 'cltbld', 05:26:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', 05:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:14 INFO - '_': '/tools/buildbot/bin/python'} 05:26:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:14 INFO - Downloading/unpacking blobuploader==1.2.4 05:26:14 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 05:26:14 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 05:26:14 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 05:26:14 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 05:26:14 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 05:26:14 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 05:26:16 INFO - Downloading blobuploader-1.2.4.tar.gz 05:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:26:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:26:16 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 05:26:16 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 05:26:16 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 05:26:16 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 05:26:16 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 05:26:16 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 05:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:26:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:26:17 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 05:26:17 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 05:26:17 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 05:26:17 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 05:26:17 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 05:26:17 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 05:26:17 INFO - Downloading docopt-0.6.1.tar.gz 05:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:26:17 INFO - Installing collected packages: blobuploader, requests, docopt 05:26:17 INFO - Running setup.py install for blobuploader 05:26:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:26:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:26:17 INFO - Running setup.py install for requests 05:26:17 INFO - Running setup.py install for docopt 05:26:17 INFO - Successfully installed blobuploader requests docopt 05:26:17 INFO - Cleaning up... 05:26:17 INFO - Return code: 0 05:26:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:17 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')]} 05:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:17 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')]} 05:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:17 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 0x7fb31c82af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa100>, '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 0x23ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', '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 05:26:17 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 05:26:17 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 05:26:17 INFO - Using env: {'DISPLAY': ':0', 05:26:17 INFO - 'HOME': '/home/cltbld', 05:26:17 INFO - 'LANG': 'en_US.UTF-8', 05:26:17 INFO - 'LANGUAGE': 'en_US:en', 05:26:17 INFO - 'LOGNAME': 'cltbld', 05:26:17 INFO - 'MAIL': '/var/mail/cltbld', 05:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:17 INFO - 'MOZ_NO_REMOTE': '1', 05:26:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:17 INFO - 'NO_EM_RESTART': '1', 05:26:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:17 INFO - 'PWD': '/builds/slave/test', 05:26:17 INFO - 'SHELL': '/bin/bash', 05:26:17 INFO - 'SHLVL': '1', 05:26:17 INFO - 'TERM': 'linux', 05:26:17 INFO - 'TMOUT': '86400', 05:26:17 INFO - 'USER': 'cltbld', 05:26:17 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', 05:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:17 INFO - '_': '/tools/buildbot/bin/python'} 05:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:18 INFO - Running setup.py (path:/tmp/pip-7mMg4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:18 INFO - Running setup.py (path:/tmp/pip-XCouoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:18 INFO - Running setup.py (path:/tmp/pip-am4699-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:18 INFO - Running setup.py (path:/tmp/pip-5IFLiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:18 INFO - Running setup.py (path:/tmp/pip-QXLpY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:18 INFO - Running setup.py (path:/tmp/pip-4epCh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:18 INFO - Running setup.py (path:/tmp/pip-_FPPBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:18 INFO - Running setup.py (path:/tmp/pip-imxkuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:18 INFO - Running setup.py (path:/tmp/pip-gcfVP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:18 INFO - Running setup.py (path:/tmp/pip-SA9H4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:18 INFO - Running setup.py (path:/tmp/pip-UGbYkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:18 INFO - Running setup.py (path:/tmp/pip-FQxvMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:18 INFO - Running setup.py (path:/tmp/pip-dPlo_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:19 INFO - Running setup.py (path:/tmp/pip-ixnyWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:19 INFO - Running setup.py (path:/tmp/pip-0EsBRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:19 INFO - Running setup.py (path:/tmp/pip-7d7d0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:19 INFO - Running setup.py (path:/tmp/pip-DYCNso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:26:19 INFO - Running setup.py install for manifestparser 05:26:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:26:19 INFO - Running setup.py install for mozcrash 05:26:19 INFO - Running setup.py install for mozdebug 05:26:19 INFO - Running setup.py install for mozdevice 05:26:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:26:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:26:19 INFO - Running setup.py install for mozfile 05:26:19 INFO - Running setup.py install for mozhttpd 05:26:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:26:19 INFO - Running setup.py install for mozinfo 05:26:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:26:20 INFO - Running setup.py install for mozInstall 05:26:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:26:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:26:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:26:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:26:20 INFO - Running setup.py install for mozleak 05:26:20 INFO - Running setup.py install for mozlog 05:26:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:26:20 INFO - Running setup.py install for moznetwork 05:26:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:26:20 INFO - Running setup.py install for mozprocess 05:26:20 INFO - Running setup.py install for mozprofile 05:26:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:26:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:26:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:26:20 INFO - Running setup.py install for mozrunner 05:26:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:26:20 INFO - Running setup.py install for mozscreenshot 05:26:20 INFO - Running setup.py install for moztest 05:26:21 INFO - Running setup.py install for mozversion 05:26:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:26:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:26:21 INFO - Cleaning up... 05:26:21 INFO - Return code: 0 05:26:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26: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')]} 05:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26: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')]} 05:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:21 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 0x7fb31c82af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa100>, '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 0x23ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', '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 05:26:21 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 05:26:21 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 05:26:21 INFO - Using env: {'DISPLAY': ':0', 05:26:21 INFO - 'HOME': '/home/cltbld', 05:26:21 INFO - 'LANG': 'en_US.UTF-8', 05:26:21 INFO - 'LANGUAGE': 'en_US:en', 05:26:21 INFO - 'LOGNAME': 'cltbld', 05:26:21 INFO - 'MAIL': '/var/mail/cltbld', 05:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:21 INFO - 'MOZ_NO_REMOTE': '1', 05:26:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:21 INFO - 'NO_EM_RESTART': '1', 05:26:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:21 INFO - 'PWD': '/builds/slave/test', 05:26:21 INFO - 'SHELL': '/bin/bash', 05:26:21 INFO - 'SHLVL': '1', 05:26:21 INFO - 'TERM': 'linux', 05:26:21 INFO - 'TMOUT': '86400', 05:26:21 INFO - 'USER': 'cltbld', 05:26:21 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', 05:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:21 INFO - '_': '/tools/buildbot/bin/python'} 05:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:21 INFO - Running setup.py (path:/tmp/pip-mKqFNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:21 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)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:21 INFO - Running setup.py (path:/tmp/pip-sPYiHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:21 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)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:21 INFO - Running setup.py (path:/tmp/pip-sN97Ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:21 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)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:21 INFO - Running setup.py (path:/tmp/pip-2uvWDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:21 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)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:21 INFO - Running setup.py (path:/tmp/pip-aEvTUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:21 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)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:21 INFO - Running setup.py (path:/tmp/pip-qH_W5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:21 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)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:21 INFO - Running setup.py (path:/tmp/pip-JD8TXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:21 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)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:21 INFO - Running setup.py (path:/tmp/pip-9_hh0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:21 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)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:21 INFO - Running setup.py (path:/tmp/pip-8FklpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:21 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)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:22 INFO - Running setup.py (path:/tmp/pip-dV8q9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:22 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)) 05:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:22 INFO - Running setup.py (path:/tmp/pip-NneWn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:22 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)) 05:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:22 INFO - Running setup.py (path:/tmp/pip-WPhjRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:22 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)) 05:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:22 INFO - Running setup.py (path:/tmp/pip-iWg86e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:22 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)) 05:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:22 INFO - Running setup.py (path:/tmp/pip-GyqdcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:22 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)) 05:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:22 INFO - Running setup.py (path:/tmp/pip-Obs6H_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:22 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)) 05:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:22 INFO - Running setup.py (path:/tmp/pip-7o3StP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:22 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)) 05:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:22 INFO - Running setup.py (path:/tmp/pip-Q1JQxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:22 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)) 05:26:22 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)) 05:26:22 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)) 05:26:22 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)) 05:26:22 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)) 05:26:22 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)) 05:26:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:26:22 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 05:26:22 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 05:26:22 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 05:26:22 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 05:26:22 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 05:26:22 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 05:26:24 INFO - Downloading blessings-1.6.tar.gz 05:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:26:24 INFO - Installing collected packages: blessings 05:26:24 INFO - Running setup.py install for blessings 05:26:24 INFO - Successfully installed blessings 05:26:24 INFO - Cleaning up... 05:26:24 INFO - Return code: 0 05:26:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:26:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:24 INFO - Reading from file tmpfile_stdout 05:26:24 INFO - Current package versions: 05:26:24 INFO - argparse == 1.2.1 05:26:24 INFO - blessings == 1.6 05:26:24 INFO - blobuploader == 1.2.4 05:26:24 INFO - docopt == 0.6.1 05:26:24 INFO - manifestparser == 1.1 05:26:24 INFO - mozInstall == 1.12 05:26:24 INFO - mozcrash == 0.16 05:26:24 INFO - mozdebug == 0.1 05:26:24 INFO - mozdevice == 0.48 05:26:24 INFO - mozfile == 1.2 05:26:24 INFO - mozhttpd == 0.7 05:26:24 INFO - mozinfo == 0.9 05:26:24 INFO - mozleak == 0.1 05:26:24 INFO - mozlog == 3.1 05:26:24 INFO - moznetwork == 0.27 05:26:24 INFO - mozprocess == 0.22 05:26:24 INFO - mozprofile == 0.28 05:26:24 INFO - mozrunner == 6.11 05:26:24 INFO - mozscreenshot == 0.1 05:26:24 INFO - mozsystemmonitor == 0.0 05:26:24 INFO - moztest == 0.7 05:26:24 INFO - mozversion == 1.4 05:26:24 INFO - psutil == 3.1.1 05:26:24 INFO - requests == 1.2.3 05:26:24 INFO - wsgiref == 0.1.2 05:26:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26: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')]} 05:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26: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')]} 05:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:24 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 0x7fb31c82af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa100>, '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 0x23ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', '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 05:26:24 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 05:26:24 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 05:26:24 INFO - Using env: {'DISPLAY': ':0', 05:26:24 INFO - 'HOME': '/home/cltbld', 05:26:24 INFO - 'LANG': 'en_US.UTF-8', 05:26:24 INFO - 'LANGUAGE': 'en_US:en', 05:26:24 INFO - 'LOGNAME': 'cltbld', 05:26:24 INFO - 'MAIL': '/var/mail/cltbld', 05:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:24 INFO - 'MOZ_NO_REMOTE': '1', 05:26:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:24 INFO - 'NO_EM_RESTART': '1', 05:26:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:24 INFO - 'PWD': '/builds/slave/test', 05:26:24 INFO - 'SHELL': '/bin/bash', 05:26:24 INFO - 'SHLVL': '1', 05:26:24 INFO - 'TERM': 'linux', 05:26:24 INFO - 'TMOUT': '86400', 05:26:24 INFO - 'USER': 'cltbld', 05:26:24 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', 05:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:24 INFO - '_': '/tools/buildbot/bin/python'} 05:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:25 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)) 05:26:25 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)) 05:26:25 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)) 05:26:25 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)) 05:26:25 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)) 05:26:25 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)) 05:26:25 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)) 05:26:25 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)) 05:26:25 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)) 05:26:25 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)) 05:26:25 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)) 05:26:25 INFO - Cleaning up... 05:26:25 INFO - Return code: 0 05:26:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:25 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 0x7fb31c82af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa100>, '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 0x23ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', '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 05:26:25 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 05:26:25 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 05:26:25 INFO - Using env: {'DISPLAY': ':0', 05:26:25 INFO - 'HOME': '/home/cltbld', 05:26:25 INFO - 'LANG': 'en_US.UTF-8', 05:26:25 INFO - 'LANGUAGE': 'en_US:en', 05:26:25 INFO - 'LOGNAME': 'cltbld', 05:26:25 INFO - 'MAIL': '/var/mail/cltbld', 05:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:25 INFO - 'MOZ_NO_REMOTE': '1', 05:26:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:25 INFO - 'NO_EM_RESTART': '1', 05:26:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:25 INFO - 'PWD': '/builds/slave/test', 05:26:25 INFO - 'SHELL': '/bin/bash', 05:26:25 INFO - 'SHLVL': '1', 05:26:25 INFO - 'TERM': 'linux', 05:26:25 INFO - 'TMOUT': '86400', 05:26:25 INFO - 'USER': 'cltbld', 05:26:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', 05:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:25 INFO - '_': '/tools/buildbot/bin/python'} 05:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:25 INFO - Downloading/unpacking jsonschema 05:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:26:27 INFO - Downloading/unpacking functools32 (from jsonschema) 05:26:27 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 05:26:27 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 05:26:27 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 05:26:27 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 05:26:27 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 05:26:27 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 05:26:27 INFO - Downloading functools32-3.2.3-2.tar.gz 05:26:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:26:27 INFO - warning: no files found matching '*.txt' 05:26:27 INFO - no previously-included directories found matching 'build' 05:26:27 INFO - no previously-included directories found matching 'dist' 05:26:27 INFO - no previously-included directories found matching '.git*' 05:26:27 INFO - Installing collected packages: jsonschema, functools32 05:26:27 INFO - Running setup.py install for functools32 05:26:27 INFO - warning: no files found matching '*.txt' 05:26:27 INFO - no previously-included directories found matching 'build' 05:26:27 INFO - no previously-included directories found matching 'dist' 05:26:27 INFO - no previously-included directories found matching '.git*' 05:26:27 INFO - Successfully installed jsonschema functools32 05:26:27 INFO - Cleaning up... 05:26:27 INFO - Return code: 0 05:26:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:27 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 0x7fb31c82af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa100>, '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 0x23ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', '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 05:26:27 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 05:26:27 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 05:26:27 INFO - Using env: {'DISPLAY': ':0', 05:26:27 INFO - 'HOME': '/home/cltbld', 05:26:27 INFO - 'LANG': 'en_US.UTF-8', 05:26:27 INFO - 'LANGUAGE': 'en_US:en', 05:26:27 INFO - 'LOGNAME': 'cltbld', 05:26:27 INFO - 'MAIL': '/var/mail/cltbld', 05:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:27 INFO - 'MOZ_NO_REMOTE': '1', 05:26:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:27 INFO - 'NO_EM_RESTART': '1', 05:26:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:27 INFO - 'PWD': '/builds/slave/test', 05:26:27 INFO - 'SHELL': '/bin/bash', 05:26:27 INFO - 'SHLVL': '1', 05:26:27 INFO - 'TERM': 'linux', 05:26:27 INFO - 'TMOUT': '86400', 05:26:27 INFO - 'USER': 'cltbld', 05:26:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', 05:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:27 INFO - '_': '/tools/buildbot/bin/python'} 05:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:27 INFO - Downloading/unpacking flake8 05:26:27 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 05:26:27 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 05:26:27 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 05:26:27 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 05:26:27 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 05:26:27 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 05:26:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:26:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:26:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:26:30 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 05:26:30 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 05:26:30 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 05:26:30 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 05:26:30 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 05:26:30 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 05:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:26:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:26:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:26:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:26:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:26:30 INFO - no previously-included directories found matching 'docs/_build' 05:26:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:26:30 INFO - Running setup.py install for pep8 05:26:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:26:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:26:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:26:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:26:30 INFO - no previously-included directories found matching 'docs/_build' 05:26:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:26:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:26:30 INFO - Cleaning up... 05:26:30 INFO - Return code: 0 05:26:30 INFO - Running post-action listener: _resource_record_post_action 05:26:30 INFO - Running post-action listener: _start_resource_monitoring 05:26:30 INFO - Starting resource monitoring. 05:26:30 INFO - ##### 05:26:30 INFO - ##### Running install step. 05:26:30 INFO - ##### 05:26:30 INFO - Running pre-action listener: _resource_record_pre_action 05:26:30 INFO - Running main action method: install 05:26:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:30 INFO - Reading from file tmpfile_stdout 05:26:30 INFO - Detecting whether we're running mozinstall >=1.0... 05:26:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:26:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:26:30 INFO - Reading from file tmpfile_stdout 05:26:30 INFO - Output received: 05:26:30 INFO - Usage: mozinstall [options] installer 05:26:30 INFO - Options: 05:26:30 INFO - -h, --help show this help message and exit 05:26:30 INFO - -d DEST, --destination=DEST 05:26:30 INFO - Directory to install application into. [default: 05:26:30 INFO - "/builds/slave/test"] 05:26:30 INFO - --app=APP Application being installed. [default: firefox] 05:26:30 INFO - mkdir: /builds/slave/test/build/application 05:26:30 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'] 05:26:30 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 05:26:46 INFO - Reading from file tmpfile_stdout 05:26:46 INFO - Output received: 05:26:46 INFO - /builds/slave/test/build/application/firefox/firefox 05:26:46 INFO - Running post-action listener: _resource_record_post_action 05:26:46 INFO - ##### 05:26:46 INFO - ##### Running run-tests step. 05:26:46 INFO - ##### 05:26:46 INFO - Running pre-action listener: _resource_record_pre_action 05:26:46 INFO - Running main action method: run_tests 05:26:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:26:46 INFO - Python 2.7.3 05:26:46 INFO - Return code: 0 05:26:46 INFO - grabbing minidump binary from tooltool 05:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:46 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 0x23aa100>, '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 0x23ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:26:46 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 05:26:46 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 05:26:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:26:46 INFO - Return code: 0 05:26:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:26:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:26:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:26:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:26:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:26:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:26:47 INFO - Return code: 0 05:26:47 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/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:26:47 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/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 05:26:47 INFO - Using env: {'DISPLAY': ':0', 05:26:47 INFO - 'HOME': '/home/cltbld', 05:26:47 INFO - 'LANG': 'en_US.UTF-8', 05:26:47 INFO - 'LANGUAGE': 'en_US:en', 05:26:47 INFO - 'LOGNAME': 'cltbld', 05:26:47 INFO - 'MAIL': '/var/mail/cltbld', 05:26:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:26:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:47 INFO - 'MOZ_NO_REMOTE': '1', 05:26:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:47 INFO - 'NO_EM_RESTART': '1', 05:26:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:47 INFO - 'PWD': '/builds/slave/test', 05:26:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:26:47 INFO - 'SHELL': '/bin/bash', 05:26:47 INFO - 'SHLVL': '1', 05:26:47 INFO - 'TERM': 'linux', 05:26:47 INFO - 'TMOUT': '86400', 05:26:47 INFO - 'USER': 'cltbld', 05:26:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899', 05:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:47 INFO - '_': '/tools/buildbot/bin/python'} 05:26:47 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/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:26:48 INFO - mozversion application_buildid: 20160301035440 05:26:48 INFO - mozversion application_changeset: bb1dbd40af536693f138bcfd4111760aef17723f 05:26:48 INFO - mozversion application_display_name: Nightly 05:26:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:26:48 INFO - mozversion application_name: Firefox 05:26:48 INFO - mozversion application_remotingname: firefox 05:26:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:26:48 INFO - mozversion application_vendor: Mozilla 05:26:48 INFO - mozversion application_version: 47.0a1 05:26:48 INFO - mozversion platform_buildid: 20160301035440 05:26:48 INFO - mozversion platform_changeset: bb1dbd40af536693f138bcfd4111760aef17723f 05:26:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:26:48 INFO - mozversion platform_version: 47.0a1 05:26:48 INFO - using testdate: 1456838808 05:26:48 INFO - actual date: 1456838808 05:26:48 INFO - starting webserver on 'localhost:52835' 05:26:48 INFO - SUITE-START | Running 2 tests 05:26:48 INFO - TEST-START | dromaeo_css 05:26:48 INFO - operating with platform_type : linux_ 05:26:48 INFO - Initialising browser for dromaeo_css test... 05:26:48 INFO - TEST-INFO | started process 16033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbOYg00/profile http://localhost:52835/getInfo.html) 05:26:52 INFO - PROCESS | 16033 | 05:26:52 INFO - PROCESS | 16033 | (process:16115): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:26:53 INFO - PROCESS | 16033 | __metrics Screen width/height:1600/1200 05:26:53 INFO - PROCESS | 16033 | colorDepth:24 05:26:53 INFO - PROCESS | 16033 | Browser inner width/height: 1024/697 05:26:53 INFO - PROCESS | 16033 | __metrics 05:26:53 ERROR - PROCESS | 16033 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:26:53 INFO - PROCESS | 16033 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:26:53 INFO - PROCESS | 16033 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:26:53 INFO - PROCESS | 16033 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:26:53 INFO - PROCESS | 16033 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:26:53 INFO - PROCESS | 16033 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:26:53 INFO - PROCESS | 16033 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:26:53 INFO - PROCESS | 16033 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:26:53 INFO - PROCESS | 16033 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:26:53 INFO - PROCESS | 16033 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:26:54 INFO - TEST-INFO | 16033: exit 0 05:26:54 INFO - Browser initialized. 05:26:54 INFO - Running cycle 1/1 for dromaeo_css test... 05:26:54 INFO - TEST-INFO | started process 16166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbOYg00/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:56 INFO - PROCESS | 16166 | 05:26:56 INFO - PROCESS | 16166 | (process:16225): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:27:06 INFO - PROCESS | 16166 | RSS: Main: 161517568 05:27:06 INFO - PROCESS | 16166 | 05:27:56 INFO - PROCESS | 16166 | 1456838876260 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] 05:30:06 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:52835/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52835/tests/dromaeo/cssquery-ext.html) 05:30:07 INFO - PROCESS | 16166 | RSS: Main: 168751104 05:30:07 INFO - PROCESS | 16166 | 05:33:09 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:52835/tests/dromaeo/cssquery-ext.html (next: http://localhost:52835/tests/dromaeo/cssquery-jquery.html) 05:33:10 INFO - PROCESS | 16166 | RSS: Main: 165236736 05:33:10 INFO - PROCESS | 16166 | 05:36:12 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:52835/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52835/tests/dromaeo/cssquery-mootools.html) 05:36:12 INFO - PROCESS | 16166 | RSS: Main: 166973440 05:36:12 INFO - PROCESS | 16166 | 05:39:14 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:52835/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52835/tests/dromaeo/cssquery-prototype.html) 05:39:15 INFO - PROCESS | 16166 | RSS: Main: 164937728 05:39:15 INFO - PROCESS | 16166 | 05:42:17 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:52835/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52835/tests/dromaeo/cssquery-yui.html) 05:42:18 INFO - PROCESS | 16166 | RSS: Main: 165928960 05:42:18 INFO - PROCESS | 16166 | 05:45:20 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:52835/tests/dromaeo/cssquery-yui.html (next: http://localhost:52835/tests/dromaeo/cssquery-dojo.html) 05:45:20 INFO - PROCESS | 16166 | RSS: Main: 168673280 05:45:20 INFO - PROCESS | 16166 | 05:45:20 INFO - PROCESS | 16166 | __start_tp_report 05:45:20 INFO - PROCESS | 16166 | _x_x_mozilla_page_load 05:45:20 INFO - PROCESS | 16166 | _x_x_mozilla_page_load_details 05:45:20 INFO - PROCESS | 16166 | |i|pagename|runs| 05:45:20 INFO - PROCESS | 16166 | |0;dojo.html;2641.5509363408223;2677.973220267797;2712.077893516205;2713.389487365343;2723.550614148665;4564.657650676196;4568.31475278708;4587.862364129073;4608.446986361637;4631.60631346336;4468.039371535119;4539.546045395458;4585.656075794321;4634.073185362932;4646.930296045562;4192.937105943406;4235.8093885775215;4286.906838756128;4289.613934745872;4303.849365272216;40.02964264054159;4132.173565286939;4138.213739389522;4168.1038576706005;4316.935245971313;4161.9583804161875;4169.499660040799;4186.790660466964;4210.284251677192;4302.483701955754;4176.540580536139;4194.496660400741;4198.202341555095;4205.137946720914;4212.789360531991;4102.610252026053;4187.853425130106;4203.4115223868685;4209.494860616715;4234.851780187679;4369.847055353079;4505.324201369821;4520.638348932078;4522.6155776759015;4566.018306064212;4893.902121957576;4894.583960363373;4913.926291105637;4927.5318844710055;4950.579200767939;4737.526247375269;4814.75926203692;4901.362822833009;4902.607791376681;4986.825461108844;4540.228161212602;4554.180247555439;4558;4575.862724118282;4587.357769912215;4966.602671786249;4976.104301225814;4986.775595098229;4994.5754610858485;4997.725125118153;4622.329762184464;4780.1873681474235;4796.160671882407;4839.733814640229;4863.829765958175;4872.707637541688;4886.706797592155;4893.681910675795;4920.261960705922;4924.089043526959;4810.8797280068275;4811.542903424239;4823.348847905558;4827.806887724451;4875.488073752205;4689.812407503729;4780.856574302777;4791.065742180311;4851.393575803025;4863.80544778212;4034.152827906114;4038.63652271297;4040.252553277653;4042.676585873182;4066.4510291110914;3563.501109844624;3563.6970857476886;3582.6417358263966;3594.370985077601;3609.3864043112735;4053.250148722496;4200.873973780792;4263.126059157865;4265.722728022669;4285.807138678767;4770.737609431515;4773.474917759044;4789.185838407479;4858.1012512685265;4958.429780575208;4206.47419072616;4242.490901091827;4249.532551419341;4266.893327666833;4283.721558098714;4191.140816132685;4266.935995960063;4364.236258654722;4369.475662920407;4372.600767754352;4662.044280922402;4700.905981880275;4714;4727.361806156194;4737.952620473751;4852.1508735971765;4888.780004899717;4895.314655948099;4913.1893237615395;4939.407271127488;4505.932411013903;4572.588467037849;4629.629629629554;4650.604698600657;4710.175719249186;4841.709497430165;4843.588294994965;4861.343718598086;4877.268409738425;4906.803727850846;4907.460179380337;4911.58251548608;4924.9507504924495;4930.630202734737;4938.38270216223;4592.15045216636;4599.333096701027;4691.50739172382;4781.4740378557635;4807.879803004953;4770;4775.6179505638775;4777.0684716479955;4787.01866117452;4809.989902120594;4608.792604332746;4647.55848194421;4654.86035418938;4659.44086709597;4695.506971768052;4641.907161856811;4747.454042785124;4808.206645903387;4809.326694262736;4815.133276010351;4612.976935115303;4617.630589552895;4636.582707556337;4649.232876575463;4694.248920172756 05:45:20 INFO - PROCESS | 16166 | |1;ext.html;490.62957467112324;494.8317572025513;524.0985504931516;525.7739172155976;527.8944211157769;29445;29723.554146687762;29758;29820.850895745545;29869.253268668293;33315.333693326116;33948.32103357931;34220.31559368811;34222;34370.31259374811;7354.96322518388;7550.886736698926;7564.432667549928;7588.051493563305;7589.582572958485;7386.667599958015;7521.435892308072;7542.019537460123;7542.170361260257;7545.17003129658;7476.102867655889;7510.986016887732;7575.810604734871;7639.04511936008;7643;7473.6263186840715;7484.812879677997;7501.624918754068;7557.282058204517;7589.772306830804;7457.105147382349;7490.588017659026;7537.434692398037;7539.208383119748;7578.166401695809;31172.688273117434;31713.20716982094;31732.206694832585;31790.046298610847;31876.20309492258;2629.3426643339167;2719.578465337876;2720.8231464954715;2806.3825958289144;2807.1157585360547;26330.6050409244;26618.6007209892;26993.460130797273;27269.181924542296;27514.862425687945;3286.8356582171036;3298.0600528849404;3316.469364901604;3324.3185147044796;3355.731541476676;215313;215599;215813;216192;216531;36468;47701.761491193014;47815.282770758466;48001;48174.5182548177;34174.316513670085;34337.141571460415;34348;34485.827570862486;34693.82653086718;12169.452374643162;12210.08424368176;12241;12255.325957072268;12329.383530823423;10019.348742331726;10061.346012509164;10106.949465252626;10123.088921996909;10148.492575371201;12109.878901211052;12323.630291091282;12391.566295179626;12434.689132771753;12500.062495312888;5048.72232027242;5163.793448262028;5164.509371609691;5182.067227899014;5247.2653828464045;763.2863272839912;775.011859878648;793.1750978981794;815.7022686719423;838.6310023589601;23724.762752372255;23780.643290350657;24249.51500970006;24499.87750061274;24762.380940476272;917.1882883648019;965.9178969787647;1018.33808024783;1022.1618273016204;1056.5826498533036;12334.142778074065;12697.128185146918;12746.298953557458;12773.361331933365;13057.477700891857;258876;258876;261091;261647;264539;41719.1656166875;41914;41956.37065444021;41960.160796784505;41965.790171048946;1005.8390657494766;1060.0989159214605;1097.2812807611028;1098.2641630107687;1102.7573933734566;23806.523869522167;24629.261122166365;26057;27224.591631125946;28976.42047159087;39755.60244397519;40045.39931900966;40397.798011009756;40446.393304099875;40446.393304099875;252540;254689;255772;256239;256260;31792.68207317897;35810.64189358177;36190;36292.81853590715;36731.63268367282;32357.191070223435;32401.837990809894;33302.66697332996;33341.16647083842;33558.328833423686;27545.173644790688;27683.307917302227;27879;28180.577291340236;28194;28752.137435876957;28845.855770721013;28869;29059.564106537997;29364;28351.149465516068;30427.54358684666;30796.230094246926;35151.82424087863;35585.90762062396;30534.694653053186;31224.375512490078;31382.372352553277;31723.20691982719;31915.840420797747;24858;25691.871540642176;25989.610155848055;25996.480070398866;26062.21813345527 05:45:20 INFO - PROCESS | 16166 | |2;jquery.html;304.6953046953047;306.90639354996745;312.98748050077995;315.9668234835342;322.2973916861243;14683;15216.391344346226;15218.771718424205;15260.160691161982;16520.58698532537;13580.524681636145;13820.447182112728;14066.296685165751;14071.437142514313;14119.647008824784;4773.952260477394;4932.5807306379;4934.481879402665;4945.159322915095;4977.950220497785;4660.836870709526;4826.107170173529;4877.561019508244;4907.9263811042865;4945.653804233705;4879.048585525824;4879.658423910328;4894.1679914414635;4894.877628059309;4895.706257624536;4829.879253018667;4854.2718592211095;4856.635752318591;4864.635152363587;4874.585660218903;4310.504292006428;4617.7691115444095;4816.51834816519;4830.2030165022725;4834.226523756217;16709.164541772985;16887.324507019704;16945.406910758065;16990.660186796318;17120.486385408334;1770.1503278426298;1812.3203798575535;1866.1975350599237;1880.8307252347217;1889.3009586452963;7977.282044615954;8302.294304984083;8546.52994085325;8575.528345940971;8586.356023298278;1587.261923205715;1694.5170626371548;1740.5474576610045;1745.23209787693;1911.9044047797693;39502.60497395018;47760;48505.272420914065;48909;49564.256536151624;9377.484238366818;9560.426374417557;9698.224142068617;9708;9860.45767482781;11944.64166075019;12118.575849845389;12181.512739490498;12192;12197;6596.472282217507;6709.7316107355155;6726.159230096238;6781.118454600969;6785.59286442815;6272.090546870678;6272.3100458949475;6313.810585682345;6392.84017899547;6392.968035159794;4047.5750046245307;4084.448599439097;4134.441850350225;4181.080162364275;4190.329547272422;1682.9242684079245;1710.615111599905;1717.7509261157063;1746.550363198542;1756.3413719855055;818.2226884459787;828.113918107619;863.7883718489011;884.8407286688329;900.617237673999;14904.62738431548;15011.174385408689;15082.170480623452;15148.16685082331;15195.848041519665;791.2206476620524;802.7471346525825;814.771863878115;822.6832669422315;822.7120507822334;8464.661413543512;8533.677280021606;8607.827843443096;8623.956880215685;8650.697225597074;351503;355748;359857;360781;365721;41256;62218.377816222164;63209.367906320345;63929.36070639327;64182.679086604265;831.3183189784319;844.7634662294568;848.8811566380836;849.3120572336427;855.0807881527259;13465.326733663082;13583.728325433634;13633.113847599874;13750.174989500661;13818.723625527635;20498.38504844857;28664.14007579776;30469.54295685522;31085.844570777;31101.844490777403;40214.39678404885;41743;42198.57801422069;43333.56666433421;43353.56646433495;6605.867882642417;6767.044493317575;6772.898406524005;6813.318668133147;6975.6163411012885;9777.41335519871;10300.484975751333;10581.100606448537;11087;11132.610358637408;9195.586198621211;9575.425474471554;9622.855657165288;9686.612535498783;9772.26707996889;9623.903760962301;9715.07706767856;9765.707028789147;9813.705588832347;9947.05502977216;9676;10073.748156296151;10093.142082923034;10130.898691012995;10170.135538479311;6899.17209934811;7140.428765698835;7154.35610795031;7171.318724721144;7180.640967951686;7430.628468576658;9922.801543969224;9946.502674866084;10017.799644007226;10123.443210623487 05:45:20 INFO - PROCESS | 16166 | |3;mootools.html;1139.0318229504921;1146.7362506623476;1149.8792626774186;1356.2676154876374;1396.6298930783337;6002.8799424011495;6171.9382806171925;6860.725570977161;7029.718811247551;7032.50772445929;6444.871102577946;6656.534042617019;6664.833379165511;6675.566088204276;6699.598024118556;1970.8423326133945;1980.3563841751416;1986.5530255692427;1997.6104659591385;1999.9200031998703;1944.1542928825936;1977.980220197794;1978.297704314962;1981.0094952523739;1993.920243190278;1944.222311075574;1959.3142400159902;1961.7155512450686;1964.3321270767935;1968.6554852900686;1998.940031799041;2014.0835919656522;2025.0381068992258;2028.3103744726716;2033.7559492860803;1970.8620396572246;1972.763268407786;1975.6641370966827;2007.8192962633286;2009.6081264153495;6815.454763618898;6846.383825455683;6850.246472887979;6855.143107111611;6881.41507971823;3909.9413508797393;3971.920561588781;4047.170330082326;4051.9797401012806;4052.1085361220485;2491.53906527293;2503.7245902950663;2553.859537725424;2558.4243545202366;2638.8680565971817;808.6199486241458;815.9265666090021;826.2852632472868;828.5360198288978;839.836231934773;9467.52662366879;9518.381305215138;9533.90466095337;9542.379745316532;9544.61821527138;3688.5942546319884;3720.441933709911;3779.998300450383;3803.087259057806;3808.352580061396;8168.224018718212;8172.264496195371;8177.5502347370275;8177.632006559719;8223.136570660114;3940.6059394060367;3983.7211395202057;3985.8405663773124;3989;3996.660283875903;3039.7720170987263;3499.6675315844955;3569.0720412692367;3578.355895938756;3583.211693427442;3215.1962009497624;3248.4964830451318;3276.2955964467756;3289.983550082234;3294.1105901406963;997.1374760831828;1005.703317521333;1005.8994100589882;1009.5002973528151;1013.3836530733469;972.4262685015875;992.0228574853763;993.180625983552;1002.1431675917132;1021.0096206679509;6146.754129834846;6179.134921111048;6244.937550624527;6284.842878928063;6347.270063942613;411.07303031663406;411.2576798877994;416.2923030847511;417.66169402783845;419.09893728484;4772.331873537708;4772.928406073912;4778.331033655291;4787.8563643090765;4819.228923372244;7968.0438347398685;7974.800629984296;8179.304759095425;8187.836243275101;8397.538135402612;8429.789255268668;8450.788730281669;8479.703210387606;8481.40630155883;8481.703140390056;6524.706388212542;6634.0712300278;6655.267920528738;6674.899876501953;6689.799306020827;6066.666333351532;6196.969015154896;6205.069239614094;6206.813795586139;6221.9377806223165;7373.3732632726815;7381;7576.090869095744;7615.390768738377;7673.040869891263;7477.813054673677;7699.34555562761;7738.4969976951315;7988.520688758693;8000.839983200187;5232.816851410183;5913.2608423947;6110.327863935053;6224.097505861715;6264.968675156595;6456.096146539394;6489.837754055998;6552;6562.901556476752;6596.142501474777;5709.743061562157;5757.568182386254;5770.596058275881;5816.738246778989;6023.096535519707;5485.424030476902;5597.27235459404;5598.888022239614;5637.126245431965;5681.034224181816;6127.816165515042;6216.658083805434;6230.7819226326865;6232.25212974446;6245.6252624842655;5565.471280228372;5580.107182850725;5582.162675598693;5638.774449022158;5665.150227465913;5768.077107662753;5820.534357251495;5843.474087332161;5858.8242352729485;5866.090755932837 05:45:20 INFO - PROCESS | 16166 | |4;prototype.html;275.2266132168605;279.9062314124768;280.9520488577604;284.147557328016;286.36712864569296;5482.972585137074;5518.779248830047;5575.665460072399;5616.66300021999;5629.971850140754;5262.079136151177;5415.64798288112;5417.160340147274;5439.347278326606;5491.176323551469;3905.3360928642055;4061.512618485786;4137.834486620532;4176.832926682944;4183.142455796555;4164.646005089556;4166.166766646667;4170.58294170582;4171.4994200695955;4172.833086676529;4126.5667104954;4132.586741325874;4133.896652583694;4138.503379594453;4142.8135733891895;4101.159262351211;4131.979340103296;4136.98643832263;4137.110521237948;4150.149219410029;3550.9644903551152;3552.0587044433246;3555.9466608000903;3561.910952226215;3563.1626567756557;5307.177387504943;5317.149256119041;5320.095583750772;5321.973390133063;5341.519263266286;4467.3299005149165;4645.605123564467;4747.477777444513;4763.69036012658;4771.952280477186;5708.743106560215;5714.000049991235;5750.511206547407;5779.88440231193;5779.971100144515;3770.1140232045445;3770.359038963383;3771.830267637963;3774.943015955537;3781.243751249761;6031.396860313977;6097.69511524422;6098.32918378978;6098.35967223444;6107.175531303262;3972.920541589152;3976.5426975897562;3976.940345894814;3978.0651546886456;3982.3628219484744;4038.4749982502085;4040;4041.191761647682;4043.0498832774274;4055.8174882130374;4525.298578720303;4700.412448443944;4721.315409265706;4734.431868175772;4734.455537613149;5712.942870571324;5716.42835716425;5753.683547404849;5787.074068149076;5813.6221145625395;1389.319233575561;1394.414345974693;1399.2723783632455;1401.9719605607831;1404.4101477379525;921.5991043895792;922.3681777981969;936.8547875079373;946.9678050924525;947.7204224753714;5026.673266237683;5037.697738135724;5038.722870242172;5042.571381432619;5054;6005.429484198994;6039.54703397247;6042.274927008787;6047.3045599755715;6070.362611925684;4952.851414457572;5022.748862556858;5045.924311135336;5058.392992840809;5065.936153407825;3230.499272612749;3278.7704860659524;3295.35740530599;3297.258116923673;3299.736021118305;5759.22250496186;5761.049426844524;5763.942360576424;5767.596268261182;5771.278590176228;6249.281332646713;6276.184096067574;6278.654673992883;6292.276388215322;6308.58994165387;5737.540996720252;5738.081906894877;5740.1963725077685;5745.396733343023;5747.6838773867;5931.851703707442;5939.376365481735;5998.070299103646;6034.607750496204;6116.418940200674;5843.561732869966;5843.94156058451;5847.327557330961;5880.911786323123;5923.808190969369;5724.169995350734;5736.053551164011;5739.770409183586;5741;5741.5119714824705;4067.6745860331694;4107.137501124797;4109.3425051991535;4113.444684967611;4118.917621647491;5884.146798714248;5919.319278283053;5921.111833225051;5923.851903702442;5934.762609495572;5518.06192947208;5636.689982051026;5677;5696.430356964271;5696.971515142398;5661.830145095653;5679.346875109415;5681.77272909079;5686.175504551899;5694.231278777312;5496.780128794963;5537.446255374431;5539.667619942817;5543.667379957215;5548.389677135431;5676.063449530781;5698.373178950395;5737.684427356368;5741.425857414392;5747.655140691572;5486.369067557282;5513.8345849624575;5528.834134975958;5542.168674698827;5547.195656629686 05:45:20 INFO - PROCESS | 16166 | |5;yui.html;546.1752753342452;548.838092762635;549.2859282932187;588.612908004543;592.6355291495731;9883.703488895335;9906.257030722707;9906.950465247683;9942;9961.950190249057;8850.380473366868;10629.096526795212;10631.78736425273;10650;10683.78632427351;640.4780104215073;659.663571578496;660.5145218264572;663.0683889135772;668.4351722794231;658.9967050164743;660.0923729871427;664.1830548425439;665.7769647168204;669.2437545573495;689;692.5533031194876;693.0539813155058;693.3032302535944;695.8190870373714;677.2685499660355;689.2280645676849;691.2327316678483;695.8364784275691;695.9930400695979;508.59312549959884;512.912804823181;513.278843225269;518.1838604198402;523.9030779305803;10349.63776267827;10614.150867930546;10615.84076238857;10678.305910115818;10757.085647719954;10711.517981690842;10774.5690172393;10993.890061099366;11139.944300278528;11167;8821.382503224777;8874.423162494482;8941.150590693938;8985.6855010075;9068.455892646462;3188.1551388881967;3195.0571936198653;3251.7398608111293;3257.462518684414;3304.487804390323;37845.432318515246;38306.42540361897;38441.23117537662;38630.22739545222;38889.22221555581;8024;8116;8183.345332373515;8271.669133234724;8351.331893448509;13884.166949982831;13910.86089139116;14022;14038.438462461592;14043;5717.656940583578;5806.767729290866;6107.053406721876;6110.847228819315;6170.197874276315;3135.3885992231294;3173.0639461358955;3241.2059045533997;3279.0818570800216;3537.876174333886;2338.894749736266;2353.9176128835406;2354.4937838364835;2355.2698663414394;2373.9050437982633;441.9381286619876;449.7841036302593;452.3328091065652;463.4994206257234;467.0915070188451;406.625904168166;482.645255737033;490.6124161912121;492.3500978708071;495.30657080087445;6833.282505336968;6924.4114250288285;6930.306969303029;7093.0424392707355;7128.572285662877;472.67857856657804;477.67756764184037;485.42962019627504;489.41270475429627;502.5000124875699;3111.5177147542167;3120.40712264669;3243.0757234188145;3247.8376081195847;3328.6005679318637;46076.7696161517;47090.82272943204;47167.29249061267;47345.5265447348;48062.03875922462;42543;42775.7861210692;43158;43504.78247608805;43586.346204806956;39569.40645890314;40028.59971400307;40115.398269025405;40914.386284205764;41251.38122928098;6169.537284703575;6265.8120256392385;6278.466330361788;6285.182926219562;6601.306862779531;30602.540961885144;30859.228519287197;30943.535846961862;31297.374052518368;31602.209944750644;37104.25791484209;38202.617973819906;38821.80589097036;38975.6102438972;39106.2178756429;8053.114157442559;8057.83884322322;8161.3062889652665;8353.916460835313;8439.367047471342;8797.47215167092;8809.11908809114;8857.911420885966;8874.556272186235;8932.821343573221;8962.910370896208;9029.593668284811;9042.90957090447;9064.818703626022;9188.724338269863;8080.111187769223;8106.635201416068;8120.35037197011;8201.056878459054;8253.669853205805;8506;8536.31709463229;8556.957215213884;8563.61463734146;8749.256313213193;7334.963325183553;7396.297351751575;7522.849543009219;7586.6206689664195;7776.300132988058;6486.708098135501;6772.458203343819;6912.654367281515;6981.162260528769;6984.720611175496 05:45:20 INFO - PROCESS | 16166 | __end_tp_report 05:45:20 INFO - PROCESS | 16166 | __start_cc_report 05:45:20 INFO - PROCESS | 16166 | _x_x_mozilla_cycle_collect,359 05:45:20 INFO - PROCESS | 16166 | __end_cc_report 05:45:20 INFO - PROCESS | 16166 | __startTimestamp1456839920963__endTimestamp 05:45:20 INFO - PROCESS | 16166 | 05:45:20 INFO - PROCESS | 16166 | ------- Summary: start ------- 05:45:20 INFO - PROCESS | 16166 | Number of tests: 6 05:45:20 INFO - PROCESS | 16166 | 05:45:20 INFO - PROCESS | 16166 | [#0] dojo.html Cycles:165 Average:4484.48 Median:4634.07 stddev:574.26 (12.4%) stddev-sans-first:557.53 05:45:20 INFO - PROCESS | 16166 | Values: 2641.6 2678.0 2712.1 2713.4 2723.6 4564.7 4568.3 4587.9 4608.4 4631.6 4468.0 4539.5 4585.7 4634.1 4646.9 4192.9 4235.8 4286.9 4289.6 4303.8 40.0 4132.2 4138.2 4168.1 4316.9 4162.0 4169.5 4186.8 4210.3 4302.5 4176.5 4194.5 4198.2 4205.1 4212.8 4102.6 4187.9 4203.4 4209.5 4234.9 4369.8 4505.3 4520.6 4522.6 4566.0 4893.9 4894.6 4913.9 4927.5 4950.6 4737.5 4814.8 4901.4 4902.6 4986.8 4540.2 4554.2 4558.0 4575.9 4587.4 4966.6 4976.1 4986.8 4994.6 4997.7 4622.3 4780.2 4796.2 4839.7 4863.8 4872.7 4886.7 4893.7 4920.3 4924.1 4810.9 4811.5 4823.3 4827.8 4875.5 4689.8 4780.9 4791.1 4851.4 4863.8 4034.2 4038.6 4040.3 4042.7 4066.5 3563.5 3563.7 3582.6 3594.4 3609.4 4053.3 4200.9 4263.1 4265.7 4285.8 4770.7 4773.5 4789.2 4858.1 4958.4 4206.5 4242.5 4249.5 4266.9 4283.7 4191.1 4266.9 4364.2 4369.5 4372.6 4662.0 4700.9 4714.0 4727.4 4738.0 4852.2 4888.8 4895.3 4913.2 4939.4 4505.9 4572.6 4629.6 4650.6 4710.2 4841.7 4843.6 4861.3 4877.3 4906.8 4907.5 4911.6 4925.0 4930.6 4938.4 4592.2 4599.3 4691.5 4781.5 4807.9 4770.0 4775.6 4777.1 4787.0 4810.0 4608.8 4647.6 4654.9 4659.4 4695.5 4641.9 4747.5 4808.2 4809.3 4815.1 4613.0 4617.6 4636.6 4649.2 4694.2 05:45:20 INFO - PROCESS | 16166 | 05:45:20 INFO - PROCESS | 16166 | [#1] ext.html Cycles:180 Average:38357.10 Median:31718.21 stddev:63880.86 (201.4%) stddev-sans-first:63996.79 05:45:20 INFO - PROCESS | 16166 | Values: 490.6 494.8 524.1 525.8 527.9 29445.0 29723.6 29758.0 29820.9 29869.3 33315.3 33948.3 34220.3 34222.0 34370.3 7355.0 7550.9 7564.4 7588.1 7589.6 7386.7 7521.4 7542.0 7542.2 7545.2 7476.1 7511.0 7575.8 7639.0 7643.0 7473.6 7484.8 7501.6 7557.3 7589.8 7457.1 7490.6 7537.4 7539.2 7578.2 31172.7 31713.2 31732.2 31790.0 31876.2 2629.3 2719.6 2720.8 2806.4 2807.1 26330.6 26618.6 26993.5 27269.2 27514.9 3286.8 3298.1 3316.5 3324.3 3355.7 215313.0 215599.0 215813.0 216192.0 216531.0 36468.0 47701.8 47815.3 48001.0 48174.5 34174.3 34337.1 34348.0 34485.8 34693.8 12169.5 12210.1 12241.0 12255.3 12329.4 10019.3 10061.3 10106.9 10123.1 10148.5 12109.9 12323.6 12391.6 12434.7 12500.1 5048.7 5163.8 5164.5 5182.1 5247.3 763.3 775.0 793.2 815.7 838.6 23724.8 23780.6 24249.5 24499.9 24762.4 917.2 965.9 1018.3 1022.2 1056.6 12334.1 12697.1 12746.3 12773.4 13057.5 258876.0 258876.0 261091.0 261647.0 264539.0 41719.2 41914.0 41956.4 41960.2 41965.8 1005.8 1060.1 1097.3 1098.3 1102.8 23806.5 24629.3 26057.0 27224.6 28976.4 39755.6 40045.4 40397.8 40446.4 40446.4 252540.0 254689.0 255772.0 256239.0 256260.0 31792.7 35810.6 36190.0 36292.8 36731.6 32357.2 32401.8 33302.7 33341.2 33558.3 27545.2 27683.3 27879.0 28180.6 28194.0 28752.1 28845.9 28869.0 29059.6 29364.0 28351.1 30427.5 30796.2 35151.8 35585.9 30534.7 31224.4 31382.4 31723.2 31915.8 24858.0 25691.9 25989.6 25996.5 26062.2 05:45:20 INFO - PROCESS | 16166 | 05:45:20 INFO - PROCESS | 16166 | [#2] jquery.html Cycles:180 Average:21155.18 Median:4832.21 stddev:58684.55 (1214.4%) stddev-sans-first:58828.29 05:45:20 INFO - PROCESS | 16166 | Values: 304.7 306.9 313.0 316.0 322.3 14683.0 15216.4 15218.8 15260.2 16520.6 13580.5 13820.4 14066.3 14071.4 14119.6 4774.0 4932.6 4934.5 4945.2 4978.0 4660.8 4826.1 4877.6 4907.9 4945.7 4879.0 4879.7 4894.2 4894.9 4895.7 4829.9 4854.3 4856.6 4864.6 4874.6 4310.5 4617.8 4816.5 4830.2 4834.2 16709.2 16887.3 16945.4 16990.7 17120.5 1770.2 1812.3 1866.2 1880.8 1889.3 7977.3 8302.3 8546.5 8575.5 8586.4 1587.3 1694.5 1740.5 1745.2 1911.9 39502.6 47760.0 48505.3 48909.0 49564.3 9377.5 9560.4 9698.2 9708.0 9860.5 11944.6 12118.6 12181.5 12192.0 12197.0 6596.5 6709.7 6726.2 6781.1 6785.6 6272.1 6272.3 6313.8 6392.8 6393.0 4047.6 4084.4 4134.4 4181.1 4190.3 1682.9 1710.6 1717.8 1746.6 1756.3 818.2 828.1 863.8 884.8 900.6 14904.6 15011.2 15082.2 15148.2 15195.8 791.2 802.7 814.8 822.7 822.7 8464.7 8533.7 8607.8 8624.0 8650.7 351503.0 355748.0 359857.0 360781.0 365721.0 41256.0 62218.4 63209.4 63929.4 64182.7 831.3 844.8 848.9 849.3 855.1 13465.3 13583.7 13633.1 13750.2 13818.7 20498.4 28664.1 30469.5 31085.8 31101.8 40214.4 41743.0 42198.6 43333.6 43353.6 6605.9 6767.0 6772.9 6813.3 6975.6 9777.4 10300.5 10581.1 11087.0 11132.6 9195.6 9575.4 9622.9 9686.6 9772.3 9623.9 9715.1 9765.7 9813.7 9947.1 9676.0 10073.7 10093.1 10130.9 10170.1 6899.2 7140.4 7154.4 7171.3 7180.6 7430.6 9922.8 9946.5 10017.8 10123.4 05:45:20 INFO - PROCESS | 16166 | 05:45:20 INFO - PROCESS | 16166 | [#3] mootools.html Cycles:180 Average:4736.73 Median:5793.67 stddev:2538.71 (43.8%) stddev-sans-first:2531.43 05:45:20 INFO - PROCESS | 16166 | Values: 1139.0 1146.7 1149.9 1356.3 1396.6 6002.9 6171.9 6860.7 7029.7 7032.5 6444.9 6656.5 6664.8 6675.6 6699.6 1970.8 1980.4 1986.6 1997.6 1999.9 1944.2 1978.0 1978.3 1981.0 1993.9 1944.2 1959.3 1961.7 1964.3 1968.7 1998.9 2014.1 2025.0 2028.3 2033.8 1970.9 1972.8 1975.7 2007.8 2009.6 6815.5 6846.4 6850.2 6855.1 6881.4 3909.9 3971.9 4047.2 4052.0 4052.1 2491.5 2503.7 2553.9 2558.4 2638.9 808.6 815.9 826.3 828.5 839.8 9467.5 9518.4 9533.9 9542.4 9544.6 3688.6 3720.4 3780.0 3803.1 3808.4 8168.2 8172.3 8177.6 8177.6 8223.1 3940.6 3983.7 3985.8 3989.0 3996.7 3039.8 3499.7 3569.1 3578.4 3583.2 3215.2 3248.5 3276.3 3290.0 3294.1 997.1 1005.7 1005.9 1009.5 1013.4 972.4 992.0 993.2 1002.1 1021.0 6146.8 6179.1 6244.9 6284.8 6347.3 411.1 411.3 416.3 417.7 419.1 4772.3 4772.9 4778.3 4787.9 4819.2 7968.0 7974.8 8179.3 8187.8 8397.5 8429.8 8450.8 8479.7 8481.4 8481.7 6524.7 6634.1 6655.3 6674.9 6689.8 6066.7 6197.0 6205.1 6206.8 6221.9 7373.4 7381.0 7576.1 7615.4 7673.0 7477.8 7699.3 7738.5 7988.5 8000.8 5232.8 5913.3 6110.3 6224.1 6265.0 6456.1 6489.8 6552.0 6562.9 6596.1 5709.7 5757.6 5770.6 5816.7 6023.1 5485.4 5597.3 5598.9 5637.1 5681.0 6127.8 6216.7 6230.8 6232.3 6245.6 5565.5 5580.1 5582.2 5638.8 5665.2 5768.1 5820.5 5843.5 5858.8 5866.1 05:45:20 INFO - PROCESS | 16166 | 05:45:20 INFO - PROCESS | 16166 | [#4] prototype.html Cycles:180 Average:4740.20 Median:5488.77 stddev:1435.59 (26.2%) stddev-sans-first:1399.96 05:45:20 INFO - PROCESS | 16166 | Values: 275.2 279.9 281.0 284.1 286.4 5483.0 5518.8 5575.7 5616.7 5630.0 5262.1 5415.6 5417.2 5439.3 5491.2 3905.3 4061.5 4137.8 4176.8 4183.1 4164.6 4166.2 4170.6 4171.5 4172.8 4126.6 4132.6 4133.9 4138.5 4142.8 4101.2 4132.0 4137.0 4137.1 4150.1 3551.0 3552.1 3555.9 3561.9 3563.2 5307.2 5317.1 5320.1 5322.0 5341.5 4467.3 4645.6 4747.5 4763.7 4772.0 5708.7 5714.0 5750.5 5779.9 5780.0 3770.1 3770.4 3771.8 3774.9 3781.2 6031.4 6097.7 6098.3 6098.4 6107.2 3972.9 3976.5 3976.9 3978.1 3982.4 4038.5 4040.0 4041.2 4043.0 4055.8 4525.3 4700.4 4721.3 4734.4 4734.5 5712.9 5716.4 5753.7 5787.1 5813.6 1389.3 1394.4 1399.3 1402.0 1404.4 921.6 922.4 936.9 947.0 947.7 5026.7 5037.7 5038.7 5042.6 5054.0 6005.4 6039.5 6042.3 6047.3 6070.4 4952.9 5022.7 5045.9 5058.4 5065.9 3230.5 3278.8 3295.4 3297.3 3299.7 5759.2 5761.0 5763.9 5767.6 5771.3 6249.3 6276.2 6278.7 6292.3 6308.6 5737.5 5738.1 5740.2 5745.4 5747.7 5931.9 5939.4 5998.1 6034.6 6116.4 5843.6 5843.9 5847.3 5880.9 5923.8 5724.2 5736.1 5739.8 5741.0 5741.5 4067.7 4107.1 4109.3 4113.4 4118.9 5884.1 5919.3 5921.1 5923.9 5934.8 5518.1 5636.7 5677.0 5696.4 5697.0 5661.8 5679.3 5681.8 5686.2 5694.2 5496.8 5537.4 5539.7 5543.7 5548.4 5676.1 5698.4 5737.7 5741.4 5747.7 5486.4 5513.8 5528.8 5542.2 5547.2 05:45:20 INFO - PROCESS | 16166 | 05:45:20 INFO - PROCESS | 16166 | [#5] yui.html Cycles:180 Average:11255.92 Median:549.06 stddev:13461.44 (2451.7%) stddev-sans-first:13475.18 05:45:20 INFO - PROCESS | 16166 | Values: 546.2 548.8 549.3 588.6 592.6 9883.7 9906.3 9907.0 9942.0 9962.0 8850.4 10629.1 10631.8 10650.0 10683.8 640.5 659.7 660.5 663.1 668.4 659.0 660.1 664.2 665.8 669.2 689.0 692.6 693.1 693.3 695.8 677.3 689.2 691.2 695.8 696.0 508.6 512.9 513.3 518.2 523.9 10349.6 10614.2 10615.8 10678.3 10757.1 10711.5 10774.6 10993.9 11139.9 11167.0 8821.4 8874.4 8941.2 8985.7 9068.5 3188.2 3195.1 3251.7 3257.5 3304.5 37845.4 38306.4 38441.2 38630.2 38889.2 8024.0 8116.0 8183.3 8271.7 8351.3 13884.2 13910.9 14022.0 14038.4 14043.0 5717.7 5806.8 6107.1 6110.8 6170.2 3135.4 3173.1 3241.2 3279.1 3537.9 2338.9 2353.9 2354.5 2355.3 2373.9 441.9 449.8 452.3 463.5 467.1 406.6 482.6 490.6 492.4 495.3 6833.3 6924.4 6930.3 7093.0 7128.6 472.7 477.7 485.4 489.4 502.5 3111.5 3120.4 3243.1 3247.8 3328.6 46076.8 47090.8 47167.3 47345.5 48062.0 42543.0 42775.8 43158.0 43504.8 43586.3 39569.4 40028.6 40115.4 40914.4 41251.4 6169.5 6265.8 6278.5 6285.2 6601.3 30602.5 30859.2 30943.5 31297.4 31602.2 37104.3 38202.6 38821.8 38975.6 39106.2 8053.1 8057.8 8161.3 8353.9 8439.4 8797.5 8809.1 8857.9 8874.6 8932.8 8962.9 9029.6 9042.9 9064.8 9188.7 8080.1 8106.6 8120.4 8201.1 8253.7 8506.0 8536.3 8557.0 8563.6 8749.3 7335.0 7396.3 7522.8 7586.6 7776.3 6486.7 6772.5 6912.7 6981.2 6984.7 05:45:20 INFO - PROCESS | 16166 | -------- Summary: end -------- 05:45:20 INFO - PROCESS | 16166 | 05:45:21 INFO - PROCESS | 16166 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:21 INFO - PROCESS | 16166 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:21 INFO - PROCESS | 16166 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:21 INFO - PROCESS | 16166 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:21 INFO - PROCESS | 16166 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:21 INFO - PROCESS | 16166 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:21 INFO - PROCESS | 16166 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:21 INFO - PROCESS | 16166 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:21 INFO - PROCESS | 16166 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:21 INFO - PROCESS | 16166 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:21 INFO - TEST-INFO | 16166: exit 0 05:45:21 INFO - TEST-OK | dromaeo_css | took 1113512ms 05:45:21 INFO - TEST-START | kraken 05:45:21 INFO - operating with platform_type : linux_ 05:45:21 INFO - Initialising browser for kraken test... 05:45:21 INFO - TEST-INFO | started process 16409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9MZXw_/profile http://localhost:52835/getInfo.html) 05:45:25 INFO - PROCESS | 16409 | 05:45:25 INFO - PROCESS | 16409 | (process:16478): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:45:26 INFO - PROCESS | 16409 | __metrics Screen width/height:1600/1200 05:45:26 INFO - PROCESS | 16409 | colorDepth:24 05:45:26 INFO - PROCESS | 16409 | Browser inner width/height: 1024/697 05:45:26 INFO - PROCESS | 16409 | __metrics 05:45:26 ERROR - PROCESS | 16409 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:45:26 INFO - PROCESS | 16409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:26 INFO - PROCESS | 16409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:26 INFO - PROCESS | 16409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:26 INFO - PROCESS | 16409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:26 INFO - PROCESS | 16409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:26 INFO - PROCESS | 16409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:26 INFO - PROCESS | 16409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:26 INFO - PROCESS | 16409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:26 INFO - PROCESS | 16409 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:45:27 INFO - TEST-INFO | 16409: exit 0 05:45:27 INFO - Browser initialized. 05:45:27 INFO - Running cycle 1/1 for kraken test... 05:45:27 INFO - TEST-INFO | started process 16529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9MZXw_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:29 INFO - PROCESS | 16529 | 05:45:29 INFO - PROCESS | 16529 | (process:16584): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:45:39 INFO - PROCESS | 16529 | RSS: Main: 160989184 05:45:39 INFO - PROCESS | 16529 | 05:45:42 INFO - PROCESS | 16529 | Cycle 1(1): loaded http://localhost:52835/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52835/tests/kraken/driver.html?testName=audio-beat-detection) 05:45:43 INFO - PROCESS | 16529 | RSS: Main: 167493632 05:45:43 INFO - PROCESS | 16529 | 05:45:45 INFO - PROCESS | 16529 | Cycle 1(1): loaded http://localhost:52835/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52835/tests/kraken/driver.html?testName=audio-dft) 05:45:46 INFO - PROCESS | 16529 | RSS: Main: 169648128 05:45:46 INFO - PROCESS | 16529 | 05:45:49 INFO - PROCESS | 16529 | Cycle 1(1): loaded http://localhost:52835/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52835/tests/kraken/driver.html?testName=audio-fft) 05:45:50 INFO - PROCESS | 16529 | RSS: Main: 162504704 05:45:50 INFO - PROCESS | 16529 | 05:45:52 INFO - PROCESS | 16529 | Cycle 1(1): loaded http://localhost:52835/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52835/tests/kraken/driver.html?testName=audio-oscillator) 05:45:52 INFO - PROCESS | 16529 | RSS: Main: 163508224 05:45:52 INFO - PROCESS | 16529 | 05:45:54 INFO - PROCESS | 16529 | Cycle 1(1): loaded http://localhost:52835/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52835/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:45:55 INFO - PROCESS | 16529 | RSS: Main: 164945920 05:45:55 INFO - PROCESS | 16529 | 05:45:58 INFO - PROCESS | 16529 | Cycle 1(1): loaded http://localhost:52835/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52835/tests/kraken/driver.html?testName=imaging-darkroom) 05:45:59 INFO - PROCESS | 16529 | RSS: Main: 165294080 05:45:59 INFO - PROCESS | 16529 | 05:46:02 INFO - PROCESS | 16529 | Cycle 1(1): loaded http://localhost:52835/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52835/tests/kraken/driver.html?testName=imaging-desaturate) 05:46:03 INFO - PROCESS | 16529 | RSS: Main: 164659200 05:46:03 INFO - PROCESS | 16529 | 05:46:06 INFO - PROCESS | 16529 | Cycle 1(1): loaded http://localhost:52835/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52835/tests/kraken/driver.html?testName=json-parse-financial) 05:46:06 INFO - PROCESS | 16529 | RSS: Main: 165863424 05:46:06 INFO - PROCESS | 16529 | 05:46:08 INFO - PROCESS | 16529 | Cycle 1(1): loaded http://localhost:52835/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52835/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:46:09 INFO - PROCESS | 16529 | RSS: Main: 165666816 05:46:09 INFO - PROCESS | 16529 | 05:46:11 INFO - PROCESS | 16529 | Cycle 1(1): loaded http://localhost:52835/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52835/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:46:11 INFO - PROCESS | 16529 | RSS: Main: 164511744 05:46:11 INFO - PROCESS | 16529 | 05:46:14 INFO - PROCESS | 16529 | Cycle 1(1): loaded http://localhost:52835/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52835/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:46:14 INFO - PROCESS | 16529 | RSS: Main: 164519936 05:46:14 INFO - PROCESS | 16529 | 05:46:17 INFO - PROCESS | 16529 | Cycle 1(1): loaded http://localhost:52835/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52835/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:46:17 INFO - PROCESS | 16529 | RSS: Main: 165580800 05:46:17 INFO - PROCESS | 16529 | 05:46:20 INFO - PROCESS | 16529 | Cycle 1(1): loaded http://localhost:52835/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52835/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:46:21 INFO - PROCESS | 16529 | RSS: Main: 164708352 05:46:21 INFO - PROCESS | 16529 | 05:46:22 INFO - PROCESS | 16529 | Cycle 1(1): loaded http://localhost:52835/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52835/tests/kraken/driver.html?testName=ai-astar) 05:46:23 INFO - PROCESS | 16529 | RSS: Main: 167473152 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | __start_tp_report 05:46:23 INFO - PROCESS | 16529 | _x_x_mozilla_page_load 05:46:23 INFO - PROCESS | 16529 | _x_x_mozilla_page_load_details 05:46:23 INFO - PROCESS | 16529 | |i|pagename|runs| 05:46:23 INFO - PROCESS | 16529 | |0;ai-astar;116;112;113;114;114;127;115;114;115;115 05:46:23 INFO - PROCESS | 16529 | |1;audio-beat-detection;154;146;152;169;146;162;166;136;176;144 05:46:23 INFO - PROCESS | 16529 | |2;audio-dft;162;161;164;162;163;168;167;163;165;165 05:46:23 INFO - PROCESS | 16529 | |3;audio-fft;74;75;76;76;74;74;132;73;74;77 05:46:23 INFO - PROCESS | 16529 | |4;audio-oscillator;95;95;144;95;96;94;143;96;96;136 05:46:23 INFO - PROCESS | 16529 | |5;imaging-gaussian-blur;118;117;117;118;119;120;117;117;121;118 05:46:23 INFO - PROCESS | 16529 | |6;imaging-darkroom;148;149;148;148;147;147;148;148;148;151 05:46:23 INFO - PROCESS | 16529 | |7;imaging-desaturate;96;97;96;96;96;96;97;97;96;97 05:46:23 INFO - PROCESS | 16529 | |8;json-parse-financial;68;67;68;68;70;67;67;67;68;68 05:46:23 INFO - PROCESS | 16529 | |9;json-stringify-tinderbox;71;77;72;71;73;72;71;72;73;71 05:46:23 INFO - PROCESS | 16529 | |10;stanford-crypto-aes;91;86;84;94;86;86;87;84;87;85 05:46:23 INFO - PROCESS | 16529 | |11;stanford-crypto-ccm;130;123;133;124;128;126;130;125;132;129 05:46:23 INFO - PROCESS | 16529 | |12;stanford-crypto-pbkdf2;139;156;153;148;150;154;140;153;151;139 05:46:23 INFO - PROCESS | 16529 | |13;stanford-crypto-sha256-iterative;70;72;71;72;72;71;73;74;71;72 05:46:23 INFO - PROCESS | 16529 | __end_tp_report 05:46:23 INFO - PROCESS | 16529 | __start_cc_report 05:46:23 INFO - PROCESS | 16529 | _x_x_mozilla_cycle_collect,884 05:46:23 INFO - PROCESS | 16529 | __end_cc_report 05:46:23 INFO - PROCESS | 16529 | __startTimestamp1456839983189__endTimestamp 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | ------- Summary: start ------- 05:46:23 INFO - PROCESS | 16529 | Number of tests: 14 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.00 stddev:4.20 (3.6%) stddev-sans-first:4.45 05:46:23 INFO - PROCESS | 16529 | Values: 116.0 112.0 113.0 114.0 114.0 127.0 115.0 114.0 115.0 115.0 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:158.00 stddev:12.74 (8.1%) stddev-sans-first:13.51 05:46:23 INFO - PROCESS | 16529 | Values: 154.0 146.0 152.0 169.0 146.0 162.0 166.0 136.0 176.0 144.0 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.50 stddev:2.26 (1.4%) stddev-sans-first:2.28 05:46:23 INFO - PROCESS | 16529 | Values: 162.0 161.0 164.0 162.0 163.0 168.0 167.0 163.0 165.0 165.0 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | [#3] audio-fft Cycles:10 Average:80.50 Median:74.50 stddev:18.14 (24.3%) stddev-sans-first:19.08 05:46:23 INFO - PROCESS | 16529 | Values: 74.0 75.0 76.0 76.0 74.0 74.0 132.0 73.0 74.0 77.0 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:95.00 stddev:22.19 (23.4%) stddev-sans-first:22.95 05:46:23 INFO - PROCESS | 16529 | Values: 95.0 95.0 144.0 95.0 96.0 94.0 143.0 96.0 96.0 136.0 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.40 (1.2%) stddev-sans-first:1.48 05:46:23 INFO - PROCESS | 16529 | Values: 118.0 117.0 117.0 118.0 119.0 120.0 117.0 117.0 121.0 118.0 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 05:46:23 INFO - PROCESS | 16529 | Values: 148.0 149.0 148.0 148.0 147.0 147.0 148.0 148.0 148.0 151.0 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:46:23 INFO - PROCESS | 16529 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 97.0 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | [#8] json-parse-financial Cycles:10 Average:67.80 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 05:46:23 INFO - PROCESS | 16529 | Values: 68.0 67.0 68.0 68.0 70.0 67.0 67.0 67.0 68.0 68.0 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:72.00 stddev:1.83 (2.5%) stddev-sans-first:1.88 05:46:23 INFO - PROCESS | 16529 | Values: 71.0 77.0 72.0 71.0 73.0 72.0 71.0 72.0 73.0 71.0 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:86.50 stddev:3.16 (3.7%) stddev-sans-first:3.00 05:46:23 INFO - PROCESS | 16529 | Values: 91.0 86.0 84.0 94.0 86.0 86.0 87.0 84.0 87.0 85.0 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:129.50 stddev:3.40 (2.6%) stddev-sans-first:3.53 05:46:23 INFO - PROCESS | 16529 | Values: 130.0 123.0 133.0 124.0 128.0 126.0 130.0 125.0 132.0 129.0 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.30 Median:152.00 stddev:6.57 (4.3%) stddev-sans-first:6.04 05:46:23 INFO - PROCESS | 16529 | Values: 139.0 156.0 153.0 148.0 150.0 154.0 140.0 153.0 151.0 139.0 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:1.14 (1.6%) stddev-sans-first:1.00 05:46:23 INFO - PROCESS | 16529 | Values: 70.0 72.0 71.0 72.0 72.0 71.0 73.0 74.0 71.0 72.0 05:46:23 INFO - PROCESS | 16529 | -------- Summary: end -------- 05:46:23 INFO - PROCESS | 16529 | 05:46:23 INFO - PROCESS | 16529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:23 INFO - PROCESS | 16529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:23 INFO - PROCESS | 16529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:23 INFO - PROCESS | 16529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:23 INFO - PROCESS | 16529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:23 INFO - PROCESS | 16529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:23 INFO - PROCESS | 16529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:24 INFO - TEST-INFO | 16529: exit 0 05:46:24 INFO - TEST-OK | kraken | took 62564ms 05:46:24 INFO - SUITE-END | took 1176s 05:46:24 INFO - Completed test suite (00:19:36) 05:46:24 INFO - Working with test: dromaeo_css 05:46:24 INFO - Generating results file: dromaeo_css 05:46:24 INFO - Working with test: kraken 05:46:24 INFO - Generating results file: kraken 05:46:24 INFO - javascript benchmark 05:46:24 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:46:24 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 05:46:24 INFO - process_Request line: dromaeo_css 5863.15 graph.html#tests=[[72,94,43]] 05:46:24 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:46:24 INFO - process_Request line: kraken 1562.10 graph.html#tests=[[232,94,43]] 05:46:24 INFO - RETURN: dromaeo_css: 5863.15 05:46:24 INFO - RETURN: kraken: 1562.10 05:46:24 INFO - javascript benchmark 05:46:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2641.5509363408223, 2677.973220267797, 2712.077893516205, 2713.389487365343, 2723.550614148665, 4564.657650676196, 4568.31475278708, 4587.862364129073, 4608.446986361637, 4631.60631346336, 4468.039371535119, 4539.546045395458, 4585.656075794321, 4634.073185362932, 4646.930296045562, 4192.937105943406, 4235.8093885775215, 4286.906838756128, 4289.613934745872, 4303.849365272216, 40.02964264054159, 4132.173565286939, 4138.213739389522, 4168.1038576706005, 4316.935245971313, 4161.9583804161875, 4169.499660040799, 4186.790660466964, 4210.284251677192, 4302.483701955754, 4176.540580536139, 4194.496660400741, 4198.202341555095, 4205.137946720914, 4212.789360531991, 4102.610252026053, 4187.853425130106, 4203.4115223868685, 4209.494860616715, 4234.851780187679, 4369.847055353079, 4505.324201369821, 4520.638348932078, 4522.6155776759015, 4566.018306064212, 4893.902121957576, 4894.583960363373, 4913.926291105637, 4927.5318844710055, 4950.579200767939, 4737.526247375269, 4814.75926203692, 4901.362822833009, 4902.607791376681, 4986.825461108844, 4540.228161212602, 4554.180247555439, 4558.0, 4575.862724118282, 4587.357769912215, 4966.602671786249, 4976.104301225814, 4986.775595098229, 4994.5754610858485, 4997.725125118153, 4622.329762184464, 4780.1873681474235, 4796.160671882407, 4839.733814640229, 4863.829765958175, 4872.707637541688, 4886.706797592155, 4893.681910675795, 4920.261960705922, 4924.089043526959, 4810.8797280068275, 4811.542903424239, 4823.348847905558, 4827.806887724451, 4875.488073752205, 4689.812407503729, 4780.856574302777, 4791.065742180311, 4851.393575803025, 4863.80544778212, 4034.152827906114, 4038.63652271297, 4040.252553277653, 4042.676585873182, 4066.4510291110914, 3563.501109844624, 3563.6970857476886, 3582.6417358263966, 3594.370985077601, 3609.3864043112735, 4053.250148722496, 4200.873973780792, 4263.126059157865, 4265.722728022669, 4285.807138678767, 4770.737609431515, 4773.474917759044, 4789.185838407479, 4858.1012512685265, 4958.429780575208, 4206.47419072616, 4242.490901091827, 4249.532551419341, 4266.893327666833, 4283.721558098714, 4191.140816132685, 4266.935995960063, 4364.236258654722, 4369.475662920407, 4372.600767754352, 4662.044280922402, 4700.905981880275, 4714.0, 4727.361806156194, 4737.952620473751, 4852.1508735971765, 4888.780004899717, 4895.314655948099, 4913.1893237615395, 4939.407271127488, 4505.932411013903, 4572.588467037849, 4629.629629629554, 4650.604698600657, 4710.175719249186, 4841.709497430165, 4843.588294994965, 4861.343718598086, 4877.268409738425, 4906.803727850846, 4907.460179380337, 4911.58251548608, 4924.9507504924495, 4930.630202734737, 4938.38270216223, 4592.15045216636, 4599.333096701027, 4691.50739172382, 4781.4740378557635, 4807.879803004953, 4770.0, 4775.6179505638775, 4777.0684716479955, 4787.01866117452, 4809.989902120594, 4608.792604332746, 4647.55848194421, 4654.86035418938, 4659.44086709597, 4695.506971768052, 4641.907161856811, 4747.454042785124, 4808.206645903387, 4809.326694262736, 4815.133276010351, 4612.976935115303, 4617.630589552895, 4636.582707556337, 4649.232876575463, 4694.248920172756], "unit": "score", "name": "dojo.html", "value": 4452.40055385556}, {"lowerIsBetter": false, "replicates": [490.62957467112324, 494.8317572025513, 524.0985504931516, 525.7739172155976, 527.8944211157769, 29445.0, 29723.554146687762, 29758.0, 29820.850895745545, 29869.253268668293, 33315.333693326116, 33948.32103357931, 34220.31559368811, 34222.0, 34370.31259374811, 7354.96322518388, 7550.886736698926, 7564.432667549928, 7588.051493563305, 7589.582572958485, 7386.667599958015, 7521.435892308072, 7542.019537460123, 7542.170361260257, 7545.17003129658, 7476.102867655889, 7510.986016887732, 7575.810604734871, 7639.04511936008, 7643.0, 7473.6263186840715, 7484.812879677997, 7501.624918754068, 7557.282058204517, 7589.772306830804, 7457.105147382349, 7490.588017659026, 7537.434692398037, 7539.208383119748, 7578.166401695809, 31172.688273117434, 31713.20716982094, 31732.206694832585, 31790.046298610847, 31876.20309492258, 2629.3426643339167, 2719.578465337876, 2720.8231464954715, 2806.3825958289144, 2807.1157585360547, 26330.6050409244, 26618.6007209892, 26993.460130797273, 27269.181924542296, 27514.862425687945, 3286.8356582171036, 3298.0600528849404, 3316.469364901604, 3324.3185147044796, 3355.731541476676, 215313.0, 215599.0, 215813.0, 216192.0, 216531.0, 36468.0, 47701.761491193014, 47815.282770758466, 48001.0, 48174.5182548177, 34174.316513670085, 34337.141571460415, 34348.0, 34485.827570862486, 34693.82653086718, 12169.452374643162, 12210.08424368176, 12241.0, 12255.325957072268, 12329.383530823423, 10019.348742331726, 10061.346012509164, 10106.949465252626, 10123.088921996909, 10148.492575371201, 12109.878901211052, 12323.630291091282, 12391.566295179626, 12434.689132771753, 12500.062495312888, 5048.72232027242, 5163.793448262028, 5164.509371609691, 5182.067227899014, 5247.2653828464045, 763.2863272839912, 775.011859878648, 793.1750978981794, 815.7022686719423, 838.6310023589601, 23724.762752372255, 23780.643290350657, 24249.51500970006, 24499.87750061274, 24762.380940476272, 917.1882883648019, 965.9178969787647, 1018.33808024783, 1022.1618273016204, 1056.5826498533036, 12334.142778074065, 12697.128185146918, 12746.298953557458, 12773.361331933365, 13057.477700891857, 258876.0, 258876.0, 261091.0, 261647.0, 264539.0, 41719.1656166875, 41914.0, 41956.37065444021, 41960.160796784505, 41965.790171048946, 1005.8390657494766, 1060.0989159214605, 1097.2812807611028, 1098.2641630107687, 1102.7573933734566, 23806.523869522167, 24629.261122166365, 26057.0, 27224.591631125946, 28976.42047159087, 39755.60244397519, 40045.39931900966, 40397.798011009756, 40446.393304099875, 40446.393304099875, 252540.0, 254689.0, 255772.0, 256239.0, 256260.0, 31792.68207317897, 35810.64189358177, 36190.0, 36292.81853590715, 36731.63268367282, 32357.191070223435, 32401.837990809894, 33302.66697332996, 33341.16647083842, 33558.328833423686, 27545.173644790688, 27683.307917302227, 27879.0, 28180.577291340236, 28194.0, 28752.137435876957, 28845.855770721013, 28869.0, 29059.564106537997, 29364.0, 28351.149465516068, 30427.54358684666, 30796.230094246926, 35151.82424087863, 35585.90762062396, 30534.694653053186, 31224.375512490078, 31382.372352553277, 31723.20691982719, 31915.840420797747, 24858.0, 25691.871540642176, 25989.610155848055, 25996.480070398866, 26062.21813345527], "unit": "score", "name": "ext.html", "value": 15339.529762260252}, {"lowerIsBetter": false, "replicates": [304.6953046953047, 306.90639354996745, 312.98748050077995, 315.9668234835342, 322.2973916861243, 14683.0, 15216.391344346226, 15218.771718424205, 15260.160691161982, 16520.58698532537, 13580.524681636145, 13820.447182112728, 14066.296685165751, 14071.437142514313, 14119.647008824784, 4773.952260477394, 4932.5807306379, 4934.481879402665, 4945.159322915095, 4977.950220497785, 4660.836870709526, 4826.107170173529, 4877.561019508244, 4907.9263811042865, 4945.653804233705, 4879.048585525824, 4879.658423910328, 4894.1679914414635, 4894.877628059309, 4895.706257624536, 4829.879253018667, 4854.2718592211095, 4856.635752318591, 4864.635152363587, 4874.585660218903, 4310.504292006428, 4617.7691115444095, 4816.51834816519, 4830.2030165022725, 4834.226523756217, 16709.164541772985, 16887.324507019704, 16945.406910758065, 16990.660186796318, 17120.486385408334, 1770.1503278426298, 1812.3203798575535, 1866.1975350599237, 1880.8307252347217, 1889.3009586452963, 7977.282044615954, 8302.294304984083, 8546.52994085325, 8575.528345940971, 8586.356023298278, 1587.261923205715, 1694.5170626371548, 1740.5474576610045, 1745.23209787693, 1911.9044047797693, 39502.60497395018, 47760.0, 48505.272420914065, 48909.0, 49564.256536151624, 9377.484238366818, 9560.426374417557, 9698.224142068617, 9708.0, 9860.45767482781, 11944.64166075019, 12118.575849845389, 12181.512739490498, 12192.0, 12197.0, 6596.472282217507, 6709.7316107355155, 6726.159230096238, 6781.118454600969, 6785.59286442815, 6272.090546870678, 6272.3100458949475, 6313.810585682345, 6392.84017899547, 6392.968035159794, 4047.5750046245307, 4084.448599439097, 4134.441850350225, 4181.080162364275, 4190.329547272422, 1682.9242684079245, 1710.615111599905, 1717.7509261157063, 1746.550363198542, 1756.3413719855055, 818.2226884459787, 828.113918107619, 863.7883718489011, 884.8407286688329, 900.617237673999, 14904.62738431548, 15011.174385408689, 15082.170480623452, 15148.16685082331, 15195.848041519665, 791.2206476620524, 802.7471346525825, 814.771863878115, 822.6832669422315, 822.7120507822334, 8464.661413543512, 8533.677280021606, 8607.827843443096, 8623.956880215685, 8650.697225597074, 351503.0, 355748.0, 359857.0, 360781.0, 365721.0, 41256.0, 62218.377816222164, 63209.367906320345, 63929.36070639327, 64182.679086604265, 831.3183189784319, 844.7634662294568, 848.8811566380836, 849.3120572336427, 855.0807881527259, 13465.326733663082, 13583.728325433634, 13633.113847599874, 13750.174989500661, 13818.723625527635, 20498.38504844857, 28664.14007579776, 30469.54295685522, 31085.844570777, 31101.844490777403, 40214.39678404885, 41743.0, 42198.57801422069, 43333.56666433421, 43353.56646433495, 6605.867882642417, 6767.044493317575, 6772.898406524005, 6813.318668133147, 6975.6163411012885, 9777.41335519871, 10300.484975751333, 10581.100606448537, 11087.0, 11132.610358637408, 9195.586198621211, 9575.425474471554, 9622.855657165288, 9686.612535498783, 9772.26707996889, 9623.903760962301, 9715.07706767856, 9765.707028789147, 9813.705588832347, 9947.05502977216, 9676.0, 10073.748156296151, 10093.142082923034, 10130.898691012995, 10170.135538479311, 6899.17209934811, 7140.428765698835, 7154.35610795031, 7171.318724721144, 7180.640967951686, 7430.628468576658, 9922.801543969224, 9946.502674866084, 10017.799644007226, 10123.443210623487], "unit": "score", "name": "jquery.html", "value": 7359.027402637173}, {"lowerIsBetter": false, "replicates": [1139.0318229504921, 1146.7362506623476, 1149.8792626774186, 1356.2676154876374, 1396.6298930783337, 6002.8799424011495, 6171.9382806171925, 6860.725570977161, 7029.718811247551, 7032.50772445929, 6444.871102577946, 6656.534042617019, 6664.833379165511, 6675.566088204276, 6699.598024118556, 1970.8423326133945, 1980.3563841751416, 1986.5530255692427, 1997.6104659591385, 1999.9200031998703, 1944.1542928825936, 1977.980220197794, 1978.297704314962, 1981.0094952523739, 1993.920243190278, 1944.222311075574, 1959.3142400159902, 1961.7155512450686, 1964.3321270767935, 1968.6554852900686, 1998.940031799041, 2014.0835919656522, 2025.0381068992258, 2028.3103744726716, 2033.7559492860803, 1970.8620396572246, 1972.763268407786, 1975.6641370966827, 2007.8192962633286, 2009.6081264153495, 6815.454763618898, 6846.383825455683, 6850.246472887979, 6855.143107111611, 6881.41507971823, 3909.9413508797393, 3971.920561588781, 4047.170330082326, 4051.9797401012806, 4052.1085361220485, 2491.53906527293, 2503.7245902950663, 2553.859537725424, 2558.4243545202366, 2638.8680565971817, 808.6199486241458, 815.9265666090021, 826.2852632472868, 828.5360198288978, 839.836231934773, 9467.52662366879, 9518.381305215138, 9533.90466095337, 9542.379745316532, 9544.61821527138, 3688.5942546319884, 3720.441933709911, 3779.998300450383, 3803.087259057806, 3808.352580061396, 8168.224018718212, 8172.264496195371, 8177.5502347370275, 8177.632006559719, 8223.136570660114, 3940.6059394060367, 3983.7211395202057, 3985.8405663773124, 3989.0, 3996.660283875903, 3039.7720170987263, 3499.6675315844955, 3569.0720412692367, 3578.355895938756, 3583.211693427442, 3215.1962009497624, 3248.4964830451318, 3276.2955964467756, 3289.983550082234, 3294.1105901406963, 997.1374760831828, 1005.703317521333, 1005.8994100589882, 1009.5002973528151, 1013.3836530733469, 972.4262685015875, 992.0228574853763, 993.180625983552, 1002.1431675917132, 1021.0096206679509, 6146.754129834846, 6179.134921111048, 6244.937550624527, 6284.842878928063, 6347.270063942613, 411.07303031663406, 411.2576798877994, 416.2923030847511, 417.66169402783845, 419.09893728484, 4772.331873537708, 4772.928406073912, 4778.331033655291, 4787.8563643090765, 4819.228923372244, 7968.0438347398685, 7974.800629984296, 8179.304759095425, 8187.836243275101, 8397.538135402612, 8429.789255268668, 8450.788730281669, 8479.703210387606, 8481.40630155883, 8481.703140390056, 6524.706388212542, 6634.0712300278, 6655.267920528738, 6674.899876501953, 6689.799306020827, 6066.666333351532, 6196.969015154896, 6205.069239614094, 6206.813795586139, 6221.9377806223165, 7373.3732632726815, 7381.0, 7576.090869095744, 7615.390768738377, 7673.040869891263, 7477.813054673677, 7699.34555562761, 7738.4969976951315, 7988.520688758693, 8000.839983200187, 5232.816851410183, 5913.2608423947, 6110.327863935053, 6224.097505861715, 6264.968675156595, 6456.096146539394, 6489.837754055998, 6552.0, 6562.901556476752, 6596.142501474777, 5709.743061562157, 5757.568182386254, 5770.596058275881, 5816.738246778989, 6023.096535519707, 5485.424030476902, 5597.27235459404, 5598.888022239614, 5637.126245431965, 5681.034224181816, 6127.816165515042, 6216.658083805434, 6230.7819226326865, 6232.25212974446, 6245.6252624842655, 5565.471280228372, 5580.107182850725, 5582.162675598693, 5638.774449022158, 5665.150227465913, 5768.077107662753, 5820.534357251495, 5843.474087332161, 5858.8242352729485, 5866.090755932837], "unit": "score", "name": "mootools.html", "value": 3789.435349079703}, {"lowerIsBetter": false, "replicates": [275.2266132168605, 279.9062314124768, 280.9520488577604, 284.147557328016, 286.36712864569296, 5482.972585137074, 5518.779248830047, 5575.665460072399, 5616.66300021999, 5629.971850140754, 5262.079136151177, 5415.64798288112, 5417.160340147274, 5439.347278326606, 5491.176323551469, 3905.3360928642055, 4061.512618485786, 4137.834486620532, 4176.832926682944, 4183.142455796555, 4164.646005089556, 4166.166766646667, 4170.58294170582, 4171.4994200695955, 4172.833086676529, 4126.5667104954, 4132.586741325874, 4133.896652583694, 4138.503379594453, 4142.8135733891895, 4101.159262351211, 4131.979340103296, 4136.98643832263, 4137.110521237948, 4150.149219410029, 3550.9644903551152, 3552.0587044433246, 3555.9466608000903, 3561.910952226215, 3563.1626567756557, 5307.177387504943, 5317.149256119041, 5320.095583750772, 5321.973390133063, 5341.519263266286, 4467.3299005149165, 4645.605123564467, 4747.477777444513, 4763.69036012658, 4771.952280477186, 5708.743106560215, 5714.000049991235, 5750.511206547407, 5779.88440231193, 5779.971100144515, 3770.1140232045445, 3770.359038963383, 3771.830267637963, 3774.943015955537, 3781.243751249761, 6031.396860313977, 6097.69511524422, 6098.32918378978, 6098.35967223444, 6107.175531303262, 3972.920541589152, 3976.5426975897562, 3976.940345894814, 3978.0651546886456, 3982.3628219484744, 4038.4749982502085, 4040.0, 4041.191761647682, 4043.0498832774274, 4055.8174882130374, 4525.298578720303, 4700.412448443944, 4721.315409265706, 4734.431868175772, 4734.455537613149, 5712.942870571324, 5716.42835716425, 5753.683547404849, 5787.074068149076, 5813.6221145625395, 1389.319233575561, 1394.414345974693, 1399.2723783632455, 1401.9719605607831, 1404.4101477379525, 921.5991043895792, 922.3681777981969, 936.8547875079373, 946.9678050924525, 947.7204224753714, 5026.673266237683, 5037.697738135724, 5038.722870242172, 5042.571381432619, 5054.0, 6005.429484198994, 6039.54703397247, 6042.274927008787, 6047.3045599755715, 6070.362611925684, 4952.851414457572, 5022.748862556858, 5045.924311135336, 5058.392992840809, 5065.936153407825, 3230.499272612749, 3278.7704860659524, 3295.35740530599, 3297.258116923673, 3299.736021118305, 5759.22250496186, 5761.049426844524, 5763.942360576424, 5767.596268261182, 5771.278590176228, 6249.281332646713, 6276.184096067574, 6278.654673992883, 6292.276388215322, 6308.58994165387, 5737.540996720252, 5738.081906894877, 5740.1963725077685, 5745.396733343023, 5747.6838773867, 5931.851703707442, 5939.376365481735, 5998.070299103646, 6034.607750496204, 6116.418940200674, 5843.561732869966, 5843.94156058451, 5847.327557330961, 5880.911786323123, 5923.808190969369, 5724.169995350734, 5736.053551164011, 5739.770409183586, 5741.0, 5741.5119714824705, 4067.6745860331694, 4107.137501124797, 4109.3425051991535, 4113.444684967611, 4118.917621647491, 5884.146798714248, 5919.319278283053, 5921.111833225051, 5923.851903702442, 5934.762609495572, 5518.06192947208, 5636.689982051026, 5677.0, 5696.430356964271, 5696.971515142398, 5661.830145095653, 5679.346875109415, 5681.77272909079, 5686.175504551899, 5694.231278777312, 5496.780128794963, 5537.446255374431, 5539.667619942817, 5543.667379957215, 5548.389677135431, 5676.063449530781, 5698.373178950395, 5737.684427356368, 5741.425857414392, 5747.655140691572, 5486.369067557282, 5513.8345849624575, 5528.834134975958, 5542.168674698827, 5547.195656629686], "unit": "score", "name": "prototype.html", "value": 4263.931615134954}, {"lowerIsBetter": false, "replicates": [546.1752753342452, 548.838092762635, 549.2859282932187, 588.612908004543, 592.6355291495731, 9883.703488895335, 9906.257030722707, 9906.950465247683, 9942.0, 9961.950190249057, 8850.380473366868, 10629.096526795212, 10631.78736425273, 10650.0, 10683.78632427351, 640.4780104215073, 659.663571578496, 660.5145218264572, 663.0683889135772, 668.4351722794231, 658.9967050164743, 660.0923729871427, 664.1830548425439, 665.7769647168204, 669.2437545573495, 689.0, 692.5533031194876, 693.0539813155058, 693.3032302535944, 695.8190870373714, 677.2685499660355, 689.2280645676849, 691.2327316678483, 695.8364784275691, 695.9930400695979, 508.59312549959884, 512.912804823181, 513.278843225269, 518.1838604198402, 523.9030779305803, 10349.63776267827, 10614.150867930546, 10615.84076238857, 10678.305910115818, 10757.085647719954, 10711.517981690842, 10774.5690172393, 10993.890061099366, 11139.944300278528, 11167.0, 8821.382503224777, 8874.423162494482, 8941.150590693938, 8985.6855010075, 9068.455892646462, 3188.1551388881967, 3195.0571936198653, 3251.7398608111293, 3257.462518684414, 3304.487804390323, 37845.432318515246, 38306.42540361897, 38441.23117537662, 38630.22739545222, 38889.22221555581, 8024.0, 8116.0, 8183.345332373515, 8271.669133234724, 8351.331893448509, 13884.166949982831, 13910.86089139116, 14022.0, 14038.438462461592, 14043.0, 5717.656940583578, 5806.767729290866, 6107.053406721876, 6110.847228819315, 6170.197874276315, 3135.3885992231294, 3173.0639461358955, 3241.2059045533997, 3279.0818570800216, 3537.876174333886, 2338.894749736266, 2353.9176128835406, 2354.4937838364835, 2355.2698663414394, 2373.9050437982633, 441.9381286619876, 449.7841036302593, 452.3328091065652, 463.4994206257234, 467.0915070188451, 406.625904168166, 482.645255737033, 490.6124161912121, 492.3500978708071, 495.30657080087445, 6833.282505336968, 6924.4114250288285, 6930.306969303029, 7093.0424392707355, 7128.572285662877, 472.67857856657804, 477.67756764184037, 485.42962019627504, 489.41270475429627, 502.5000124875699, 3111.5177147542167, 3120.40712264669, 3243.0757234188145, 3247.8376081195847, 3328.6005679318637, 46076.7696161517, 47090.82272943204, 47167.29249061267, 47345.5265447348, 48062.03875922462, 42543.0, 42775.7861210692, 43158.0, 43504.78247608805, 43586.346204806956, 39569.40645890314, 40028.59971400307, 40115.398269025405, 40914.386284205764, 41251.38122928098, 6169.537284703575, 6265.8120256392385, 6278.466330361788, 6285.182926219562, 6601.306862779531, 30602.540961885144, 30859.228519287197, 30943.535846961862, 31297.374052518368, 31602.209944750644, 37104.25791484209, 38202.617973819906, 38821.80589097036, 38975.6102438972, 39106.2178756429, 8053.114157442559, 8057.83884322322, 8161.3062889652665, 8353.916460835313, 8439.367047471342, 8797.47215167092, 8809.11908809114, 8857.911420885966, 8874.556272186235, 8932.821343573221, 8962.910370896208, 9029.593668284811, 9042.90957090447, 9064.818703626022, 9188.724338269863, 8080.111187769223, 8106.635201416068, 8120.35037197011, 8201.056878459054, 8253.669853205805, 8506.0, 8536.31709463229, 8556.957215213884, 8563.61463734146, 8749.256313213193, 7334.963325183553, 7396.297351751575, 7522.849543009219, 7586.6206689664195, 7776.300132988058, 6486.708098135501, 6772.458203343819, 6912.654367281515, 6981.162260528769, 6984.720611175496], "unit": "score", "name": "yui.html", "value": 5001.828066761714}], "name": "dromaeo_css", "value": 5863.145199590888}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 112.0, 113.0, 114.0, 114.0, 127.0, 115.0, 114.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [154.0, 146.0, 152.0, 169.0, 146.0, 162.0, 166.0, 136.0, 176.0, 144.0], "unit": "score", "name": "audio-beat-detection", "value": 155.1}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 164.0, 162.0, 163.0, 168.0, 167.0, 163.0, 165.0, 165.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 76.0, 76.0, 74.0, 74.0, 132.0, 73.0, 74.0, 77.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 144.0, 95.0, 96.0, 94.0, 143.0, 96.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 118.0, 119.0, 120.0, 117.0, 117.0, 121.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 118.2}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 151.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 70.0, 67.0, 67.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 67.8}, {"lowerIsBetter": true, "replicates": [71.0, 77.0, 72.0, 71.0, 73.0, 72.0, 71.0, 72.0, 73.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.3}, {"lowerIsBetter": true, "replicates": [91.0, 86.0, 84.0, 94.0, 86.0, 86.0, 87.0, 84.0, 87.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [130.0, 123.0, 133.0, 124.0, 128.0, 126.0, 130.0, 125.0, 132.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.0}, {"lowerIsBetter": true, "replicates": [139.0, 156.0, 153.0, 148.0, 150.0, 154.0, 140.0, 153.0, 151.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.3}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 71.0, 72.0, 72.0, 71.0, 73.0, 74.0, 71.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.8}], "name": "kraken", "value": 1562.1}]} 05:46:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1562.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "5863.15"}}} 05:46:24 INFO - Return code: 0 05:46:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:46:24 ERROR - # TBPL SUCCESS # 05:46:24 INFO - Running post-action listener: _resource_record_post_action 05:46:24 INFO - Running post-run listener: _resource_record_post_run 05:46:25 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539041792; Read time: 16; Write time: 668348 05:46:25 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 196521984; Read time: 0; Write time: 384156 05:46:25 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288083968; Read time: 16; Write time: 247264 05:46:25 INFO - Running post-run listener: _upload_blobber_files 05:46:25 INFO - Blob upload gear active. 05:46:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:46:25 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 05:46:25 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'] 05:46:25 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 05:46:26 INFO - (blobuploader) - INFO - Open directory for files ... 05:46:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:46:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:46:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:26 INFO - (blobuploader) - INFO - Done attempting. 05:46:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:46:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:46:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:27 INFO - (blobuploader) - INFO - Done attempting. 05:46:27 INFO - (blobuploader) - INFO - Iteration through files over. 05:46:27 INFO - Return code: 0 05:46:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:46:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:46:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0591dd6e6ad330df4f55ae758be9e983b31b3a37d2f3dd92ec14dad4127e5eb10b7e269ad8b036b12cfda35c2965fa5355cf2a426cef551f98b83f613ddc843", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ce7f91be4acc446780026148bbc433217d22d8d03d73c3e73bcff0c16bfbf9d4fa777f1faaa41415bb2f5c110b6198c83d0a0e6c27956dde70534875c4519cb"} 05:46:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:46:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:46:27 INFO - Contents: 05:46:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0591dd6e6ad330df4f55ae758be9e983b31b3a37d2f3dd92ec14dad4127e5eb10b7e269ad8b036b12cfda35c2965fa5355cf2a426cef551f98b83f613ddc843", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ce7f91be4acc446780026148bbc433217d22d8d03d73c3e73bcff0c16bfbf9d4fa777f1faaa41415bb2f5c110b6198c83d0a0e6c27956dde70534875c4519cb"} 05:46:27 INFO - Running post-run listener: copy_logs_to_upload_dir 05:46:27 INFO - Copying logs to upload dir... 05:46:27 INFO - mkdir: /builds/slave/test/build/upload/logs 05:46:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.599302 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-01 05:46:27.655887) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 05:46:27.659296) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899 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/a0591dd6e6ad330df4f55ae758be9e983b31b3a37d2f3dd92ec14dad4127e5eb10b7e269ad8b036b12cfda35c2965fa5355cf2a426cef551f98b83f613ddc843", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ce7f91be4acc446780026148bbc433217d22d8d03d73c3e73bcff0c16bfbf9d4fa777f1faaa41415bb2f5c110b6198c83d0a0e6c27956dde70534875c4519cb"} build_url:https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/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/a0591dd6e6ad330df4f55ae758be9e983b31b3a37d2f3dd92ec14dad4127e5eb10b7e269ad8b036b12cfda35c2965fa5355cf2a426cef551f98b83f613ddc843", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ce7f91be4acc446780026148bbc433217d22d8d03d73c3e73bcff0c16bfbf9d4fa777f1faaa41415bb2f5c110b6198c83d0a0e6c27956dde70534875c4519cb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 05:46:27.683162) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 05:46:27.683449) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456838677.127869-945475899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004689 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 05:46:27.768533) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 05:46:27.768845) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 05:46:27.769149) ========= ========= Total master_lag: 0.29 =========