builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1456772934.81 results: success (0) buildid: 20160229094946 builduid: a1a69cc9881e421e81681967a46e428c revision: 04634ec900b2fb94962733148ecdeac7ae98e0e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:54.815551) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:54.816537) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:54.817292) ========= 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=745a4373a2a16df560f216e000000264-1456772934.121299-1348343867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006351 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:54.846206) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:54.846893) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:54.862374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:54.863059) ========= 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=745a4373a2a16df560f216e000000264-1456772934.121299-1348343867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004666 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:54.917285) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:54.917985) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:54.918795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:54.919460) ========= 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=745a4373a2a16df560f216e000000264-1456772934.121299-1348343867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 11:08:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 73.0M=0s 2016-02-29 11:08:55 (73.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089682 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:55.027038) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:55.027748) ========= 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=745a4373a2a16df560f216e000000264-1456772934.121299-1348343867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021476 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:55.080174) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:55.080664) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 04634ec900b2fb94962733148ecdeac7ae98e0e2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 04634ec900b2fb94962733148ecdeac7ae98e0e2 --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=745a4373a2a16df560f216e000000264-1456772934.121299-1348343867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 11:08:55,160 truncating revision to first 12 chars 2016-02-29 11:08:55,160 Setting DEBUG logging. 2016-02-29 11:08:55,160 attempt 1/10 2016-02-29 11:08:55,160 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/04634ec900b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 11:08:55,427 unpacking tar archive at: fx-team-04634ec900b2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548348 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:55.643669) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:55.644073) ========= echo 04634ec900b2fb94962733148ecdeac7ae98e0e2 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'04634ec900b2fb94962733148ecdeac7ae98e0e2'] 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=745a4373a2a16df560f216e000000264-1456772934.121299-1348343867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04634ec900b2fb94962733148ecdeac7ae98e0e2 program finished with exit code 0 elapsedTime=0.003372 script_repo_revision: '04634ec900b2fb94962733148ecdeac7ae98e0e2' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:55.696425) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:55.696851) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 11:08:55.707574) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-02-29 11:08:55.708204) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1456772934.121299-1348343867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:08:55 INFO - MultiFileLogger online at 20160229 11:08:55 in /builds/slave/test 11:08:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:08:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:08:55 INFO - {'append_to_log': False, 11:08:55 INFO - 'base_work_dir': '/builds/slave/test', 11:08:55 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:08:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:08:55 INFO - 'branch': 'Fx-Team-Non-PGO', 11:08:55 INFO - 'buildbot_json_path': 'buildprops.json', 11:08:55 INFO - 'config_files': ('talos/linux_config.py',), 11:08:55 INFO - 'default_actions': ('clobber', 11:08:55 INFO - 'read-buildbot-config', 11:08:55 INFO - 'download-and-extract', 11:08:55 INFO - 'populate-webroot', 11:08:55 INFO - 'create-virtualenv', 11:08:55 INFO - 'install', 11:08:55 INFO - 'run-tests'), 11:08:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:08:55 INFO - 'download_minidump_stackwalk': True, 11:08:55 INFO - 'download_symbols': 'ondemand', 11:08:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:08:55 INFO - 'tooltool.py': '/tools/tooltool.py', 11:08:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:08:55 INFO - '/tools/misc-python/virtualenv.py')}, 11:08:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:08:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:08:55 INFO - 'installer_path': 'installer.exe', 11:08:55 INFO - 'log_level': 'info', 11:08:55 INFO - 'log_name': 'talos', 11:08:55 INFO - 'log_to_console': True, 11:08:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:08:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:08:55 INFO - 'opt_config_files': (), 11:08:55 INFO - 'pip_index': False, 11:08:55 INFO - 'sps_profile': False, 11:08:55 INFO - 'sps_profile_interval': 0, 11:08:55 INFO - 'suite': 'dromaeojs-e10s', 11:08:55 INFO - 'system_bits': '32', 11:08:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:08:55 INFO - 'title': 'talos-linux64-ix-032', 11:08:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:08:55 INFO - 'use_talos_json': True, 11:08:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:08:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:08:55 INFO - 'work_dir': 'build'} 11:08:55 INFO - ##### 11:08:55 INFO - ##### Running clobber step. 11:08:55 INFO - ##### 11:08:55 INFO - Running pre-action listener: _resource_record_pre_action 11:08:55 INFO - Running main action method: clobber 11:08:55 INFO - rmtree: /builds/slave/test/build 11:08:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:08:56 INFO - Running post-action listener: _resource_record_post_action 11:08:56 INFO - ##### 11:08:56 INFO - ##### Running read-buildbot-config step. 11:08:56 INFO - ##### 11:08:56 INFO - Running pre-action listener: _resource_record_pre_action 11:08:56 INFO - Running main action method: read_buildbot_config 11:08:56 INFO - Using buildbot properties: 11:08:56 INFO - { 11:08:56 INFO - "project": "", 11:08:56 INFO - "product": "firefox", 11:08:56 INFO - "script_repo_revision": "production", 11:08:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:08:56 INFO - "repository": "", 11:08:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 11:08:56 INFO - "buildid": "20160229094946", 11:08:56 INFO - "pgo_build": "False", 11:08:56 INFO - "basedir": "/builds/slave/test", 11:08:56 INFO - "buildnumber": 1171, 11:08:56 INFO - "slavename": "talos-linux64-ix-032", 11:08:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:08:56 INFO - "platform": "ubuntu64_hw", 11:08:56 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:08:56 INFO - "branch": "fx-team", 11:08:56 INFO - "repo_path": "integration/fx-team", 11:08:56 INFO - "revision": "04634ec900b2fb94962733148ecdeac7ae98e0e2", 11:08:56 INFO - "stage_platform": "linux64", 11:08:56 INFO - "builduid": "a1a69cc9881e421e81681967a46e428c", 11:08:56 INFO - "slavebuilddir": "test" 11:08:56 INFO - } 11:08:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 11:08:56 INFO - Running post-action listener: _resource_record_post_action 11:08:56 INFO - ##### 11:08:56 INFO - ##### Running download-and-extract step. 11:08:56 INFO - ##### 11:08:56 INFO - Running pre-action listener: _resource_record_pre_action 11:08:56 INFO - Running main action method: download_and_extract 11:08:56 INFO - mkdir: /builds/slave/test/build/tests 11:08: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')]} 11:08:56 INFO - https://queue.taskcluster.net/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:08:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/test_packages.json 11:08:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/test_packages.json 11:08:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:08:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:08:57 INFO - Downloaded 1448 bytes. 11:08:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:08:57 INFO - Using the following test package requirements: 11:08:57 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:57 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:57 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:08:57 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:57 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:08:57 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:57 INFO - u'jsshell-linux-x86_64.zip'], 11:08:57 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:57 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:08:57 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:57 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:57 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:08:57 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:57 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:08:57 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:57 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:08:57 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:57 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:57 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:08:57 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:57 INFO - https://queue.taskcluster.net/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:08:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:08:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:08:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/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 11:08:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/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 11:08:58 INFO - Downloaded 22057460 bytes. 11:08:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:08:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:08:59 INFO - Return code: 0 11:08:59 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 11:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:59 INFO - https://queue.taskcluster.net/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:08:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:08:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:08:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/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 11:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/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 11:09:00 INFO - Downloaded 22057460 bytes. 11:09:00 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'] 11:09:00 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 11:09:02 INFO - Return code: 0 11:09:02 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')]} 11:09:02 INFO - https://queue.taskcluster.net/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:09:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 11:09:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 11:09:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/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 11:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/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 11:09:03 INFO - Downloaded 10713410 bytes. 11:09:03 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'] 11:09:03 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 11:09:03 INFO - Return code: 0 11:09:03 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')]} 11:09:03 INFO - https://queue.taskcluster.net/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:09:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:09:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:09:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/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 11:09:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H551OqKyQK6xqUhX41S_qw/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 11:09:04 INFO - Downloaded 54850648 bytes. 11:09:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:09:04 INFO - mkdir: /builds/slave/test/properties 11:09:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:09:04 INFO - Writing to file /builds/slave/test/properties/build_url 11:09:04 INFO - Contents: 11:09:04 INFO - build_url:https://queue.taskcluster.net/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:09:05 INFO - Running post-action listener: _resource_record_post_action 11:09:05 INFO - Running post-action listener: set_extra_try_arguments 11:09:05 INFO - ##### 11:09:05 INFO - ##### Running populate-webroot step. 11:09:05 INFO - ##### 11:09:05 INFO - Running pre-action listener: _resource_record_pre_action 11:09:05 INFO - Running main action method: populate_webroot 11:09:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:09:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:09:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:09:05 INFO - '--tppagecycles', 11:09:05 INFO - '7'], 11:09:05 INFO - 'tests': ['tsvgm']}}, 11:09:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:09:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:09:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:09:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:09:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:09:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:09:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:05 INFO - 'talos_options': ['--e10s'], 11:09:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:05 INFO - 'tests': ['damp', 'tps']}, 11:09:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:05 INFO - 'talos_options': ['--e10s'], 11:09:05 INFO - 'tests': ['damp', 'tps']}, 11:09:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:09:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:09:05 INFO - 'other': {'tests': ['a11yr', 11:09:05 INFO - 'ts_paint', 11:09:05 INFO - 'tpaint', 11:09:05 INFO - 'sessionrestore', 11:09:05 INFO - 'sessionrestore_no_auto_restore']}, 11:09:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:09:05 INFO - 'tests': ['a11yr', 11:09:05 INFO - 'ts_paint', 11:09:05 INFO - 'tpaint', 11:09:05 INFO - 'sessionrestore', 11:09:05 INFO - 'sessionrestore_no_auto_restore']}, 11:09:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:09:05 INFO - 'tests': ['a11yr', 11:09:05 INFO - 'ts_paint', 11:09:05 INFO - 'tpaint', 11:09:05 INFO - 'sessionrestore', 11:09:05 INFO - 'sessionrestore_no_auto_restore']}, 11:09:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:09:05 INFO - 'tests': ['a11yr', 11:09:05 INFO - 'ts_paint', 11:09:05 INFO - 'tpaint', 11:09:05 INFO - 'sessionrestore', 11:09:05 INFO - 'sessionrestore_no_auto_restore']}, 11:09:05 INFO - 'other_l64': {'tests': ['a11yr', 11:09:05 INFO - 'ts_paint', 11:09:05 INFO - 'tpaint', 11:09:05 INFO - 'sessionrestore', 11:09:05 INFO - 'sessionrestore_no_auto_restore']}, 11:09:05 INFO - 'other_nol64': {'tests': ['a11yr', 11:09:05 INFO - 'ts_paint', 11:09:05 INFO - 'tpaint', 11:09:05 INFO - 'sessionrestore', 11:09:05 INFO - 'sessionrestore_no_auto_restore']}, 11:09:05 INFO - 'svgr': {'tests': ['tsvgx', 11:09:05 INFO - 'tsvgr_opacity', 11:09:05 INFO - 'tart', 11:09:05 INFO - 'tscrollx', 11:09:05 INFO - 'cart']}, 11:09:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:09:05 INFO - 'tests': ['tsvgx', 11:09:05 INFO - 'tsvgr_opacity', 11:09:05 INFO - 'tart', 11:09:05 INFO - 'tscrollx', 11:09:05 INFO - 'cart']}, 11:09:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:05 INFO - 'tests': ['tp5o']}, 11:09:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:05 INFO - 'talos_options': ['--e10s'], 11:09:05 INFO - 'tests': ['tp5o']}, 11:09:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:05 INFO - 'talos_options': ['--xperf_path', 11:09:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:05 INFO - 'tests': ['tp5n']}, 11:09:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:05 INFO - 'talos_options': ['--e10s', 11:09:05 INFO - '--xperf_path', 11:09:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:05 INFO - 'tests': ['tp5n']}}, 11:09:05 INFO - 'talos.zip': {'path': '', 11:09:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:09:05 INFO - Running post-action listener: _resource_record_post_action 11:09:05 INFO - ##### 11:09:05 INFO - ##### Running create-virtualenv step. 11:09:05 INFO - ##### 11:09:05 INFO - Running pre-action listener: _resource_record_pre_action 11:09:05 INFO - Running main action method: create_virtualenv 11:09:05 INFO - Creating virtualenv /builds/slave/test/build/venv 11:09:05 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 11:09:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:09:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:09:05 INFO - Using real prefix '/usr' 11:09:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:09:05 INFO - Installing distribute.............................................................................................................................................................................................done. 11:09:07 INFO - Installing pip.................done. 11:09:07 INFO - Return code: 0 11:09:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:08 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 0x7f948957bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251100>, '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 0x1252000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1252490>, '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': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', '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 11:09:08 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 11:09:08 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 11:09:08 INFO - Using env: {'DISPLAY': ':0', 11:09:08 INFO - 'HOME': '/home/cltbld', 11:09:08 INFO - 'LANG': 'en_US.UTF-8', 11:09:08 INFO - 'LANGUAGE': 'en_US:en', 11:09:08 INFO - 'LOGNAME': 'cltbld', 11:09:08 INFO - 'MAIL': '/var/mail/cltbld', 11:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:08 INFO - 'MOZ_NO_REMOTE': '1', 11:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:08 INFO - 'NO_EM_RESTART': '1', 11:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:08 INFO - 'PWD': '/builds/slave/test', 11:09:08 INFO - 'SHELL': '/bin/bash', 11:09:08 INFO - 'SHLVL': '1', 11:09:08 INFO - 'TERM': 'linux', 11:09:08 INFO - 'TMOUT': '86400', 11:09:08 INFO - 'USER': 'cltbld', 11:09:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', 11:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:08 INFO - '_': '/tools/buildbot/bin/python'} 11:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:08 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 11:09:08 INFO - Cleaning up... 11:09:08 INFO - Return code: 0 11:09:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:09:08 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')]} 11:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:08 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')]} 11:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:08 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 0x7f948957bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251100>, '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 0x1252000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1252490>, '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': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', '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 11:09:08 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 11:09:08 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 11:09:08 INFO - Using env: {'DISPLAY': ':0', 11:09:08 INFO - 'HOME': '/home/cltbld', 11:09:08 INFO - 'LANG': 'en_US.UTF-8', 11:09:08 INFO - 'LANGUAGE': 'en_US:en', 11:09:08 INFO - 'LOGNAME': 'cltbld', 11:09:08 INFO - 'MAIL': '/var/mail/cltbld', 11:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:08 INFO - 'MOZ_NO_REMOTE': '1', 11:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:08 INFO - 'NO_EM_RESTART': '1', 11:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:08 INFO - 'PWD': '/builds/slave/test', 11:09:08 INFO - 'SHELL': '/bin/bash', 11:09:08 INFO - 'SHLVL': '1', 11:09:08 INFO - 'TERM': 'linux', 11:09:08 INFO - 'TMOUT': '86400', 11:09:08 INFO - 'USER': 'cltbld', 11:09:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', 11:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:08 INFO - '_': '/tools/buildbot/bin/python'} 11:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:08 INFO - Downloading/unpacking psutil>=0.7.1 11:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:09:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:10 INFO - Installing collected packages: psutil 11:09:10 INFO - Running setup.py install for psutil 11:09:10 INFO - building 'psutil._psutil_linux' extension 11:09:10 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 11:09:10 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 11:09:10 INFO - building 'psutil._psutil_posix' extension 11:09:10 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 11:09:10 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 11:09:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:10 INFO - Successfully installed psutil 11:09:10 INFO - Cleaning up... 11:09:10 INFO - Return code: 0 11:09:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:09:10 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')]} 11:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:10 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')]} 11:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:10 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 0x7f948957bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251100>, '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 0x1252000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1252490>, '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': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', '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 11:09:10 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 11:09:10 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 11:09:10 INFO - Using env: {'DISPLAY': ':0', 11:09:10 INFO - 'HOME': '/home/cltbld', 11:09:10 INFO - 'LANG': 'en_US.UTF-8', 11:09:10 INFO - 'LANGUAGE': 'en_US:en', 11:09:10 INFO - 'LOGNAME': 'cltbld', 11:09:10 INFO - 'MAIL': '/var/mail/cltbld', 11:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:10 INFO - 'MOZ_NO_REMOTE': '1', 11:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:10 INFO - 'NO_EM_RESTART': '1', 11:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:10 INFO - 'PWD': '/builds/slave/test', 11:09:10 INFO - 'SHELL': '/bin/bash', 11:09:10 INFO - 'SHLVL': '1', 11:09:10 INFO - 'TERM': 'linux', 11:09:10 INFO - 'TMOUT': '86400', 11:09:10 INFO - 'USER': 'cltbld', 11:09:10 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', 11:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:10 INFO - '_': '/tools/buildbot/bin/python'} 11:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:09:11 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 11:09:11 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 11:09:11 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 11:09:11 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 11:09:11 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 11:09:11 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 11:09:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:09:12 INFO - Installing collected packages: mozsystemmonitor 11:09:12 INFO - Running setup.py install for mozsystemmonitor 11:09:13 INFO - Successfully installed mozsystemmonitor 11:09:13 INFO - Cleaning up... 11:09:13 INFO - Return code: 0 11:09:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:13 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 0x7f948957bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251100>, '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 0x1252000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1252490>, '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': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', '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 11:09:13 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 11:09:13 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 11:09:13 INFO - Using env: {'DISPLAY': ':0', 11:09:13 INFO - 'HOME': '/home/cltbld', 11:09:13 INFO - 'LANG': 'en_US.UTF-8', 11:09:13 INFO - 'LANGUAGE': 'en_US:en', 11:09:13 INFO - 'LOGNAME': 'cltbld', 11:09:13 INFO - 'MAIL': '/var/mail/cltbld', 11:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:13 INFO - 'MOZ_NO_REMOTE': '1', 11:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:13 INFO - 'NO_EM_RESTART': '1', 11:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:13 INFO - 'PWD': '/builds/slave/test', 11:09:13 INFO - 'SHELL': '/bin/bash', 11:09:13 INFO - 'SHLVL': '1', 11:09:13 INFO - 'TERM': 'linux', 11:09:13 INFO - 'TMOUT': '86400', 11:09:13 INFO - 'USER': 'cltbld', 11:09:13 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', 11:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:13 INFO - '_': '/tools/buildbot/bin/python'} 11:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:13 INFO - Downloading/unpacking blobuploader==1.2.4 11:09:13 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 11:09:13 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 11:09:13 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 11:09:13 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 11:09:13 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 11:09:13 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 11:09:15 INFO - Downloading blobuploader-1.2.4.tar.gz 11:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:09:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:09:15 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 11:09:15 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 11:09:15 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 11:09:15 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 11:09:15 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 11:09:15 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 11:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:09:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:09:15 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 11:09:15 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 11:09:15 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 11:09:15 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 11:09:15 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 11:09:15 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 11:09:16 INFO - Downloading docopt-0.6.1.tar.gz 11:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:09:16 INFO - Installing collected packages: blobuploader, requests, docopt 11:09:16 INFO - Running setup.py install for blobuploader 11:09:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:09:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:09:16 INFO - Running setup.py install for requests 11:09:16 INFO - Running setup.py install for docopt 11:09:16 INFO - Successfully installed blobuploader requests docopt 11:09:16 INFO - Cleaning up... 11:09:16 INFO - Return code: 0 11:09:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:16 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 0x7f948957bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251100>, '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 0x1252000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1252490>, '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': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', '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 11:09:16 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 11:09:16 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 11:09:16 INFO - Using env: {'DISPLAY': ':0', 11:09:16 INFO - 'HOME': '/home/cltbld', 11:09:16 INFO - 'LANG': 'en_US.UTF-8', 11:09:16 INFO - 'LANGUAGE': 'en_US:en', 11:09:16 INFO - 'LOGNAME': 'cltbld', 11:09:16 INFO - 'MAIL': '/var/mail/cltbld', 11:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:16 INFO - 'MOZ_NO_REMOTE': '1', 11:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:16 INFO - 'NO_EM_RESTART': '1', 11:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:16 INFO - 'PWD': '/builds/slave/test', 11:09:16 INFO - 'SHELL': '/bin/bash', 11:09:16 INFO - 'SHLVL': '1', 11:09:16 INFO - 'TERM': 'linux', 11:09:16 INFO - 'TMOUT': '86400', 11:09:16 INFO - 'USER': 'cltbld', 11:09:16 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', 11:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:16 INFO - '_': '/tools/buildbot/bin/python'} 11:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:16 INFO - Running setup.py (path:/tmp/pip-gTNb9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:17 INFO - Running setup.py (path:/tmp/pip-eWtKX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:17 INFO - Running setup.py (path:/tmp/pip-XEUJFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:17 INFO - Running setup.py (path:/tmp/pip-rdCsxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:17 INFO - Running setup.py (path:/tmp/pip-AaCYgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:17 INFO - Running setup.py (path:/tmp/pip-TXAfk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:17 INFO - Running setup.py (path:/tmp/pip-RccKjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:17 INFO - Running setup.py (path:/tmp/pip-K1IhPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:17 INFO - Running setup.py (path:/tmp/pip-5clX7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:17 INFO - Running setup.py (path:/tmp/pip-4t5hEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:17 INFO - Running setup.py (path:/tmp/pip-CiUSEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:17 INFO - Running setup.py (path:/tmp/pip-P3wnxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:17 INFO - Running setup.py (path:/tmp/pip-YHHkm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:17 INFO - Running setup.py (path:/tmp/pip-_jbC0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:17 INFO - Running setup.py (path:/tmp/pip-LySTrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:18 INFO - Running setup.py (path:/tmp/pip-WI1Zoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:18 INFO - Running setup.py (path:/tmp/pip-quf4KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:09:18 INFO - Running setup.py install for manifestparser 11:09:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:09:18 INFO - Running setup.py install for mozcrash 11:09:18 INFO - Running setup.py install for mozdebug 11:09:18 INFO - Running setup.py install for mozdevice 11:09:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:09:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:09:18 INFO - Running setup.py install for mozfile 11:09:18 INFO - Running setup.py install for mozhttpd 11:09:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:09:18 INFO - Running setup.py install for mozinfo 11:09:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:09:18 INFO - Running setup.py install for mozInstall 11:09:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:09:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:09:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:09:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:09:18 INFO - Running setup.py install for mozleak 11:09:19 INFO - Running setup.py install for mozlog 11:09:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:09:19 INFO - Running setup.py install for moznetwork 11:09:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:09:19 INFO - Running setup.py install for mozprocess 11:09:19 INFO - Running setup.py install for mozprofile 11:09:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:09:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:09:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:09:19 INFO - Running setup.py install for mozrunner 11:09:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:09:19 INFO - Running setup.py install for mozscreenshot 11:09:19 INFO - Running setup.py install for moztest 11:09:19 INFO - Running setup.py install for mozversion 11:09:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:09:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:09:19 INFO - Cleaning up... 11:09:19 INFO - Return code: 0 11:09:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:19 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 0x7f948957bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251100>, '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 0x1252000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1252490>, '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': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', '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 11:09:19 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 11:09:19 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 11:09:19 INFO - Using env: {'DISPLAY': ':0', 11:09:19 INFO - 'HOME': '/home/cltbld', 11:09:19 INFO - 'LANG': 'en_US.UTF-8', 11:09:19 INFO - 'LANGUAGE': 'en_US:en', 11:09:19 INFO - 'LOGNAME': 'cltbld', 11:09:19 INFO - 'MAIL': '/var/mail/cltbld', 11:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:19 INFO - 'MOZ_NO_REMOTE': '1', 11:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:19 INFO - 'NO_EM_RESTART': '1', 11:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:19 INFO - 'PWD': '/builds/slave/test', 11:09:19 INFO - 'SHELL': '/bin/bash', 11:09:19 INFO - 'SHLVL': '1', 11:09:19 INFO - 'TERM': 'linux', 11:09:19 INFO - 'TMOUT': '86400', 11:09:19 INFO - 'USER': 'cltbld', 11:09:19 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', 11:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:19 INFO - '_': '/tools/buildbot/bin/python'} 11:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:20 INFO - Running setup.py (path:/tmp/pip-L0hkvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:20 INFO - Running setup.py (path:/tmp/pip-b_16pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:20 INFO - Running setup.py (path:/tmp/pip-zkFzKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:20 INFO - Running setup.py (path:/tmp/pip-Hyn3QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:20 INFO - Running setup.py (path:/tmp/pip-FjiOd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:20 INFO - Running setup.py (path:/tmp/pip-HKtyYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:20 INFO - Running setup.py (path:/tmp/pip-LnA_Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:20 INFO - Running setup.py (path:/tmp/pip-V2h7DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:20 INFO - Running setup.py (path:/tmp/pip-qXonN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:20 INFO - Running setup.py (path:/tmp/pip-TOj2Bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:20 INFO - Running setup.py (path:/tmp/pip-1vdlGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:20 INFO - Running setup.py (path:/tmp/pip-s0Lrxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:21 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)) 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:21 INFO - Running setup.py (path:/tmp/pip-zNdhY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:21 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)) 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:21 INFO - Running setup.py (path:/tmp/pip-yTNx5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:21 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)) 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:21 INFO - Running setup.py (path:/tmp/pip-6XNPWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:21 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)) 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:21 INFO - Running setup.py (path:/tmp/pip-3iFN3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:21 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)) 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:21 INFO - Running setup.py (path:/tmp/pip-scLtYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:21 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)) 11:09:21 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)) 11:09:21 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)) 11:09:21 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)) 11:09:21 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)) 11:09:21 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)) 11:09:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:23 INFO - Downloading blessings-1.6.tar.gz 11:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:09:23 INFO - Installing collected packages: blessings 11:09:23 INFO - Running setup.py install for blessings 11:09:23 INFO - Successfully installed blessings 11:09:23 INFO - Cleaning up... 11:09:23 INFO - Return code: 0 11:09:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:09:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:23 INFO - Reading from file tmpfile_stdout 11:09:23 INFO - Current package versions: 11:09:23 INFO - argparse == 1.2.1 11:09:23 INFO - blessings == 1.6 11:09:23 INFO - blobuploader == 1.2.4 11:09:23 INFO - docopt == 0.6.1 11:09:23 INFO - manifestparser == 1.1 11:09:23 INFO - mozInstall == 1.12 11:09:23 INFO - mozcrash == 0.16 11:09:23 INFO - mozdebug == 0.1 11:09:23 INFO - mozdevice == 0.48 11:09:23 INFO - mozfile == 1.2 11:09:23 INFO - mozhttpd == 0.7 11:09:23 INFO - mozinfo == 0.9 11:09:23 INFO - mozleak == 0.1 11:09:23 INFO - mozlog == 3.1 11:09:23 INFO - moznetwork == 0.27 11:09:23 INFO - mozprocess == 0.22 11:09:23 INFO - mozprofile == 0.28 11:09:23 INFO - mozrunner == 6.11 11:09:23 INFO - mozscreenshot == 0.1 11:09:23 INFO - mozsystemmonitor == 0.0 11:09:23 INFO - moztest == 0.7 11:09:23 INFO - mozversion == 1.4 11:09:23 INFO - psutil == 3.1.1 11:09:23 INFO - requests == 1.2.3 11:09:23 INFO - wsgiref == 0.1.2 11:09:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:23 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')]} 11:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:23 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')]} 11:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:23 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 0x7f948957bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251100>, '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 0x1252000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1252490>, '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': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', '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 11:09:23 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 11:09:23 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 11:09:23 INFO - Using env: {'DISPLAY': ':0', 11:09:23 INFO - 'HOME': '/home/cltbld', 11:09:23 INFO - 'LANG': 'en_US.UTF-8', 11:09:23 INFO - 'LANGUAGE': 'en_US:en', 11:09:23 INFO - 'LOGNAME': 'cltbld', 11:09:23 INFO - 'MAIL': '/var/mail/cltbld', 11:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:23 INFO - 'MOZ_NO_REMOTE': '1', 11:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:23 INFO - 'NO_EM_RESTART': '1', 11:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:23 INFO - 'PWD': '/builds/slave/test', 11:09:23 INFO - 'SHELL': '/bin/bash', 11:09:23 INFO - 'SHLVL': '1', 11:09:23 INFO - 'TERM': 'linux', 11:09:23 INFO - 'TMOUT': '86400', 11:09:23 INFO - 'USER': 'cltbld', 11:09:23 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', 11:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:23 INFO - '_': '/tools/buildbot/bin/python'} 11:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 INFO - Cleaning up... 11:09:23 INFO - Return code: 0 11:09:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:09:23 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')]} 11:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:23 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')]} 11:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:23 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 0x7f948957bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251100>, '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 0x1252000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1252490>, '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': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', '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 11:09:23 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 11:09:23 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 11:09:23 INFO - Using env: {'DISPLAY': ':0', 11:09:23 INFO - 'HOME': '/home/cltbld', 11:09:23 INFO - 'LANG': 'en_US.UTF-8', 11:09:23 INFO - 'LANGUAGE': 'en_US:en', 11:09:23 INFO - 'LOGNAME': 'cltbld', 11:09:23 INFO - 'MAIL': '/var/mail/cltbld', 11:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:23 INFO - 'MOZ_NO_REMOTE': '1', 11:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:23 INFO - 'NO_EM_RESTART': '1', 11:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:23 INFO - 'PWD': '/builds/slave/test', 11:09:23 INFO - 'SHELL': '/bin/bash', 11:09:23 INFO - 'SHLVL': '1', 11:09:23 INFO - 'TERM': 'linux', 11:09:23 INFO - 'TMOUT': '86400', 11:09:23 INFO - 'USER': 'cltbld', 11:09:23 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', 11:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:23 INFO - '_': '/tools/buildbot/bin/python'} 11:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:24 INFO - Downloading/unpacking jsonschema 11:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:09:25 INFO - Downloading/unpacking functools32 (from jsonschema) 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09:26 INFO - Downloading functools32-3.2.3-2.tar.gz 11:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:09:26 INFO - warning: no files found matching '*.txt' 11:09:26 INFO - no previously-included directories found matching 'build' 11:09:26 INFO - no previously-included directories found matching 'dist' 11:09:26 INFO - no previously-included directories found matching '.git*' 11:09:26 INFO - Installing collected packages: jsonschema, functools32 11:09:26 INFO - Running setup.py install for functools32 11:09:26 INFO - warning: no files found matching '*.txt' 11:09:26 INFO - no previously-included directories found matching 'build' 11:09:26 INFO - no previously-included directories found matching 'dist' 11:09:26 INFO - no previously-included directories found matching '.git*' 11:09:26 INFO - Successfully installed jsonschema functools32 11:09:26 INFO - Cleaning up... 11:09:26 INFO - Return code: 0 11:09:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f948957bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251100>, '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 0x1252000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1252490>, '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': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', '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 11:09:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:09:26 INFO - Using env: {'DISPLAY': ':0', 11:09:26 INFO - 'HOME': '/home/cltbld', 11:09:26 INFO - 'LANG': 'en_US.UTF-8', 11:09:26 INFO - 'LANGUAGE': 'en_US:en', 11:09:26 INFO - 'LOGNAME': 'cltbld', 11:09:26 INFO - 'MAIL': '/var/mail/cltbld', 11:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:26 INFO - 'MOZ_NO_REMOTE': '1', 11:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:26 INFO - 'NO_EM_RESTART': '1', 11:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:26 INFO - 'PWD': '/builds/slave/test', 11:09:26 INFO - 'SHELL': '/bin/bash', 11:09:26 INFO - 'SHLVL': '1', 11:09:26 INFO - 'TERM': 'linux', 11:09:26 INFO - 'TMOUT': '86400', 11:09:26 INFO - 'USER': 'cltbld', 11:09:26 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', 11:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:26 INFO - '_': '/tools/buildbot/bin/python'} 11:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:26 INFO - Downloading/unpacking flake8 11:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:09:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:09:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:09:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:09:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:09:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:09:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:09:29 INFO - no previously-included directories found matching 'docs/_build' 11:09:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:09:29 INFO - Running setup.py install for pep8 11:09:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:09:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:09:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:09:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:09:29 INFO - no previously-included directories found matching 'docs/_build' 11:09:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:09:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:09:29 INFO - Cleaning up... 11:09:29 INFO - Return code: 0 11:09:29 INFO - Running post-action listener: _resource_record_post_action 11:09:29 INFO - Running post-action listener: _start_resource_monitoring 11:09:29 INFO - Starting resource monitoring. 11:09:29 INFO - ##### 11:09:29 INFO - ##### Running install step. 11:09:29 INFO - ##### 11:09:29 INFO - Running pre-action listener: _resource_record_pre_action 11:09:29 INFO - Running main action method: install 11:09:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:29 INFO - Reading from file tmpfile_stdout 11:09:29 INFO - Detecting whether we're running mozinstall >=1.0... 11:09:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:09:29 INFO - Reading from file tmpfile_stdout 11:09:29 INFO - Output received: 11:09:29 INFO - Usage: mozinstall [options] installer 11:09:29 INFO - Options: 11:09:29 INFO - -h, --help show this help message and exit 11:09:29 INFO - -d DEST, --destination=DEST 11:09:29 INFO - Directory to install application into. [default: 11:09:29 INFO - "/builds/slave/test"] 11:09:29 INFO - --app=APP Application being installed. [default: firefox] 11:09:29 INFO - mkdir: /builds/slave/test/build/application 11:09:29 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'] 11:09:29 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 11:09:45 INFO - Reading from file tmpfile_stdout 11:09:45 INFO - Output received: 11:09:45 INFO - /builds/slave/test/build/application/firefox/firefox 11:09:45 INFO - Running post-action listener: _resource_record_post_action 11:09:45 INFO - ##### 11:09:45 INFO - ##### Running run-tests step. 11:09:45 INFO - ##### 11:09:45 INFO - Running pre-action listener: _resource_record_pre_action 11:09:45 INFO - Running main action method: run_tests 11:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:09:45 INFO - Python 2.7.3 11:09:45 INFO - Return code: 0 11:09:45 INFO - grabbing minidump binary from tooltool 11:09:45 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')]} 11:09:45 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 0x1251100>, '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 0x1252000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1252490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:09:45 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 11:09:45 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 11:09:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:09:45 INFO - Return code: 0 11:09:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:09:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:09:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:09:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:09:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:09:46 INFO - Return code: 0 11:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 11:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 11:09:46 INFO - Using env: {'DISPLAY': ':0', 11:09:46 INFO - 'HOME': '/home/cltbld', 11:09:46 INFO - 'LANG': 'en_US.UTF-8', 11:09:46 INFO - 'LANGUAGE': 'en_US:en', 11:09:46 INFO - 'LOGNAME': 'cltbld', 11:09:46 INFO - 'MAIL': '/var/mail/cltbld', 11:09:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:09:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:46 INFO - 'MOZ_NO_REMOTE': '1', 11:09:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:46 INFO - 'NO_EM_RESTART': '1', 11:09:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:46 INFO - 'PWD': '/builds/slave/test', 11:09:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:09:46 INFO - 'SHELL': '/bin/bash', 11:09:46 INFO - 'SHLVL': '1', 11:09:46 INFO - 'TERM': 'linux', 11:09:46 INFO - 'TMOUT': '86400', 11:09:46 INFO - 'USER': 'cltbld', 11:09:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1456772934.121299-1348343867', 11:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:46 INFO - '_': '/tools/buildbot/bin/python'} 11:09:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 11:09:46 INFO - mozversion application_buildid: 20160229094946 11:09:46 INFO - mozversion application_changeset: 04634ec900b2fb94962733148ecdeac7ae98e0e2 11:09:46 INFO - mozversion application_display_name: Nightly 11:09:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:09:46 INFO - mozversion application_name: Firefox 11:09:46 INFO - mozversion application_remotingname: firefox 11:09:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:09:46 INFO - mozversion application_vendor: Mozilla 11:09:46 INFO - mozversion application_version: 47.0a1 11:09:46 INFO - mozversion platform_buildid: 20160229094946 11:09:46 INFO - mozversion platform_changeset: 04634ec900b2fb94962733148ecdeac7ae98e0e2 11:09:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:09:46 INFO - mozversion platform_version: 47.0a1 11:09:46 INFO - using testdate: 1456772986 11:09:46 INFO - actual date: 1456772986 11:09:46 INFO - starting webserver on 'localhost:60913' 11:09:46 INFO - SUITE-START | Running 2 tests 11:09:46 INFO - TEST-START | dromaeo_css 11:09:46 INFO - operating with platform_type : linux_ 11:09:46 INFO - Initialising browser for dromaeo_css test... 11:09:46 INFO - TEST-INFO | started process 6884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpruEGgS/profile http://localhost:60913/getInfo.html) 11:09:51 INFO - PROCESS | 6884 | 11:09:51 INFO - PROCESS | 6884 | (process:6968): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:09:52 INFO - PROCESS | 6884 | __metrics Screen width/height:1600/1200 11:09:52 INFO - PROCESS | 6884 | colorDepth:24 11:09:52 INFO - PROCESS | 6884 | Browser inner width/height: 1024/697 11:09:52 INFO - PROCESS | 6884 | __metrics 11:09:53 ERROR - PROCESS | 6884 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 11:09:53 INFO - PROCESS | 6884 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:09:53 INFO - PROCESS | 6884 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:09:53 INFO - PROCESS | 6884 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:09:53 INFO - PROCESS | 6884 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:09:53 INFO - PROCESS | 6884 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:09:53 INFO - PROCESS | 6884 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:09:53 INFO - PROCESS | 6884 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:09:53 INFO - PROCESS | 6884 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:09:53 INFO - PROCESS | 6884 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:09:54 INFO - TEST-INFO | 6884: exit 0 11:09:54 INFO - Browser initialized. 11:09:54 INFO - Running cycle 1/1 for dromaeo_css test... 11:09:54 INFO - TEST-INFO | started process 7018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpruEGgS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:55 INFO - PROCESS | 7018 | 11:09:55 INFO - PROCESS | 7018 | (process:7074): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:10:06 INFO - PROCESS | 7018 | RSS: Main: 159903744 11:10:06 INFO - PROCESS | 7018 | 11:10:55 INFO - PROCESS | 7018 | 1456773055896 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] 11:13:06 INFO - PROCESS | 7018 | Cycle 1(1): loaded http://localhost:60913/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60913/tests/dromaeo/cssquery-ext.html) 11:13:07 INFO - PROCESS | 7018 | RSS: Main: 165355520 11:13:07 INFO - PROCESS | 7018 | 11:16:09 INFO - PROCESS | 7018 | Cycle 1(1): loaded http://localhost:60913/tests/dromaeo/cssquery-ext.html (next: http://localhost:60913/tests/dromaeo/cssquery-jquery.html) 11:16:10 INFO - PROCESS | 7018 | RSS: Main: 166137856 11:16:10 INFO - PROCESS | 7018 | 11:19:12 INFO - PROCESS | 7018 | Cycle 1(1): loaded http://localhost:60913/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60913/tests/dromaeo/cssquery-mootools.html) 11:19:12 INFO - PROCESS | 7018 | RSS: Main: 166559744 11:19:12 INFO - PROCESS | 7018 | 11:22:14 INFO - PROCESS | 7018 | Cycle 1(1): loaded http://localhost:60913/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60913/tests/dromaeo/cssquery-prototype.html) 11:22:15 INFO - PROCESS | 7018 | RSS: Main: 164360192 11:22:15 INFO - PROCESS | 7018 | 11:25:17 INFO - PROCESS | 7018 | Cycle 1(1): loaded http://localhost:60913/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60913/tests/dromaeo/cssquery-yui.html) 11:25:18 INFO - PROCESS | 7018 | RSS: Main: 164548608 11:25:18 INFO - PROCESS | 7018 | 11:28:20 INFO - PROCESS | 7018 | Cycle 1(1): loaded http://localhost:60913/tests/dromaeo/cssquery-yui.html (next: http://localhost:60913/tests/dromaeo/cssquery-dojo.html) 11:28:20 INFO - PROCESS | 7018 | RSS: Main: 168255488 11:28:20 INFO - PROCESS | 7018 | 11:28:20 INFO - PROCESS | 7018 | __start_tp_report 11:28:20 INFO - PROCESS | 7018 | _x_x_mozilla_page_load 11:28:20 INFO - PROCESS | 7018 | _x_x_mozilla_page_load_details 11:28:20 INFO - PROCESS | 7018 | |i|pagename|runs| 11:28:20 INFO - PROCESS | 7018 | |0;dojo.html;2629.2243788082515;2636.0641972099893;2666.160159549742;2679.0623281851354;2704.8782804773778;4501.6945085925045;4630.120277147344;4659.347691323217;4661.557152070553;4678.929816052758;4625.444946606403;4657.347971284014;4664.4402671679445;4749.548792864681;4769.5707386335225;4256.084941737534;4321.503027151871;4322.7406355618605;4343.261645520253;4343.391925130484;49.618333716773755;4161.334186530155;4241.5122260939925;4280.636145927584;4364.869053928387;4281.207976524322;4313.784310784448;4320.956790432087;4343.413639158704;4343.565643435662;4280.743155410654;4317.15815415994;4325.286327755916;4327.8485253016;4358.891027724332;4230.450041494617;4263.467066616673;4285.550017248175;4290.292101803198;4320.762358070305;4622.6301895848255;4627.629789616823;4635.884102897455;4643.698159619647;4665.856865068046;4764.2615394613895;4981.950180498185;5007.524285192901;5019.62352823536;5049;5076.086304465195;5090;5106.310648062538;5112.054269960069;5151.4333423323405;4705.529447055302;4747.905041899212;4750.192467280571;4756.357891684647;4787.976060119677;4938.160512712848;5059.19052951526;5123.513266239701;5181.3005244291535;5248.790048398021;4897.1185186666025;4918.606511479073;4925.75371231437;4929.408470983505;4968.403791545038;5003.374578177728;5004.3494345734825;5016.749162541858;5020.297158397827;5051.242313652908;4812.470628230892;4906.9263961040615;4969.652124351333;4977.178765503724;5010.098182327143;4869.2939523768855;4880.048390563877;4886.193778026657;4891.926621100686;4922.163232250526;4120.031792528754;4130;4135.255653982312;4142.689298302639;4157.334826427757;3559.430491121408;3637.0725465006253;3700.8704695336073;3714.6285371462636;3721.3673675475234;4311.762853043113;4326.351047342924;4355.346697995326;4386.363977223285;4428.402165707588;4993.400791904995;5001.949980500149;5003.874903127451;5012.624053195952;5054.166062599704;4217.514985776675;4259.254630439723;4310.698251122454;4323.718958267703;4353.629941455012;4429.933550996738;4434.357018232403;4436.600705936481;4444.755538445352;4483.910321793546;4612.123696497655;4721.740304283228;4746.905061898674;4759.904801904012;4768.117898188915;4997.525235102659;5068.898622027613;5077.416097148727;5097.515736005073;5111.284420181103;4650.48844627084;4686.437627484724;4695.906081878275;4706.670533062653;4731.408573928259;4834.540718631724;4878.585320247818;4886.218205087169;4890.168671325812;4939.431965324034;5006.499350064964;5019.924701129413;5022.673526220784;5028.446870844277;5075.568576671024;4846.709197448165;4856.805727770849;4859.07677541266;4864.829730959399;4902.240152776325;4721.055788842176;4795.568398844121;4833;4842.6368022399165;4895.73073480962;4673.252279635242;4745.881352966204;4751;4756.857294281177;4795.832145874878;4868.756562171948;4877.756112194305;4891.26631005352;4893.632977526771;4953.72754498506;4610.216263235325;4639.234526303122;4704.811807527797;4726.976365118152;4747.2879068140055 11:28:20 INFO - PROCESS | 7018 | |1;ext.html;499.47056120512246;504.1857400298519;528.2419727690763;537.6290359651842;545.046169203893;31616;32306.83846580767;32328.515072273934;32423.351532969355;32426.67573324266;33078.834605826996;33440.331193376114;33475.16312092199;33648;33688.15779605511;7365.2634736526325;7537.472376933617;7539.4345424093135;7547.094348678166;7548.131964824061;7349.889751653703;7577;7599.202083781206;7647.961760191191;7649.923500765005;7530.6987720491115;7643.656035478389;7648.9235107648765;7661.3487853532515;7664.885026724603;7548.471606987513;7643.923560764377;7676.539407635504;7677.577733224671;7691.615419229044;7399.630018499053;7544.207858174867;7567.243275672444;7577.962110189414;7608.505447145918;33004.83497582521;33544;33617.6638233617;33640.831795841106;33734.83132584346;2928.2240206345123;3000.339925216449;3100.5659207710937;3359.6808303211155;3585.928281434383;27900.30249243785;28230;28234.29414264639;28506.144815655563;29013.709862901313;3072.139800855764;3088;3113.3144617350968;3157.068664743906;3251.5122731590213;215897;217269;218354.90822545785;218449.9999999984;218716;54074.45925540773;54235.45764542304;54523.72738136284;54650.180247296325;54840;58697.82604347975;60409.69795150996;60603;60700;60729.08906366408;11992.74076221984;12209.328486933126;12275.570355037531;12276.324802135969;12374.443150058269;8972.551372431351;8980.506072165963;8984.146506081912;9011.954940225258;9039.412438191497;19279.179042945183;19406.18638597879;19456.70949339655;19488.79558804472;19529.01320621799;7825.647845846951;7852.764417067498;7917.247861453153;7953.323967462715;7965.442419030613;861.0657436681146;874.5627186406797;915.7664795477244;918.7335672654989;980.8038392321564;25629.231123066336;25826.483470330488;26064.34839129037;26101.781348585584;26168.8691556541;931.1712575807402;950.6577632052456;959.8416261316804;994.4928086675703;1046.6807623674852;11937.791508570943;12035.638930832089;12174.086943479275;12193.51225950952;12243.449044793006;252771;254330;254456;254542;254747;44747;45642.77178614152;45718.542814572094;45789.31316030262;45813.31280030802;1205.6081773423673;1217.1601594899491;1218.707510197564;1221.6579357779835;1235.0860363331071;23527.882360588086;23581;23972.28083157508;24004.51990960206;24015.159469418486;36151.81924090363;36247.818760906026;36361.636383636884;36428.45357319695;36634.26731465409;235859;236135;236565;237084;238358;26646.20061398161;26678.866605667623;26883.731162688906;27023.86488067547;39055.41416878806;34482.89653931158;35324.11689707778;35492.82253588716;35526.11184720299;35762.8211858939;29325.583485633888;30196.698033020268;30326.848365758913;30365.240868978453;30987.380252395276;32146.19634509156;32296.83851580821;32493;32537.34925301528;32929.506057409635;30197.69802301949;33171.33657326888;33223;35601.82199088988;35734.8213258932;27366.315842104108;27970.440591188468;27999.160025199275;28304.575431368135;28445.146645600664;22941.770582293964;23270.546920206798;23580.29259122229;23631.172908948105;23689.17087901915 11:28:20 INFO - PROCESS | 7018 | |2;jquery.html;335.9647237040111;337.1907422186752;337.4920744279859;338.79502900745047;342.9365567370035;14943.626409339759;15154.62113447163;15436.382544698212;16168.595785105348;16211.108389038627;14775.374708782025;14983.475578354759;14986;15556.766648500254;15560.53318400447;4772.427308722949;4974.527419895122;5014.498550144993;5022.874428139307;5029.823956161535;4708.964027913854;4982.252662100677;4993.950060499385;4999.625028122905;5001.749912504379;4916.041371932474;4927.630427717918;4945.950540494585;4948.7773050212645;4957.603391728671;4718.622510199193;4929.2359684248995;4938.1111399947995;4976.527229913152;4993.700377977297;4396.868093957187;4431.689781715281;4447.510773814878;4449.866504004885;4450.5104438511735;18280;18663.906680466647;18696.43910682668;18709.158087886077;18828;1619.3279788887598;1736.8089510153873;1833.1292635997795;2076.0657704033247;2234.944126396853;8890.86663700045;9034.051424600453;9078.364514483988;10581.10060644846;12532.436040378114;1666.5916850371616;1676.6395225026556;1723.1987125986352;1758.446089481822;1773.0602780526342;53107.46892531064;53986.73006634942;55000.449995499934;55707.72146139284;55793.72103139499;9705.466199359103;9771.778527684039;9854.556544955494;9866.084713818016;9994.700158995242;12456.128071035122;12593.30736809466;12605.684857878627;12609.747805043848;12634.81047784284;6598.670066496656;6621.635810030494;6714.060031595581;6715.764948226789;6735.797926062226;6196.504279657616;6198.132261483396;6208.1308616793685;6255.843603909939;6302.338254483305;4065.207284579538;4067.7152599317765;4166.416701661769;4183.037901282722;4254.446921900195;1659.3694396129395;1716.1333526569003;1730.7403889416437;1739.4781565530543;1778.9579818510492;411.54935345796304;860.3461369359331;944.9527523623791;1006.0643601450574;1011.4335971855784;9063.456192628464;9920.603175873028;9976.102150806462;10077.832861543331;10147.441890696082;403.98990025249014;409.77462395682255;420.98526551570546;427.55107137505496;797.330242596222;8087.919120808717;8181.67273309061;8273.255407013397;8306.916930830736;8400.831983360298;253772;255785;375642;380219;382139;67324.6633766828;67548.32451675518;67777.66111169412;68013;69734.65132674304;904.3579058868277;919.2599957034518;930.6835675870236;932.1098351074708;934.9439033658002;13950.720985580434;14079;14137.575872723835;14199.858001419854;14366.281685915454;30097.79608815623;31114.999999999094;31498.370032598763;31804.363912722078;31899.68100318967;40922.79538602288;42858.142837142455;44037.559624403344;44385.33421998737;44921.1015779676;6483.902741458787;6531.11829902957;6544;6648.800535983928;6652.567583107082;9142.451452912846;10050.296479246383;10096.798064038825;10195.086849627347;10288.897111029093;8719.65121395137;8809.559522023745;8838.469691818511;8924.464532128093;9177.908220917972;8900.21486034083;9359.110884465965;9467.431954082776;9492.288078394009;9530.666426675032;9115.589798458952;9727.854082188915;10112.292139550162;10120.291579589359;10145.594176232868;6674.399304062657;6849.726010959505;6872;6915.550489218184;6949.583025018515;8590.613422396133;9280.62877484893;9402.34183607141;9720.902790971999;9842.60629574809 11:28:20 INFO - PROCESS | 7018 | |3;mootools.html;1366.3851266929883;1367.6512489315223;1494.230471307277;1694.9067801270926;1714.9828501714978;5968.462838344548;6917.342852429024;6987.755428559995;7124.536905101171;7147.035150254714;6993.44052475802;7039.683214255358;7050.471214658908;7115.857682846353;7122.679479423426;2047.0992763184188;2069.3895300886275;2072.0572139676487;2073.9792602074012;2080.3134965461436;2052.887091209983;2055.5169535159225;2074.813266805987;2106.5260316428835;2127.7659457459667;2086.7078608994675;2095.476130967258;2109.3144727963395;2119.5972765174565;2123.6495978163584;2068.917243310266;2080.906359213839;2083.260442542906;2089.1434511850143;2089.861025740975;2067.1421360135528;2092.9476763080893;2120.120150137691;2124.0654112190587;2126.2451829600423;7165.713371465135;7205.7838264852135;7249.637518124126;7251.963740181318;7289.38040266578;4273.145370925828;4387.692861499696;4387.868363949086;4413.602775750166;4429.512753597101;2555.821092523524;2671.4523522678;2688.596710493422;2693.7979651526216;2694.339886727764;837.1502924531605;839.7606682095635;847.9406441549094;858.107568129145;876.8640860666607;9807.803843923082;9814.754631134207;9835.852462213072;9863.506824658738;9880.703578892644;3818.9236215275537;3896.8699077267274;3904.39481880309;3974.423708562242;4001.1797581495725;8450.366222533212;8451.873221901677;8458.28104611115;8470.449420787629;8499.192576705203;4303.526612072669;4310.116426132635;4353.10761293934;4357.564243575617;4359.585839345257;3095.6904309569313;3812.3519001769764;3858.2090671412293;3892.338302488584;3898.9805050974564;3400.931981360359;3461.913452163716;3464.359093567698;3484.7212223022098;3512.666296701809;1093.8359246113146;1098.5441041967495;1099.2250463423427;1107.1143085531542;1112.3048094940661;915.0392088307384;952.8808898887639;1178.6581891251442;1179.1274456902001;1198.628425188177;6697.3637504437;6739.326067393319;6750.898736518956;6791.728330866808;6812.1144251248015;1048.308116643012;1060.0830281806182;1066.989330106689;1077.4235783855756;1087.8368244763349;5242.213667949762;5275.604329675213;5277.050130976461;5307.442718514578;5325.653832500875;7922.4850384724805;8372.079071302152;8414.410991230556;8457.661693532313;8457.703980360659;8340.04089529712;8365.539895305696;8371.497710137412;8381.07808141104;8398.790030249293;6841.144856892888;6849.623270720158;6997.335253150841;7013;7047.68285427157;6653.068570400244;6656.600603963778;6659.600423974577;6660.900951342974;6667.233268174222;7712;7938.880916786368;7973.162817904036;7995.520268783892;8035.236652518001;7929.920700792918;8145.144759800372;8154.714584989497;8166.346692264486;8264.090949995616;4993.15116430215;5419.945800541944;5556.249906262603;5991.3409524953095;6078.696065196634;6626.204855417188;6640.83397915056;6665.633390163587;6687.297833727389;6696.0960270362875;5948.821535353946;5996.2504686914135;6108.816735497942;6115.7247923844425;6156.507479401726;5943.435373639497;5974.731137098754;5975.312839023568;6051.697415129138;6172.783952561639;6197.96901015492;6233.906491402542;6237.750489980532;6249.562530622813;6299.11812346281;5890.057590785454;5898.675572843535;5919.319278283053;5939.762409503572;5945;5718.285214348207;5799.246098007232;5866.7066646668345;5868.002439585366;5869.530437564899 11:28:20 INFO - PROCESS | 7018 | |4;prototype.html;290.58736594036463;296.3406420713911;298.1829786385304;298.79233932416963;300.56718325611104;5579.525740312073;5670.234518340023;5696.829095127153;5711.114777209539;5729.312482502095;5606.943930560693;5615.2138700581845;5625.634333768302;5630.15547667849;5686.857828554288;4007.7194596378195;4160.771157586331;4198.139381426816;4247.405363249148;4270.12462445198;4238.660907127438;4257.297545904922;4283.464566929134;4299.785010749466;4299.935500967488;4204.705670603059;4247.469066366704;4263.997960479285;4265.872023839274;4281.48622165339;4207.453031105937;4255.829766809339;4260.297050986584;4262.360645903108;4289.549597292271;3728.981355093207;3729.216864458467;3734.551853777537;3740.7942563159017;3748.11919198988;5349.545288650469;5375.516203541661;5384.757685904144;5389.056915039852;5405.18922161675;4623.029163875556;4742.810287588492;4749.311349854252;4758.476567577598;4945.653804233705;5783.392743761887;5789.363170051291;5812.912806307909;5818.301803783573;5820.068788993783;3898.9220215595815;3909.7458665186673;3918.235943990923;3918.3534716771983;3920.6863450924143;6175.07373893915;6197.845053873644;6232.9376706232815;6242.094896240065;6252.124702541648;4063.89840253996;4064.207479541461;4067;4074.2869997750277;4077.673786097105;4109.732867363612;4135.565765594569;4136.5863413659;4138.52406973202;4148.79256037203;4626.282926146453;4797.496262892346;4836.7339796310835;4852.684575502652;4854.150523658345;5925.081612350093;5955.970220148872;5958.46373826349;5960.552958528127;5965.910511342333;1429.335359058043;1460.3063544816127;1461.590754588717;1463.1952426165567;1464.5240296903337;928.150742071011;946.8921362006469;950.4677380666849;979.2313034268208;979.8530220466987;5106.131957567222;5169.043726910533;5195.792168313225;5197.246399272084;5210.687358758487;6109.75560977556;6167.506599472032;6168.383161683796;6187.288461826857;6195.822793669188;5082.974585127125;5146.6911985281;5150.27896094547;5153.6907785532985;5215.322008138917;3326.085326535222;3362.5460562824196;3363.428217203081;3365.2764655598676;3372.2581032172884;5823.650580965071;5913.349531551526;5916.704164791743;5917.053271476543;5927.3776253493625;6399.296077431479;6417.358264173638;6425.775097871552;6430;6433.742650293936;5825.0679891217205;5841.7371218295275;5842.182094506772;5842.474177324061;5854.531637468992;6050.092486127116;6170.382961703794;6229.626222426669;6243.875122497434;6246.312905580474;6094.664793436226;6098.146259523582;6099.359567245376;6103.908441373294;6118.694065296629;5805.564582656233;5816.040353341651;5828.737706803119;5856.707164641665;5861.00362938293;4011.1777085696776;4036.889855289819;4038.0914294284726;4041.3331800253804;4056.371262454324;6173.969130154321;6232.127502149793;6233.532485063548;6239.563230573816;6241.3134555197985;5718;5922.1412895130825;5979.22270104901;6005.939940600538;6019.819405417845;5970.104484327386;5991.610545314541;5994.160817485643;5996.310424301087;6014.939850601613;5848.327442344185;5855.03391940325;5857.619254748428;5858.677772722541;5868.706564671664;5990.910136348046;6009.7295621698;6033;6063.939360606338;6066.787662431971;5764.422196144825;5810.854728631818;5884.176215329943;5895.204147440212;5905.143754155709 11:28:20 INFO - PROCESS | 7018 | |5;yui.html;705.5519744961948;724.2576359231786;729.9160596531399;732.2165283147035;733.9376153026992;10283.845742313863;10729.8390524142;10770.73073173171;10837.241393102486;10845.8373124403;11385.259958102717;11578;11717.0626349892;11821.34982575958;11890.346030968294;604.5194070713771;753.4010461682975;759.2559291893947;769.4729110559257;773.4199350487135;776.6116941529235;777.7666699990009;779.5128044971892;781.4725060584111;782.3389236095519;803.5901690138043;811.2050190813006;812.8577498937692;813.0852790610563;820.0364571628343;801.2228138705447;802.6869520886888;803.5098589860181;804.1998211779259;815.64927081355;593.5340757505337;598.3717097048082;599.3796420704593;601.5007543738686;604.6855635069783;11607.651770446815;11650.70873228176;11665.533378664843;11688.883111168865;11717.648470545897;10928.781424371547;11273.492692828842;11290.153238507062;11463.942680286546;11557.133215008907;9128.90871091294;9349.906500934972;9406.95296523513;9411.011843756376;9485.672005919178;3215.6623554526905;3219.3722224166295;3243.1567792373917;3283.0479161043268;3289.5723555937816;40617.593824061674;40679;40716.38925416121;41105;41442.37836432456;8291.33669306454;8626.094260102724;8634.179752923463;8693.304535637133;8741.475511469333;16080.517584472485;16082.758758618396;16230.837691623168;16373.590660233589;16451.58871028234;6294.937050629526;6490.545661803723;6515.446187074152;6539.967300163468;6596.96701516499;3406.2846802171325;3456.1705190754037;3459.3773120837986;3504.176518518146;3551.5915669698315;2521.583938650139;2588.184721812623;2593.610958356224;2597.1039991203006;2600.2069368842685;474.95487928646725;488.577380565808;488.59934853420566;489.20259976239214;491.26555799080603;454.6976260786606;471.9103370359621;531.8537402214345;549.5603517186235;564.6285600477927;6468.482521398277;6574.506911981525;6581.703823327962;6754.6284954327;6765.05289259504;509.8572399728082;532.9120695085345;551.6965668882099;621.316551793024;623.2023010546508;3087.984560077185;3157.5105858591955;3158.494640857452;3255.674432556773;3262.559554460165;46236.306455403195;46958;47432;47467.762661186476;47528;42816.357754633704;43255;43690.34464483035;43711;44101.33847992283;38054.42918356227;38609.99999999944;38800.22399551993;38933.41599876004;39319.60680393217;7551.962240188984;7582.469227154046;7668.386529077548;7872.763817085496;8081.393895457747;29815.85092074526;30822.53766193464;31549.684503154676;31685.36629267448;31743.841280793447;37590.248195036496;39010.80494597509;39130.2173956525;39231;39322.21355572815;9215.539223038688;9837.655682051094;9919.702408927744;9971.850422243528;10136;10663.200259980378;10697.251192416456;10706.518206680874;10728.463576821285;10867.836982445111;10110.797784044425;10200.642977495752;10255.641052563124;10317.329373590692;10424.270301078852;8702.782430439289;8924.86612700823;8960.820783584422;8961.283097352327;9059.864102038342;9379.155875971195;9384.155426011692;9526.571304291185;9558.95220523893;9614.90385096168;8338.166183381612;8417.284530814704;8507.702230422154;8579.742607721779;8664.653413863627;7954.959860523362;8622.698205563027;8645.170315450974;8778.166074222938;8967.865482017645 11:28:20 INFO - PROCESS | 7018 | __end_tp_report 11:28:20 INFO - PROCESS | 7018 | __start_cc_report 11:28:20 INFO - PROCESS | 7018 | _x_x_mozilla_cycle_collect,330 11:28:20 INFO - PROCESS | 7018 | __end_cc_report 11:28:20 INFO - PROCESS | 7018 | __startTimestamp1456774100927__endTimestamp 11:28:20 INFO - PROCESS | 7018 | 11:28:20 INFO - PROCESS | 7018 | ------- Summary: start ------- 11:28:20 INFO - PROCESS | 7018 | Number of tests: 6 11:28:20 INFO - PROCESS | 7018 | 11:28:20 INFO - PROCESS | 7018 | [#0] dojo.html Cycles:165 Average:4585.28 Median:4746.91 stddev:597.93 (12.6%) stddev-sans-first:579.74 11:28:20 INFO - PROCESS | 7018 | Values: 2629.2 2636.1 2666.2 2679.1 2704.9 4501.7 4630.1 4659.3 4661.6 4678.9 4625.4 4657.3 4664.4 4749.5 4769.6 4256.1 4321.5 4322.7 4343.3 4343.4 49.6 4161.3 4241.5 4280.6 4364.9 4281.2 4313.8 4321.0 4343.4 4343.6 4280.7 4317.2 4325.3 4327.8 4358.9 4230.5 4263.5 4285.6 4290.3 4320.8 4622.6 4627.6 4635.9 4643.7 4665.9 4764.3 4982.0 5007.5 5019.6 5049.0 5076.1 5090.0 5106.3 5112.1 5151.4 4705.5 4747.9 4750.2 4756.4 4788.0 4938.2 5059.2 5123.5 5181.3 5248.8 4897.1 4918.6 4925.8 4929.4 4968.4 5003.4 5004.3 5016.7 5020.3 5051.2 4812.5 4906.9 4969.7 4977.2 5010.1 4869.3 4880.0 4886.2 4891.9 4922.2 4120.0 4130.0 4135.3 4142.7 4157.3 3559.4 3637.1 3700.9 3714.6 3721.4 4311.8 4326.4 4355.3 4386.4 4428.4 4993.4 5001.9 5003.9 5012.6 5054.2 4217.5 4259.3 4310.7 4323.7 4353.6 4429.9 4434.4 4436.6 4444.8 4483.9 4612.1 4721.7 4746.9 4759.9 4768.1 4997.5 5068.9 5077.4 5097.5 5111.3 4650.5 4686.4 4695.9 4706.7 4731.4 4834.5 4878.6 4886.2 4890.2 4939.4 5006.5 5019.9 5022.7 5028.4 5075.6 4846.7 4856.8 4859.1 4864.8 4902.2 4721.1 4795.6 4833.0 4842.6 4895.7 4673.3 4745.9 4751.0 4756.9 4795.8 4868.8 4877.8 4891.3 4893.6 4953.7 4610.2 4639.2 4704.8 4727.0 4747.3 11:28:20 INFO - PROCESS | 7018 | 11:28:20 INFO - PROCESS | 7018 | [#1] ext.html Cycles:180 Average:38986.20 Median:33125.09 stddev:61721.45 (186.3%) stddev-sans-first:61826.95 11:28:20 INFO - PROCESS | 7018 | Values: 499.5 504.2 528.2 537.6 545.0 31616.0 32306.8 32328.5 32423.4 32426.7 33078.8 33440.3 33475.2 33648.0 33688.2 7365.3 7537.5 7539.4 7547.1 7548.1 7349.9 7577.0 7599.2 7648.0 7649.9 7530.7 7643.7 7648.9 7661.3 7664.9 7548.5 7643.9 7676.5 7677.6 7691.6 7399.6 7544.2 7567.2 7578.0 7608.5 33004.8 33544.0 33617.7 33640.8 33734.8 2928.2 3000.3 3100.6 3359.7 3585.9 27900.3 28230.0 28234.3 28506.1 29013.7 3072.1 3088.0 3113.3 3157.1 3251.5 215897.0 217269.0 218354.9 218450.0 218716.0 54074.5 54235.5 54523.7 54650.2 54840.0 58697.8 60409.7 60603.0 60700.0 60729.1 11992.7 12209.3 12275.6 12276.3 12374.4 8972.6 8980.5 8984.1 9012.0 9039.4 19279.2 19406.2 19456.7 19488.8 19529.0 7825.6 7852.8 7917.2 7953.3 7965.4 861.1 874.6 915.8 918.7 980.8 25629.2 25826.5 26064.3 26101.8 26168.9 931.2 950.7 959.8 994.5 1046.7 11937.8 12035.6 12174.1 12193.5 12243.4 252771.0 254330.0 254456.0 254542.0 254747.0 44747.0 45642.8 45718.5 45789.3 45813.3 1205.6 1217.2 1218.7 1221.7 1235.1 23527.9 23581.0 23972.3 24004.5 24015.2 36151.8 36247.8 36361.6 36428.5 36634.3 235859.0 236135.0 236565.0 237084.0 238358.0 26646.2 26678.9 26883.7 27023.9 39055.4 34482.9 35324.1 35492.8 35526.1 35762.8 29325.6 30196.7 30326.8 30365.2 30987.4 32146.2 32296.8 32493.0 32537.3 32929.5 30197.7 33171.3 33223.0 35601.8 35734.8 27366.3 27970.4 27999.2 28304.6 28445.1 22941.8 23270.5 23580.3 23631.2 23689.2 11:28:20 INFO - PROCESS | 7018 | 11:28:20 INFO - PROCESS | 7018 | [#2] jquery.html Cycles:180 Average:20864.12 Median:4844.23 stddev:55291.57 (1141.4%) stddev-sans-first:55425.19 11:28:20 INFO - PROCESS | 7018 | Values: 336.0 337.2 337.5 338.8 342.9 14943.6 15154.6 15436.4 16168.6 16211.1 14775.4 14983.5 14986.0 15556.8 15560.5 4772.4 4974.5 5014.5 5022.9 5029.8 4709.0 4982.3 4994.0 4999.6 5001.7 4916.0 4927.6 4946.0 4948.8 4957.6 4718.6 4929.2 4938.1 4976.5 4993.7 4396.9 4431.7 4447.5 4449.9 4450.5 18280.0 18663.9 18696.4 18709.2 18828.0 1619.3 1736.8 1833.1 2076.1 2234.9 8890.9 9034.1 9078.4 10581.1 12532.4 1666.6 1676.6 1723.2 1758.4 1773.1 53107.5 53986.7 55000.4 55707.7 55793.7 9705.5 9771.8 9854.6 9866.1 9994.7 12456.1 12593.3 12605.7 12609.7 12634.8 6598.7 6621.6 6714.1 6715.8 6735.8 6196.5 6198.1 6208.1 6255.8 6302.3 4065.2 4067.7 4166.4 4183.0 4254.4 1659.4 1716.1 1730.7 1739.5 1779.0 411.5 860.3 945.0 1006.1 1011.4 9063.5 9920.6 9976.1 10077.8 10147.4 404.0 409.8 421.0 427.6 797.3 8087.9 8181.7 8273.3 8306.9 8400.8 253772.0 255785.0 375642.0 380219.0 382139.0 67324.7 67548.3 67777.7 68013.0 69734.7 904.4 919.3 930.7 932.1 934.9 13950.7 14079.0 14137.6 14199.9 14366.3 30097.8 31115.0 31498.4 31804.4 31899.7 40922.8 42858.1 44037.6 44385.3 44921.1 6483.9 6531.1 6544.0 6648.8 6652.6 9142.5 10050.3 10096.8 10195.1 10288.9 8719.7 8809.6 8838.5 8924.5 9177.9 8900.2 9359.1 9467.4 9492.3 9530.7 9115.6 9727.9 10112.3 10120.3 10145.6 6674.4 6849.7 6872.0 6915.6 6949.6 8590.6 9280.6 9402.3 9720.9 9842.6 11:28:20 INFO - PROCESS | 7018 | 11:28:20 INFO - PROCESS | 7018 | [#3] mootools.html Cycles:180 Average:4965.15 Median:5944.22 stddev:2570.85 (43.2%) stddev-sans-first:2563.83 11:28:20 INFO - PROCESS | 7018 | Values: 1366.4 1367.7 1494.2 1694.9 1715.0 5968.5 6917.3 6987.8 7124.5 7147.0 6993.4 7039.7 7050.5 7115.9 7122.7 2047.1 2069.4 2072.1 2074.0 2080.3 2052.9 2055.5 2074.8 2106.5 2127.8 2086.7 2095.5 2109.3 2119.6 2123.6 2068.9 2080.9 2083.3 2089.1 2089.9 2067.1 2092.9 2120.1 2124.1 2126.2 7165.7 7205.8 7249.6 7252.0 7289.4 4273.1 4387.7 4387.9 4413.6 4429.5 2555.8 2671.5 2688.6 2693.8 2694.3 837.2 839.8 847.9 858.1 876.9 9807.8 9814.8 9835.9 9863.5 9880.7 3818.9 3896.9 3904.4 3974.4 4001.2 8450.4 8451.9 8458.3 8470.4 8499.2 4303.5 4310.1 4353.1 4357.6 4359.6 3095.7 3812.4 3858.2 3892.3 3899.0 3400.9 3461.9 3464.4 3484.7 3512.7 1093.8 1098.5 1099.2 1107.1 1112.3 915.0 952.9 1178.7 1179.1 1198.6 6697.4 6739.3 6750.9 6791.7 6812.1 1048.3 1060.1 1067.0 1077.4 1087.8 5242.2 5275.6 5277.1 5307.4 5325.7 7922.5 8372.1 8414.4 8457.7 8457.7 8340.0 8365.5 8371.5 8381.1 8398.8 6841.1 6849.6 6997.3 7013.0 7047.7 6653.1 6656.6 6659.6 6660.9 6667.2 7712.0 7938.9 7973.2 7995.5 8035.2 7929.9 8145.1 8154.7 8166.3 8264.1 4993.2 5419.9 5556.2 5991.3 6078.7 6626.2 6640.8 6665.6 6687.3 6696.1 5948.8 5996.3 6108.8 6115.7 6156.5 5943.4 5974.7 5975.3 6051.7 6172.8 6198.0 6233.9 6237.8 6249.6 6299.1 5890.1 5898.7 5919.3 5939.8 5945.0 5718.3 5799.2 5866.7 5868.0 5869.5 11:28:20 INFO - PROCESS | 7018 | 11:28:20 INFO - PROCESS | 7018 | [#4] prototype.html Cycles:180 Average:4883.64 Median:5678.55 stddev:1487.70 (26.2%) stddev-sans-first:1451.38 11:28:20 INFO - PROCESS | 7018 | Values: 290.6 296.3 298.2 298.8 300.6 5579.5 5670.2 5696.8 5711.1 5729.3 5606.9 5615.2 5625.6 5630.2 5686.9 4007.7 4160.8 4198.1 4247.4 4270.1 4238.7 4257.3 4283.5 4299.8 4299.9 4204.7 4247.5 4264.0 4265.9 4281.5 4207.5 4255.8 4260.3 4262.4 4289.5 3729.0 3729.2 3734.6 3740.8 3748.1 5349.5 5375.5 5384.8 5389.1 5405.2 4623.0 4742.8 4749.3 4758.5 4945.7 5783.4 5789.4 5812.9 5818.3 5820.1 3898.9 3909.7 3918.2 3918.4 3920.7 6175.1 6197.8 6232.9 6242.1 6252.1 4063.9 4064.2 4067.0 4074.3 4077.7 4109.7 4135.6 4136.6 4138.5 4148.8 4626.3 4797.5 4836.7 4852.7 4854.2 5925.1 5956.0 5958.5 5960.6 5965.9 1429.3 1460.3 1461.6 1463.2 1464.5 928.2 946.9 950.5 979.2 979.9 5106.1 5169.0 5195.8 5197.2 5210.7 6109.8 6167.5 6168.4 6187.3 6195.8 5083.0 5146.7 5150.3 5153.7 5215.3 3326.1 3362.5 3363.4 3365.3 3372.3 5823.7 5913.3 5916.7 5917.1 5927.4 6399.3 6417.4 6425.8 6430.0 6433.7 5825.1 5841.7 5842.2 5842.5 5854.5 6050.1 6170.4 6229.6 6243.9 6246.3 6094.7 6098.1 6099.4 6103.9 6118.7 5805.6 5816.0 5828.7 5856.7 5861.0 4011.2 4036.9 4038.1 4041.3 4056.4 6174.0 6232.1 6233.5 6239.6 6241.3 5718.0 5922.1 5979.2 6005.9 6019.8 5970.1 5991.6 5994.2 5996.3 6014.9 5848.3 5855.0 5857.6 5858.7 5868.7 5990.9 6009.7 6033.0 6063.9 6066.8 5764.4 5810.9 5884.2 5895.2 5905.1 11:28:20 INFO - PROCESS | 7018 | 11:28:20 INFO - PROCESS | 7018 | [#5] yui.html Cycles:180 Average:11819.85 Median:488.90 stddev:13477.29 (2756.6%) stddev-sans-first:13489.25 11:28:20 INFO - PROCESS | 7018 | Values: 705.6 724.3 729.9 732.2 733.9 10283.8 10729.8 10770.7 10837.2 10845.8 11385.3 11578.0 11717.1 11821.3 11890.3 604.5 753.4 759.3 769.5 773.4 776.6 777.8 779.5 781.5 782.3 803.6 811.2 812.9 813.1 820.0 801.2 802.7 803.5 804.2 815.6 593.5 598.4 599.4 601.5 604.7 11607.7 11650.7 11665.5 11688.9 11717.6 10928.8 11273.5 11290.2 11463.9 11557.1 9128.9 9349.9 9407.0 9411.0 9485.7 3215.7 3219.4 3243.2 3283.0 3289.6 40617.6 40679.0 40716.4 41105.0 41442.4 8291.3 8626.1 8634.2 8693.3 8741.5 16080.5 16082.8 16230.8 16373.6 16451.6 6294.9 6490.5 6515.4 6540.0 6597.0 3406.3 3456.2 3459.4 3504.2 3551.6 2521.6 2588.2 2593.6 2597.1 2600.2 475.0 488.6 488.6 489.2 491.3 454.7 471.9 531.9 549.6 564.6 6468.5 6574.5 6581.7 6754.6 6765.1 509.9 532.9 551.7 621.3 623.2 3088.0 3157.5 3158.5 3255.7 3262.6 46236.3 46958.0 47432.0 47467.8 47528.0 42816.4 43255.0 43690.3 43711.0 44101.3 38054.4 38610.0 38800.2 38933.4 39319.6 7552.0 7582.5 7668.4 7872.8 8081.4 29815.9 30822.5 31549.7 31685.4 31743.8 37590.2 39010.8 39130.2 39231.0 39322.2 9215.5 9837.7 9919.7 9971.9 10136.0 10663.2 10697.3 10706.5 10728.5 10867.8 10110.8 10200.6 10255.6 10317.3 10424.3 8702.8 8924.9 8960.8 8961.3 9059.9 9379.2 9384.2 9526.6 9559.0 9614.9 8338.2 8417.3 8507.7 8579.7 8664.7 7955.0 8622.7 8645.2 8778.2 8967.9 11:28:20 INFO - PROCESS | 7018 | -------- Summary: end -------- 11:28:20 INFO - PROCESS | 7018 | 11:28:21 INFO - PROCESS | 7018 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:21 INFO - PROCESS | 7018 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:21 INFO - PROCESS | 7018 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:21 INFO - PROCESS | 7018 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:21 INFO - PROCESS | 7018 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:21 INFO - PROCESS | 7018 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:21 INFO - PROCESS | 7018 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:21 INFO - PROCESS | 7018 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:21 INFO - TEST-INFO | 7018: exit 0 11:28:21 INFO - TEST-OK | dromaeo_css | took 1114730ms 11:28:21 INFO - TEST-START | kraken 11:28:21 INFO - operating with platform_type : linux_ 11:28:21 INFO - Initialising browser for kraken test... 11:28:21 INFO - TEST-INFO | started process 7255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuocW62/profile http://localhost:60913/getInfo.html) 11:28:25 INFO - PROCESS | 7255 | 11:28:25 INFO - PROCESS | 7255 | (process:7326): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:28:26 INFO - PROCESS | 7255 | __metrics Screen width/height:1600/1200 11:28:26 INFO - PROCESS | 7255 | colorDepth:24 11:28:26 INFO - PROCESS | 7255 | Browser inner width/height: 1024/697 11:28:26 INFO - PROCESS | 7255 | __metrics 11:28:27 ERROR - PROCESS | 7255 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 11:28:27 INFO - PROCESS | 7255 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:27 INFO - PROCESS | 7255 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:27 INFO - PROCESS | 7255 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:27 INFO - PROCESS | 7255 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:27 INFO - PROCESS | 7255 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:27 INFO - PROCESS | 7255 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:27 INFO - PROCESS | 7255 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:27 INFO - PROCESS | 7255 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:27 INFO - PROCESS | 7255 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:28:28 INFO - TEST-INFO | 7255: exit 0 11:28:28 INFO - Browser initialized. 11:28:28 INFO - Running cycle 1/1 for kraken test... 11:28:28 INFO - TEST-INFO | started process 7377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuocW62/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:29 INFO - PROCESS | 7377 | 11:28:29 INFO - PROCESS | 7377 | (process:7433): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:28:40 INFO - PROCESS | 7377 | RSS: Main: 161021952 11:28:40 INFO - PROCESS | 7377 | 11:28:42 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60913/tests/kraken/driver.html?testName=audio-beat-detection) 11:28:43 INFO - PROCESS | 7377 | RSS: Main: 167378944 11:28:43 INFO - PROCESS | 7377 | 11:28:46 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60913/tests/kraken/driver.html?testName=audio-dft) 11:28:46 INFO - PROCESS | 7377 | RSS: Main: 169771008 11:28:46 INFO - PROCESS | 7377 | 11:28:49 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60913/tests/kraken/driver.html?testName=audio-fft) 11:28:50 INFO - PROCESS | 7377 | RSS: Main: 162369536 11:28:50 INFO - PROCESS | 7377 | 11:28:52 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60913/tests/kraken/driver.html?testName=audio-oscillator) 11:28:52 INFO - PROCESS | 7377 | RSS: Main: 163508224 11:28:52 INFO - PROCESS | 7377 | 11:28:55 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60913/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:28:55 INFO - PROCESS | 7377 | RSS: Main: 163098624 11:28:55 INFO - PROCESS | 7377 | 11:28:58 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60913/tests/kraken/driver.html?testName=imaging-darkroom) 11:28:59 INFO - PROCESS | 7377 | RSS: Main: 163516416 11:28:59 INFO - PROCESS | 7377 | 11:29:03 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60913/tests/kraken/driver.html?testName=imaging-desaturate) 11:29:03 INFO - PROCESS | 7377 | RSS: Main: 163020800 11:29:03 INFO - PROCESS | 7377 | 11:29:06 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60913/tests/kraken/driver.html?testName=json-parse-financial) 11:29:07 INFO - PROCESS | 7377 | RSS: Main: 163926016 11:29:07 INFO - PROCESS | 7377 | 11:29:08 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60913/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:29:09 INFO - PROCESS | 7377 | RSS: Main: 165445632 11:29:09 INFO - PROCESS | 7377 | 11:29:11 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:29:11 INFO - PROCESS | 7377 | RSS: Main: 164839424 11:29:11 INFO - PROCESS | 7377 | 11:29:14 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:29:14 INFO - PROCESS | 7377 | RSS: Main: 164659200 11:29:14 INFO - PROCESS | 7377 | 11:29:17 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:29:17 INFO - PROCESS | 7377 | RSS: Main: 165330944 11:29:17 INFO - PROCESS | 7377 | 11:29:20 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:29:21 INFO - PROCESS | 7377 | RSS: Main: 165400576 11:29:21 INFO - PROCESS | 7377 | 11:29:22 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60913/tests/kraken/driver.html?testName=ai-astar) 11:29:23 INFO - PROCESS | 7377 | RSS: Main: 167538688 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | __start_tp_report 11:29:23 INFO - PROCESS | 7377 | _x_x_mozilla_page_load 11:29:23 INFO - PROCESS | 7377 | _x_x_mozilla_page_load_details 11:29:23 INFO - PROCESS | 7377 | |i|pagename|runs| 11:29:23 INFO - PROCESS | 7377 | |0;ai-astar;117;110;117;113;115;125;114;116;115;117 11:29:23 INFO - PROCESS | 7377 | |1;audio-beat-detection;160;142;163;175;132;159;156;142;187;139 11:29:23 INFO - PROCESS | 7377 | |2;audio-dft;162;164;165;163;166;169;169;163;165;163 11:29:23 INFO - PROCESS | 7377 | |3;audio-fft;76;74;73;167;74;74;74;74;151;74 11:29:23 INFO - PROCESS | 7377 | |4;audio-oscillator;98;98;137;98;98;99;148;100;98;142 11:29:23 INFO - PROCESS | 7377 | |5;imaging-gaussian-blur;120;116;116;116;115;115;116;116;119;116 11:29:23 INFO - PROCESS | 7377 | |6;imaging-darkroom;148;149;148;148;146;147;149;148;148;148 11:29:23 INFO - PROCESS | 7377 | |7;imaging-desaturate;97;98;96;96;97;96;97;96;97;97 11:29:23 INFO - PROCESS | 7377 | |8;json-parse-financial;67;69;67;68;71;67;67;75;66;65 11:29:23 INFO - PROCESS | 7377 | |9;json-stringify-tinderbox;70;72;71;71;71;72;72;71;71;71 11:29:23 INFO - PROCESS | 7377 | |10;stanford-crypto-aes;85;85;84;86;89;87;84;86;87;83 11:29:23 INFO - PROCESS | 7377 | |11;stanford-crypto-ccm;122;124;136;121;129;140;124;127;131;123 11:29:23 INFO - PROCESS | 7377 | |12;stanford-crypto-pbkdf2;142;140;151;153;151;138;148;150;154;152 11:29:23 INFO - PROCESS | 7377 | |13;stanford-crypto-sha256-iterative;79;74;72;71;71;72;70;73;69;70 11:29:23 INFO - PROCESS | 7377 | __end_tp_report 11:29:23 INFO - PROCESS | 7377 | __start_cc_report 11:29:23 INFO - PROCESS | 7377 | _x_x_mozilla_cycle_collect,863 11:29:23 INFO - PROCESS | 7377 | __end_cc_report 11:29:23 INFO - PROCESS | 7377 | __startTimestamp1456774163244__endTimestamp 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | ------- Summary: start ------- 11:29:23 INFO - PROCESS | 7377 | Number of tests: 14 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.50 stddev:3.87 (3.3%) stddev-sans-first:4.09 11:29:23 INFO - PROCESS | 7377 | Values: 117.0 110.0 117.0 113.0 115.0 125.0 114.0 116.0 115.0 117.0 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | [#1] audio-beat-detection Cycles:10 Average:155.50 Median:159.50 stddev:17.16 (10.8%) stddev-sans-first:18.12 11:29:23 INFO - PROCESS | 7377 | Values: 160.0 142.0 163.0 175.0 132.0 159.0 156.0 142.0 187.0 139.0 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:2.47 (1.5%) stddev-sans-first:2.39 11:29:23 INFO - PROCESS | 7377 | Values: 162.0 164.0 165.0 163.0 166.0 169.0 169.0 163.0 165.0 163.0 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | [#3] audio-fft Cycles:10 Average:91.10 Median:74.00 stddev:35.99 (48.6%) stddev-sans-first:37.76 11:29:23 INFO - PROCESS | 7377 | Values: 76.0 74.0 73.0 167.0 74.0 74.0 74.0 74.0 151.0 74.0 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:98.00 stddev:21.38 (21.8%) stddev-sans-first:22.10 11:29:23 INFO - PROCESS | 7377 | Values: 98.0 98.0 137.0 98.0 98.0 99.0 148.0 100.0 98.0 142.0 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.00 stddev:1.65 (1.4%) stddev-sans-first:1.17 11:29:23 INFO - PROCESS | 7377 | Values: 120.0 116.0 116.0 116.0 115.0 115.0 116.0 116.0 119.0 116.0 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 11:29:23 INFO - PROCESS | 7377 | Values: 148.0 149.0 148.0 148.0 146.0 147.0 149.0 148.0 148.0 148.0 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 11:29:23 INFO - PROCESS | 7377 | Values: 97.0 98.0 96.0 96.0 97.0 96.0 97.0 96.0 97.0 97.0 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | [#8] json-parse-financial Cycles:10 Average:68.20 Median:67.50 stddev:2.90 (4.3%) stddev-sans-first:3.04 11:29:23 INFO - PROCESS | 7377 | Values: 67.0 69.0 67.0 68.0 71.0 67.0 67.0 75.0 66.0 65.0 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 11:29:23 INFO - PROCESS | 7377 | Values: 70.0 72.0 71.0 71.0 71.0 72.0 72.0 71.0 71.0 71.0 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:1.78 (2.1%) stddev-sans-first:1.87 11:29:23 INFO - PROCESS | 7377 | Values: 85.0 85.0 84.0 86.0 89.0 87.0 84.0 86.0 87.0 83.0 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:128.00 stddev:6.33 (4.9%) stddev-sans-first:6.36 11:29:23 INFO - PROCESS | 7377 | Values: 122.0 124.0 136.0 121.0 129.0 140.0 124.0 127.0 131.0 123.0 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:151.00 stddev:5.76 (3.8%) stddev-sans-first:5.70 11:29:23 INFO - PROCESS | 7377 | Values: 142.0 140.0 151.0 153.0 151.0 138.0 148.0 150.0 154.0 152.0 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:2.85 (4.0%) stddev-sans-first:1.58 11:29:23 INFO - PROCESS | 7377 | Values: 79.0 74.0 72.0 71.0 71.0 72.0 70.0 73.0 69.0 70.0 11:29:23 INFO - PROCESS | 7377 | -------- Summary: end -------- 11:29:23 INFO - PROCESS | 7377 | 11:29:23 INFO - PROCESS | 7377 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:29:23 INFO - PROCESS | 7377 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:29:23 INFO - PROCESS | 7377 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:29:23 INFO - PROCESS | 7377 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:29:23 INFO - PROCESS | 7377 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:29:23 INFO - PROCESS | 7377 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:29:23 INFO - PROCESS | 7377 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:29:24 INFO - TEST-INFO | 7377: exit 0 11:29:24 INFO - TEST-OK | kraken | took 62625ms 11:29:24 INFO - SUITE-END | took 1177s 11:29:24 INFO - Completed test suite (00:19:37) 11:29:24 INFO - Working with test: dromaeo_css 11:29:24 INFO - Generating results file: dromaeo_css 11:29:24 INFO - Working with test: kraken 11:29:24 INFO - Generating results file: kraken 11:29:24 INFO - javascript benchmark 11:29:24 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:29:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 11:29:41 INFO - process_Request line: dromaeo_css 6125.69 graph.html#tests=[[72,132,43]] 11:29:41 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:29:41 INFO - process_Request line: kraken 1572.80 graph.html#tests=[[232,132,43]] 11:29:41 INFO - RETURN: dromaeo_css: 6125.69 11:29:41 INFO - RETURN: kraken: 1572.80 11:29:41 INFO - javascript benchmark 11:29:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2629.2243788082515, 2636.0641972099893, 2666.160159549742, 2679.0623281851354, 2704.8782804773778, 4501.6945085925045, 4630.120277147344, 4659.347691323217, 4661.557152070553, 4678.929816052758, 4625.444946606403, 4657.347971284014, 4664.4402671679445, 4749.548792864681, 4769.5707386335225, 4256.084941737534, 4321.503027151871, 4322.7406355618605, 4343.261645520253, 4343.391925130484, 49.618333716773755, 4161.334186530155, 4241.5122260939925, 4280.636145927584, 4364.869053928387, 4281.207976524322, 4313.784310784448, 4320.956790432087, 4343.413639158704, 4343.565643435662, 4280.743155410654, 4317.15815415994, 4325.286327755916, 4327.8485253016, 4358.891027724332, 4230.450041494617, 4263.467066616673, 4285.550017248175, 4290.292101803198, 4320.762358070305, 4622.6301895848255, 4627.629789616823, 4635.884102897455, 4643.698159619647, 4665.856865068046, 4764.2615394613895, 4981.950180498185, 5007.524285192901, 5019.62352823536, 5049.0, 5076.086304465195, 5090.0, 5106.310648062538, 5112.054269960069, 5151.4333423323405, 4705.529447055302, 4747.905041899212, 4750.192467280571, 4756.357891684647, 4787.976060119677, 4938.160512712848, 5059.19052951526, 5123.513266239701, 5181.3005244291535, 5248.790048398021, 4897.1185186666025, 4918.606511479073, 4925.75371231437, 4929.408470983505, 4968.403791545038, 5003.374578177728, 5004.3494345734825, 5016.749162541858, 5020.297158397827, 5051.242313652908, 4812.470628230892, 4906.9263961040615, 4969.652124351333, 4977.178765503724, 5010.098182327143, 4869.2939523768855, 4880.048390563877, 4886.193778026657, 4891.926621100686, 4922.163232250526, 4120.031792528754, 4130.0, 4135.255653982312, 4142.689298302639, 4157.334826427757, 3559.430491121408, 3637.0725465006253, 3700.8704695336073, 3714.6285371462636, 3721.3673675475234, 4311.762853043113, 4326.351047342924, 4355.346697995326, 4386.363977223285, 4428.402165707588, 4993.400791904995, 5001.949980500149, 5003.874903127451, 5012.624053195952, 5054.166062599704, 4217.514985776675, 4259.254630439723, 4310.698251122454, 4323.718958267703, 4353.629941455012, 4429.933550996738, 4434.357018232403, 4436.600705936481, 4444.755538445352, 4483.910321793546, 4612.123696497655, 4721.740304283228, 4746.905061898674, 4759.904801904012, 4768.117898188915, 4997.525235102659, 5068.898622027613, 5077.416097148727, 5097.515736005073, 5111.284420181103, 4650.48844627084, 4686.437627484724, 4695.906081878275, 4706.670533062653, 4731.408573928259, 4834.540718631724, 4878.585320247818, 4886.218205087169, 4890.168671325812, 4939.431965324034, 5006.499350064964, 5019.924701129413, 5022.673526220784, 5028.446870844277, 5075.568576671024, 4846.709197448165, 4856.805727770849, 4859.07677541266, 4864.829730959399, 4902.240152776325, 4721.055788842176, 4795.568398844121, 4833.0, 4842.6368022399165, 4895.73073480962, 4673.252279635242, 4745.881352966204, 4751.0, 4756.857294281177, 4795.832145874878, 4868.756562171948, 4877.756112194305, 4891.26631005352, 4893.632977526771, 4953.72754498506, 4610.216263235325, 4639.234526303122, 4704.811807527797, 4726.976365118152, 4747.2879068140055], "unit": "score", "name": "dojo.html", "value": 4550.170227023586}, {"lowerIsBetter": false, "replicates": [499.47056120512246, 504.1857400298519, 528.2419727690763, 537.6290359651842, 545.046169203893, 31616.0, 32306.83846580767, 32328.515072273934, 32423.351532969355, 32426.67573324266, 33078.834605826996, 33440.331193376114, 33475.16312092199, 33648.0, 33688.15779605511, 7365.2634736526325, 7537.472376933617, 7539.4345424093135, 7547.094348678166, 7548.131964824061, 7349.889751653703, 7577.0, 7599.202083781206, 7647.961760191191, 7649.923500765005, 7530.6987720491115, 7643.656035478389, 7648.9235107648765, 7661.3487853532515, 7664.885026724603, 7548.471606987513, 7643.923560764377, 7676.539407635504, 7677.577733224671, 7691.615419229044, 7399.630018499053, 7544.207858174867, 7567.243275672444, 7577.962110189414, 7608.505447145918, 33004.83497582521, 33544.0, 33617.6638233617, 33640.831795841106, 33734.83132584346, 2928.2240206345123, 3000.339925216449, 3100.5659207710937, 3359.6808303211155, 3585.928281434383, 27900.30249243785, 28230.0, 28234.29414264639, 28506.144815655563, 29013.709862901313, 3072.139800855764, 3088.0, 3113.3144617350968, 3157.068664743906, 3251.5122731590213, 215897.0, 217269.0, 218354.90822545785, 218449.9999999984, 218716.0, 54074.45925540773, 54235.45764542304, 54523.72738136284, 54650.180247296325, 54840.0, 58697.82604347975, 60409.69795150996, 60603.0, 60700.0, 60729.08906366408, 11992.74076221984, 12209.328486933126, 12275.570355037531, 12276.324802135969, 12374.443150058269, 8972.551372431351, 8980.506072165963, 8984.146506081912, 9011.954940225258, 9039.412438191497, 19279.179042945183, 19406.18638597879, 19456.70949339655, 19488.79558804472, 19529.01320621799, 7825.647845846951, 7852.764417067498, 7917.247861453153, 7953.323967462715, 7965.442419030613, 861.0657436681146, 874.5627186406797, 915.7664795477244, 918.7335672654989, 980.8038392321564, 25629.231123066336, 25826.483470330488, 26064.34839129037, 26101.781348585584, 26168.8691556541, 931.1712575807402, 950.6577632052456, 959.8416261316804, 994.4928086675703, 1046.6807623674852, 11937.791508570943, 12035.638930832089, 12174.086943479275, 12193.51225950952, 12243.449044793006, 252771.0, 254330.0, 254456.0, 254542.0, 254747.0, 44747.0, 45642.77178614152, 45718.542814572094, 45789.31316030262, 45813.31280030802, 1205.6081773423673, 1217.1601594899491, 1218.707510197564, 1221.6579357779835, 1235.0860363331071, 23527.882360588086, 23581.0, 23972.28083157508, 24004.51990960206, 24015.159469418486, 36151.81924090363, 36247.818760906026, 36361.636383636884, 36428.45357319695, 36634.26731465409, 235859.0, 236135.0, 236565.0, 237084.0, 238358.0, 26646.20061398161, 26678.866605667623, 26883.731162688906, 27023.86488067547, 39055.41416878806, 34482.89653931158, 35324.11689707778, 35492.82253588716, 35526.11184720299, 35762.8211858939, 29325.583485633888, 30196.698033020268, 30326.848365758913, 30365.240868978453, 30987.380252395276, 32146.19634509156, 32296.83851580821, 32493.0, 32537.34925301528, 32929.506057409635, 30197.69802301949, 33171.33657326888, 33223.0, 35601.82199088988, 35734.8213258932, 27366.315842104108, 27970.440591188468, 27999.160025199275, 28304.575431368135, 28445.146645600664, 22941.770582293964, 23270.546920206798, 23580.29259122229, 23631.172908948105, 23689.17087901915], "unit": "score", "name": "ext.html", "value": 16124.469794525688}, {"lowerIsBetter": false, "replicates": [335.9647237040111, 337.1907422186752, 337.4920744279859, 338.79502900745047, 342.9365567370035, 14943.626409339759, 15154.62113447163, 15436.382544698212, 16168.595785105348, 16211.108389038627, 14775.374708782025, 14983.475578354759, 14986.0, 15556.766648500254, 15560.53318400447, 4772.427308722949, 4974.527419895122, 5014.498550144993, 5022.874428139307, 5029.823956161535, 4708.964027913854, 4982.252662100677, 4993.950060499385, 4999.625028122905, 5001.749912504379, 4916.041371932474, 4927.630427717918, 4945.950540494585, 4948.7773050212645, 4957.603391728671, 4718.622510199193, 4929.2359684248995, 4938.1111399947995, 4976.527229913152, 4993.700377977297, 4396.868093957187, 4431.689781715281, 4447.510773814878, 4449.866504004885, 4450.5104438511735, 18280.0, 18663.906680466647, 18696.43910682668, 18709.158087886077, 18828.0, 1619.3279788887598, 1736.8089510153873, 1833.1292635997795, 2076.0657704033247, 2234.944126396853, 8890.86663700045, 9034.051424600453, 9078.364514483988, 10581.10060644846, 12532.436040378114, 1666.5916850371616, 1676.6395225026556, 1723.1987125986352, 1758.446089481822, 1773.0602780526342, 53107.46892531064, 53986.73006634942, 55000.449995499934, 55707.72146139284, 55793.72103139499, 9705.466199359103, 9771.778527684039, 9854.556544955494, 9866.084713818016, 9994.700158995242, 12456.128071035122, 12593.30736809466, 12605.684857878627, 12609.747805043848, 12634.81047784284, 6598.670066496656, 6621.635810030494, 6714.060031595581, 6715.764948226789, 6735.797926062226, 6196.504279657616, 6198.132261483396, 6208.1308616793685, 6255.843603909939, 6302.338254483305, 4065.207284579538, 4067.7152599317765, 4166.416701661769, 4183.037901282722, 4254.446921900195, 1659.3694396129395, 1716.1333526569003, 1730.7403889416437, 1739.4781565530543, 1778.9579818510492, 411.54935345796304, 860.3461369359331, 944.9527523623791, 1006.0643601450574, 1011.4335971855784, 9063.456192628464, 9920.603175873028, 9976.102150806462, 10077.832861543331, 10147.441890696082, 403.98990025249014, 409.77462395682255, 420.98526551570546, 427.55107137505496, 797.330242596222, 8087.919120808717, 8181.67273309061, 8273.255407013397, 8306.916930830736, 8400.831983360298, 253772.0, 255785.0, 375642.0, 380219.0, 382139.0, 67324.6633766828, 67548.32451675518, 67777.66111169412, 68013.0, 69734.65132674304, 904.3579058868277, 919.2599957034518, 930.6835675870236, 932.1098351074708, 934.9439033658002, 13950.720985580434, 14079.0, 14137.575872723835, 14199.858001419854, 14366.281685915454, 30097.79608815623, 31114.999999999094, 31498.370032598763, 31804.363912722078, 31899.68100318967, 40922.79538602288, 42858.142837142455, 44037.559624403344, 44385.33421998737, 44921.1015779676, 6483.902741458787, 6531.11829902957, 6544.0, 6648.800535983928, 6652.567583107082, 9142.451452912846, 10050.296479246383, 10096.798064038825, 10195.086849627347, 10288.897111029093, 8719.65121395137, 8809.559522023745, 8838.469691818511, 8924.464532128093, 9177.908220917972, 8900.21486034083, 9359.110884465965, 9467.431954082776, 9492.288078394009, 9530.666426675032, 9115.589798458952, 9727.854082188915, 10112.292139550162, 10120.291579589359, 10145.594176232868, 6674.399304062657, 6849.726010959505, 6872.0, 6915.550489218184, 6949.583025018515, 8590.613422396133, 9280.62877484893, 9402.34183607141, 9720.902790971999, 9842.60629574809], "unit": "score", "name": "jquery.html", "value": 7301.649805695121}, {"lowerIsBetter": false, "replicates": [1366.3851266929883, 1367.6512489315223, 1494.230471307277, 1694.9067801270926, 1714.9828501714978, 5968.462838344548, 6917.342852429024, 6987.755428559995, 7124.536905101171, 7147.035150254714, 6993.44052475802, 7039.683214255358, 7050.471214658908, 7115.857682846353, 7122.679479423426, 2047.0992763184188, 2069.3895300886275, 2072.0572139676487, 2073.9792602074012, 2080.3134965461436, 2052.887091209983, 2055.5169535159225, 2074.813266805987, 2106.5260316428835, 2127.7659457459667, 2086.7078608994675, 2095.476130967258, 2109.3144727963395, 2119.5972765174565, 2123.6495978163584, 2068.917243310266, 2080.906359213839, 2083.260442542906, 2089.1434511850143, 2089.861025740975, 2067.1421360135528, 2092.9476763080893, 2120.120150137691, 2124.0654112190587, 2126.2451829600423, 7165.713371465135, 7205.7838264852135, 7249.637518124126, 7251.963740181318, 7289.38040266578, 4273.145370925828, 4387.692861499696, 4387.868363949086, 4413.602775750166, 4429.512753597101, 2555.821092523524, 2671.4523522678, 2688.596710493422, 2693.7979651526216, 2694.339886727764, 837.1502924531605, 839.7606682095635, 847.9406441549094, 858.107568129145, 876.8640860666607, 9807.803843923082, 9814.754631134207, 9835.852462213072, 9863.506824658738, 9880.703578892644, 3818.9236215275537, 3896.8699077267274, 3904.39481880309, 3974.423708562242, 4001.1797581495725, 8450.366222533212, 8451.873221901677, 8458.28104611115, 8470.449420787629, 8499.192576705203, 4303.526612072669, 4310.116426132635, 4353.10761293934, 4357.564243575617, 4359.585839345257, 3095.6904309569313, 3812.3519001769764, 3858.2090671412293, 3892.338302488584, 3898.9805050974564, 3400.931981360359, 3461.913452163716, 3464.359093567698, 3484.7212223022098, 3512.666296701809, 1093.8359246113146, 1098.5441041967495, 1099.2250463423427, 1107.1143085531542, 1112.3048094940661, 915.0392088307384, 952.8808898887639, 1178.6581891251442, 1179.1274456902001, 1198.628425188177, 6697.3637504437, 6739.326067393319, 6750.898736518956, 6791.728330866808, 6812.1144251248015, 1048.308116643012, 1060.0830281806182, 1066.989330106689, 1077.4235783855756, 1087.8368244763349, 5242.213667949762, 5275.604329675213, 5277.050130976461, 5307.442718514578, 5325.653832500875, 7922.4850384724805, 8372.079071302152, 8414.410991230556, 8457.661693532313, 8457.703980360659, 8340.04089529712, 8365.539895305696, 8371.497710137412, 8381.07808141104, 8398.790030249293, 6841.144856892888, 6849.623270720158, 6997.335253150841, 7013.0, 7047.68285427157, 6653.068570400244, 6656.600603963778, 6659.600423974577, 6660.900951342974, 6667.233268174222, 7712.0, 7938.880916786368, 7973.162817904036, 7995.520268783892, 8035.236652518001, 7929.920700792918, 8145.144759800372, 8154.714584989497, 8166.346692264486, 8264.090949995616, 4993.15116430215, 5419.945800541944, 5556.249906262603, 5991.3409524953095, 6078.696065196634, 6626.204855417188, 6640.83397915056, 6665.633390163587, 6687.297833727389, 6696.0960270362875, 5948.821535353946, 5996.2504686914135, 6108.816735497942, 6115.7247923844425, 6156.507479401726, 5943.435373639497, 5974.731137098754, 5975.312839023568, 6051.697415129138, 6172.783952561639, 6197.96901015492, 6233.906491402542, 6237.750489980532, 6249.562530622813, 6299.11812346281, 5890.057590785454, 5898.675572843535, 5919.319278283053, 5939.762409503572, 5945.0, 5718.285214348207, 5799.246098007232, 5866.7066646668345, 5868.002439585366, 5869.530437564899], "unit": "score", "name": "mootools.html", "value": 4092.2260788520157}, {"lowerIsBetter": false, "replicates": [290.58736594036463, 296.3406420713911, 298.1829786385304, 298.79233932416963, 300.56718325611104, 5579.525740312073, 5670.234518340023, 5696.829095127153, 5711.114777209539, 5729.312482502095, 5606.943930560693, 5615.2138700581845, 5625.634333768302, 5630.15547667849, 5686.857828554288, 4007.7194596378195, 4160.771157586331, 4198.139381426816, 4247.405363249148, 4270.12462445198, 4238.660907127438, 4257.297545904922, 4283.464566929134, 4299.785010749466, 4299.935500967488, 4204.705670603059, 4247.469066366704, 4263.997960479285, 4265.872023839274, 4281.48622165339, 4207.453031105937, 4255.829766809339, 4260.297050986584, 4262.360645903108, 4289.549597292271, 3728.981355093207, 3729.216864458467, 3734.551853777537, 3740.7942563159017, 3748.11919198988, 5349.545288650469, 5375.516203541661, 5384.757685904144, 5389.056915039852, 5405.18922161675, 4623.029163875556, 4742.810287588492, 4749.311349854252, 4758.476567577598, 4945.653804233705, 5783.392743761887, 5789.363170051291, 5812.912806307909, 5818.301803783573, 5820.068788993783, 3898.9220215595815, 3909.7458665186673, 3918.235943990923, 3918.3534716771983, 3920.6863450924143, 6175.07373893915, 6197.845053873644, 6232.9376706232815, 6242.094896240065, 6252.124702541648, 4063.89840253996, 4064.207479541461, 4067.0, 4074.2869997750277, 4077.673786097105, 4109.732867363612, 4135.565765594569, 4136.5863413659, 4138.52406973202, 4148.79256037203, 4626.282926146453, 4797.496262892346, 4836.7339796310835, 4852.684575502652, 4854.150523658345, 5925.081612350093, 5955.970220148872, 5958.46373826349, 5960.552958528127, 5965.910511342333, 1429.335359058043, 1460.3063544816127, 1461.590754588717, 1463.1952426165567, 1464.5240296903337, 928.150742071011, 946.8921362006469, 950.4677380666849, 979.2313034268208, 979.8530220466987, 5106.131957567222, 5169.043726910533, 5195.792168313225, 5197.246399272084, 5210.687358758487, 6109.75560977556, 6167.506599472032, 6168.383161683796, 6187.288461826857, 6195.822793669188, 5082.974585127125, 5146.6911985281, 5150.27896094547, 5153.6907785532985, 5215.322008138917, 3326.085326535222, 3362.5460562824196, 3363.428217203081, 3365.2764655598676, 3372.2581032172884, 5823.650580965071, 5913.349531551526, 5916.704164791743, 5917.053271476543, 5927.3776253493625, 6399.296077431479, 6417.358264173638, 6425.775097871552, 6430.0, 6433.742650293936, 5825.0679891217205, 5841.7371218295275, 5842.182094506772, 5842.474177324061, 5854.531637468992, 6050.092486127116, 6170.382961703794, 6229.626222426669, 6243.875122497434, 6246.312905580474, 6094.664793436226, 6098.146259523582, 6099.359567245376, 6103.908441373294, 6118.694065296629, 5805.564582656233, 5816.040353341651, 5828.737706803119, 5856.707164641665, 5861.00362938293, 4011.1777085696776, 4036.889855289819, 4038.0914294284726, 4041.3331800253804, 4056.371262454324, 6173.969130154321, 6232.127502149793, 6233.532485063548, 6239.563230573816, 6241.3134555197985, 5718.0, 5922.1412895130825, 5979.22270104901, 6005.939940600538, 6019.819405417845, 5970.104484327386, 5991.610545314541, 5994.160817485643, 5996.310424301087, 6014.939850601613, 5848.327442344185, 5855.03391940325, 5857.619254748428, 5858.677772722541, 5868.706564671664, 5990.910136348046, 6009.7295621698, 6033.0, 6063.939360606338, 6066.787662431971, 5764.422196144825, 5810.854728631818, 5884.176215329943, 5895.204147440212, 5905.143754155709], "unit": "score", "name": "prototype.html", "value": 4393.490736173105}, {"lowerIsBetter": false, "replicates": [705.5519744961948, 724.2576359231786, 729.9160596531399, 732.2165283147035, 733.9376153026992, 10283.845742313863, 10729.8390524142, 10770.73073173171, 10837.241393102486, 10845.8373124403, 11385.259958102717, 11578.0, 11717.0626349892, 11821.34982575958, 11890.346030968294, 604.5194070713771, 753.4010461682975, 759.2559291893947, 769.4729110559257, 773.4199350487135, 776.6116941529235, 777.7666699990009, 779.5128044971892, 781.4725060584111, 782.3389236095519, 803.5901690138043, 811.2050190813006, 812.8577498937692, 813.0852790610563, 820.0364571628343, 801.2228138705447, 802.6869520886888, 803.5098589860181, 804.1998211779259, 815.64927081355, 593.5340757505337, 598.3717097048082, 599.3796420704593, 601.5007543738686, 604.6855635069783, 11607.651770446815, 11650.70873228176, 11665.533378664843, 11688.883111168865, 11717.648470545897, 10928.781424371547, 11273.492692828842, 11290.153238507062, 11463.942680286546, 11557.133215008907, 9128.90871091294, 9349.906500934972, 9406.95296523513, 9411.011843756376, 9485.672005919178, 3215.6623554526905, 3219.3722224166295, 3243.1567792373917, 3283.0479161043268, 3289.5723555937816, 40617.593824061674, 40679.0, 40716.38925416121, 41105.0, 41442.37836432456, 8291.33669306454, 8626.094260102724, 8634.179752923463, 8693.304535637133, 8741.475511469333, 16080.517584472485, 16082.758758618396, 16230.837691623168, 16373.590660233589, 16451.58871028234, 6294.937050629526, 6490.545661803723, 6515.446187074152, 6539.967300163468, 6596.96701516499, 3406.2846802171325, 3456.1705190754037, 3459.3773120837986, 3504.176518518146, 3551.5915669698315, 2521.583938650139, 2588.184721812623, 2593.610958356224, 2597.1039991203006, 2600.2069368842685, 474.95487928646725, 488.577380565808, 488.59934853420566, 489.20259976239214, 491.26555799080603, 454.6976260786606, 471.9103370359621, 531.8537402214345, 549.5603517186235, 564.6285600477927, 6468.482521398277, 6574.506911981525, 6581.703823327962, 6754.6284954327, 6765.05289259504, 509.8572399728082, 532.9120695085345, 551.6965668882099, 621.316551793024, 623.2023010546508, 3087.984560077185, 3157.5105858591955, 3158.494640857452, 3255.674432556773, 3262.559554460165, 46236.306455403195, 46958.0, 47432.0, 47467.762661186476, 47528.0, 42816.357754633704, 43255.0, 43690.34464483035, 43711.0, 44101.33847992283, 38054.42918356227, 38609.99999999944, 38800.22399551993, 38933.41599876004, 39319.60680393217, 7551.962240188984, 7582.469227154046, 7668.386529077548, 7872.763817085496, 8081.393895457747, 29815.85092074526, 30822.53766193464, 31549.684503154676, 31685.36629267448, 31743.841280793447, 37590.248195036496, 39010.80494597509, 39130.2173956525, 39231.0, 39322.21355572815, 9215.539223038688, 9837.655682051094, 9919.702408927744, 9971.850422243528, 10136.0, 10663.200259980378, 10697.251192416456, 10706.518206680874, 10728.463576821285, 10867.836982445111, 10110.797784044425, 10200.642977495752, 10255.641052563124, 10317.329373590692, 10424.270301078852, 8702.782430439289, 8924.86612700823, 8960.820783584422, 8961.283097352327, 9059.864102038342, 9379.155875971195, 9384.155426011692, 9526.571304291185, 9558.95220523893, 9614.90385096168, 8338.166183381612, 8417.284530814704, 8507.702230422154, 8579.742607721779, 8664.653413863627, 7954.959860523362, 8622.698205563027, 8645.170315450974, 8778.166074222938, 8967.865482017645], "unit": "score", "name": "yui.html", "value": 5485.136987500926}], "name": "dromaeo_css", "value": 6125.693352738468}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 110.0, 117.0, 113.0, 115.0, 125.0, 114.0, 116.0, 115.0, 117.0], "unit": "score", "name": "ai-astar", "value": 115.9}, {"lowerIsBetter": true, "replicates": [160.0, 142.0, 163.0, 175.0, 132.0, 159.0, 156.0, 142.0, 187.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 155.5}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 165.0, 163.0, 166.0, 169.0, 169.0, 163.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.9}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 73.0, 167.0, 74.0, 74.0, 74.0, 74.0, 151.0, 74.0], "unit": "score", "name": "audio-fft", "value": 91.1}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 137.0, 98.0, 98.0, 99.0, 148.0, 100.0, 98.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 111.6}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 116.0, 116.0, 115.0, 115.0, 116.0, 116.0, 119.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.5}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 148.0, 148.0, 146.0, 147.0, 149.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 68.0, 71.0, 67.0, 67.0, 75.0, 66.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 68.2}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 71.0, 71.0, 71.0, 72.0, 72.0, 71.0, 71.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.2}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 84.0, 86.0, 89.0, 87.0, 84.0, 86.0, 87.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [122.0, 124.0, 136.0, 121.0, 129.0, 140.0, 124.0, 127.0, 131.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.7}, {"lowerIsBetter": true, "replicates": [142.0, 140.0, 151.0, 153.0, 151.0, 138.0, 148.0, 150.0, 154.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [79.0, 74.0, 72.0, 71.0, 71.0, 72.0, 70.0, 73.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.1}], "name": "kraken", "value": 1572.8}]} 11:29:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1572.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6125.69"}}} 11:29:41 INFO - Return code: 0 11:29:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:29:41 ERROR - # TBPL SUCCESS # 11:29:41 INFO - Running post-action listener: _resource_record_post_action 11:29:41 INFO - Running post-run listener: _resource_record_post_run 11:29:42 INFO - Total resource usage - Wall time: 1212s; CPU: 13.0%; Read bytes: 8192; Write bytes: 526614528; Read time: 24; Write time: 808140 11:29:42 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 233680896; Read time: 0; Write time: 466088 11:29:42 INFO - run-tests - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292818944; Read time: 24; Write time: 341884 11:29:42 INFO - Running post-run listener: _upload_blobber_files 11:29:42 INFO - Blob upload gear active. 11:29:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:29:42 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 11:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:29:43 INFO - (blobuploader) - INFO - Open directory for files ... 11:29:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:29:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:29:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:44 INFO - (blobuploader) - INFO - Done attempting. 11:29:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:29:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:29:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:44 INFO - (blobuploader) - INFO - Done attempting. 11:29:44 INFO - (blobuploader) - INFO - Iteration through files over. 11:29:44 INFO - Return code: 0 11:29:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:29:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:29:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40cbdc633c1c4de810e053764bd7721d864098467bc7b18e8cbecb5d31966ad199a5273ca2defeadfe384b92ddd1d5a149991c3a1bb80e57e3263297e98afc1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e67a6656a9f858fe7fc80502cd7f82f98fb652b6a4d559038c0fb6b7fc6ad07b21e73cd500ceaa9c613df59988785ef490731fb2f3d07d811cd18e78933f16a7"} 11:29:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:29:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:29:44 INFO - Contents: 11:29:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40cbdc633c1c4de810e053764bd7721d864098467bc7b18e8cbecb5d31966ad199a5273ca2defeadfe384b92ddd1d5a149991c3a1bb80e57e3263297e98afc1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e67a6656a9f858fe7fc80502cd7f82f98fb652b6a4d559038c0fb6b7fc6ad07b21e73cd500ceaa9c613df59988785ef490731fb2f3d07d811cd18e78933f16a7"} 11:29:44 INFO - Running post-run listener: copy_logs_to_upload_dir 11:29:44 INFO - Copying logs to upload dir... 11:29:44 INFO - mkdir: /builds/slave/test/build/upload/logs 11:29:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.190094 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-02-29 11:29:44.924176) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 11:29:44.929154) ========= 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=745a4373a2a16df560f216e000000264-1456772934.121299-1348343867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40cbdc633c1c4de810e053764bd7721d864098467bc7b18e8cbecb5d31966ad199a5273ca2defeadfe384b92ddd1d5a149991c3a1bb80e57e3263297e98afc1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e67a6656a9f858fe7fc80502cd7f82f98fb652b6a4d559038c0fb6b7fc6ad07b21e73cd500ceaa9c613df59988785ef490731fb2f3d07d811cd18e78933f16a7"} build_url:https://queue.taskcluster.net/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/H551OqKyQK6xqUhX41S_qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40cbdc633c1c4de810e053764bd7721d864098467bc7b18e8cbecb5d31966ad199a5273ca2defeadfe384b92ddd1d5a149991c3a1bb80e57e3263297e98afc1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e67a6656a9f858fe7fc80502cd7f82f98fb652b6a4d559038c0fb6b7fc6ad07b21e73cd500ceaa9c613df59988785ef490731fb2f3d07d811cd18e78933f16a7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 11:29:44.954061) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:29:44.954399) ========= 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=745a4373a2a16df560f216e000000264-1456772934.121299-1348343867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:29:45.039971) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 11:29:45.040825) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 11:29:45.041465) ========= ========= Total master_lag: 0.31 =========