builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-063 starttime: 1449677253.48 results: success (0) buildid: 20151209072942 builduid: 64c637351ddc44148d7c7588ff22aaa5 revision: 6c9319ab4430fd2858325fd1546d8fcc8fe513d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:33.481352) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:33.481848) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:33.482210) ========= 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=edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006187 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:33.528178) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:33.528534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:33.558920) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:33.559246) ========= 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=edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:33.610601) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:33.610972) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:33.611478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:33.612014) ========= 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=edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 08:07:33-- 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% 224M=0s 2015-12-09 08:07:33 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.262336 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:33.897780) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:33.898105) ========= 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=edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.118292 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:34.030878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:34.031300) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6c9319ab4430fd2858325fd1546d8fcc8fe513d7 --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 6c9319ab4430fd2858325fd1546d8fcc8fe513d7 --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=edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 08:07:34,119 truncating revision to first 12 chars 2015-12-09 08:07:34,119 Setting DEBUG logging. 2015-12-09 08:07:34,119 attempt 1/10 2015-12-09 08:07:34,119 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6c9319ab4430?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 08:07:34,373 unpacking tar archive at: fx-team-6c9319ab4430/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524074 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:34.568254) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:34.568574) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:34.576558) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:34.576870) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 08:07:34.577318) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2015-12-09 08:07:34.577639) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--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=edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:07:34 INFO - MultiFileLogger online at 20151209 08:07:34 in /builds/slave/test 08:07:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:07:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:07:34 INFO - {'append_to_log': False, 08:07:34 INFO - 'base_work_dir': '/builds/slave/test', 08:07:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:07:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:07:34 INFO - 'branch': 'Fx-Team-Non-PGO', 08:07:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:07:34 INFO - 'config_files': ('talos/linux_config.py',), 08:07:34 INFO - 'default_actions': ('clobber', 08:07:34 INFO - 'read-buildbot-config', 08:07:34 INFO - 'download-and-extract', 08:07:34 INFO - 'populate-webroot', 08:07:34 INFO - 'create-virtualenv', 08:07:34 INFO - 'install', 08:07:34 INFO - 'run-tests'), 08:07:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:07:34 INFO - 'download_minidump_stackwalk': True, 08:07:34 INFO - 'download_symbols': 'ondemand', 08:07:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:07:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:07:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:07:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:07:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:07:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:07:34 INFO - 'installer_path': 'installer.exe', 08:07:34 INFO - 'log_level': 'info', 08:07:34 INFO - 'log_name': 'talos', 08:07:34 INFO - 'log_to_console': True, 08:07:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:07:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:07:34 INFO - 'opt_config_files': (), 08:07:34 INFO - 'pip_index': False, 08:07:34 INFO - 'sps_profile': False, 08:07:34 INFO - 'sps_profile_interval': 0, 08:07:34 INFO - 'suite': 'dromaeojs', 08:07:34 INFO - 'system_bits': '64', 08:07:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:07:34 INFO - 'title': 'talos-linux64-ix-063', 08:07:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:07:34 INFO - 'use_talos_json': True, 08:07:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:07:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:07:34 INFO - 'work_dir': 'build'} 08:07:34 INFO - ##### 08:07:34 INFO - ##### Running clobber step. 08:07:34 INFO - ##### 08:07:34 INFO - Running pre-action listener: _resource_record_pre_action 08:07:34 INFO - Running main action method: clobber 08:07:34 INFO - rmtree: /builds/slave/test/build 08:07:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:07:36 INFO - Running post-action listener: _resource_record_post_action 08:07:36 INFO - ##### 08:07:36 INFO - ##### Running read-buildbot-config step. 08:07:36 INFO - ##### 08:07:36 INFO - Running pre-action listener: _resource_record_pre_action 08:07:36 INFO - Running main action method: read_buildbot_config 08:07:36 INFO - Using buildbot properties: 08:07:36 INFO - { 08:07:36 INFO - "properties": { 08:07:36 INFO - "buildnumber": 996, 08:07:36 INFO - "product": "firefox", 08:07:36 INFO - "script_repo_revision": "production", 08:07:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:07:36 INFO - "repository": "", 08:07:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:07:36 INFO - "buildid": "20151209072942", 08:07:36 INFO - "slavename": "talos-linux64-ix-063", 08:07:36 INFO - "pgo_build": "False", 08:07:36 INFO - "basedir": "/builds/slave/test", 08:07:36 INFO - "project": "", 08:07:36 INFO - "platform": "ubuntu64_hw", 08:07:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:07:36 INFO - "slavebuilddir": "test", 08:07:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:07:36 INFO - "branch": "fx-team", 08:07:36 INFO - "repo_path": "integration/fx-team", 08:07:36 INFO - "stage_platform": "linux64", 08:07:36 INFO - "builduid": "64c637351ddc44148d7c7588ff22aaa5", 08:07:36 INFO - "revision": "6c9319ab4430fd2858325fd1546d8fcc8fe513d7" 08:07:36 INFO - }, 08:07:36 INFO - "sourcestamp": { 08:07:36 INFO - "repository": "", 08:07:36 INFO - "hasPatch": false, 08:07:36 INFO - "project": "", 08:07:36 INFO - "branch": "fx-team-linux64-talos", 08:07:36 INFO - "changes": [ 08:07:36 INFO - { 08:07:36 INFO - "category": null, 08:07:36 INFO - "files": [ 08:07:36 INFO - { 08:07:36 INFO - "url": null, 08:07:36 INFO - "name": "https://queue.taskcluster.net/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 08:07:36 INFO - } 08:07:36 INFO - ], 08:07:36 INFO - "repository": "", 08:07:36 INFO - "rev": "6c9319ab4430fd2858325fd1546d8fcc8fe513d7", 08:07:36 INFO - "who": "dtownsend@mozilla.com", 08:07:36 INFO - "when": 1449677207, 08:07:36 INFO - "number": 7160711, 08:07:36 INFO - "comments": "Bug 1229858: Add a preprocessor to convert XBL into JavaScript blocks for eslint. r=miker", 08:07:36 INFO - "project": "", 08:07:36 INFO - "at": "Wed 09 Dec 2015 08:06:47", 08:07:36 INFO - "branch": "fx-team-linux64-talos", 08:07:36 INFO - "revlink": "", 08:07:36 INFO - "properties": [ 08:07:36 INFO - [ 08:07:36 INFO - "buildid", 08:07:36 INFO - "20151209072942", 08:07:36 INFO - "Change" 08:07:36 INFO - ], 08:07:36 INFO - [ 08:07:36 INFO - "builduid", 08:07:36 INFO - "64c637351ddc44148d7c7588ff22aaa5", 08:07:36 INFO - "Change" 08:07:36 INFO - ], 08:07:36 INFO - [ 08:07:36 INFO - "pgo_build", 08:07:36 INFO - "False", 08:07:36 INFO - "Change" 08:07:36 INFO - ] 08:07:36 INFO - ], 08:07:36 INFO - "revision": "6c9319ab4430fd2858325fd1546d8fcc8fe513d7" 08:07:36 INFO - } 08:07:36 INFO - ], 08:07:36 INFO - "revision": "6c9319ab4430fd2858325fd1546d8fcc8fe513d7" 08:07:36 INFO - } 08:07:36 INFO - } 08:07:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 08:07:36 INFO - Running post-action listener: _resource_record_post_action 08:07:36 INFO - ##### 08:07:36 INFO - ##### Running download-and-extract step. 08:07:36 INFO - ##### 08:07:36 INFO - Running pre-action listener: _resource_record_pre_action 08:07:36 INFO - Running main action method: download_and_extract 08:07:36 INFO - mkdir: /builds/slave/test/build/tests 08:07:36 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')]} 08:07:36 INFO - https://queue.taskcluster.net/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:07:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/test_packages.json 08:07:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/test_packages.json 08:07:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:07:42 INFO - Downloaded 1302 bytes. 08:07:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:07:42 INFO - Using the following test package requirements: 08:07:42 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:07:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:42 INFO - u'jsshell-linux-x86_64.zip'], 08:07:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:07:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:07:42 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:07:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:07:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:07:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:42 INFO - https://queue.taskcluster.net/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:07:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:07:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:07:45 INFO - Downloaded 21860154 bytes. 08:07:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:07:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:07:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:07:46 INFO - Return code: 0 08:07:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:46 INFO - https://queue.taskcluster.net/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:07:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:07:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:07:51 INFO - Downloaded 21860154 bytes. 08:07:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:07:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:07:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:07:52 INFO - Return code: 0 08:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:52 INFO - https://queue.taskcluster.net/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:07:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:07:55 INFO - Downloaded 11132038 bytes. 08:07:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 08:07:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 08:07:56 INFO - Return code: 0 08:07: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')]} 08:07:56 INFO - https://queue.taskcluster.net/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:07:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:07:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:07:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:07:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:07:59 INFO - Downloaded 57730295 bytes. 08:07:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:07:59 INFO - mkdir: /builds/slave/test/properties 08:07:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:07:59 INFO - Writing to file /builds/slave/test/properties/build_url 08:07:59 INFO - Contents: 08:07:59 INFO - build_url:https://queue.taskcluster.net/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:07:59 INFO - Running post-action listener: _resource_record_post_action 08:07:59 INFO - Running post-action listener: set_extra_try_arguments 08:07:59 INFO - ##### 08:07:59 INFO - ##### Running populate-webroot step. 08:07:59 INFO - ##### 08:07:59 INFO - Running pre-action listener: _resource_record_pre_action 08:07:59 INFO - Running main action method: populate_webroot 08:07:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:07:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:07:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:07:59 INFO - '--tppagecycles', 08:07:59 INFO - '7'], 08:07:59 INFO - 'tests': ['tsvgm']}}, 08:07:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:07:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:07:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:07:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:07:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:07:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:07:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:59 INFO - 'talos_options': ['--e10s'], 08:07:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:59 INFO - 'tests': ['damp', 'tps']}, 08:07:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:59 INFO - 'talos_options': ['--e10s'], 08:07:59 INFO - 'tests': ['damp', 'tps']}, 08:07:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:07:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:07:59 INFO - 'other': {'tests': ['a11yr', 08:07:59 INFO - 'ts_paint', 08:07:59 INFO - 'tpaint', 08:07:59 INFO - 'sessionrestore', 08:07:59 INFO - 'sessionrestore_no_auto_restore']}, 08:07:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:07:59 INFO - 'tests': ['a11yr', 08:07:59 INFO - 'ts_paint', 08:07:59 INFO - 'tpaint', 08:07:59 INFO - 'sessionrestore', 08:07:59 INFO - 'sessionrestore_no_auto_restore']}, 08:07:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:07:59 INFO - 'tests': ['a11yr', 08:07:59 INFO - 'ts_paint', 08:07:59 INFO - 'tpaint', 08:07:59 INFO - 'sessionrestore', 08:07:59 INFO - 'sessionrestore_no_auto_restore']}, 08:07:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:07:59 INFO - 'tests': ['a11yr', 08:07:59 INFO - 'ts_paint', 08:07:59 INFO - 'tpaint', 08:07:59 INFO - 'sessionrestore', 08:07:59 INFO - 'sessionrestore_no_auto_restore']}, 08:07:59 INFO - 'other_l64': {'tests': ['a11yr', 08:07:59 INFO - 'ts_paint', 08:07:59 INFO - 'tpaint', 08:07:59 INFO - 'sessionrestore', 08:07:59 INFO - 'sessionrestore_no_auto_restore']}, 08:07:59 INFO - 'other_nol64': {'tests': ['a11yr', 08:07:59 INFO - 'ts_paint', 08:07:59 INFO - 'tpaint', 08:07:59 INFO - 'sessionrestore', 08:07:59 INFO - 'sessionrestore_no_auto_restore']}, 08:07:59 INFO - 'svgr': {'tests': ['tsvgx', 08:07:59 INFO - 'tsvgr_opacity', 08:07:59 INFO - 'tart', 08:07:59 INFO - 'tscrollx', 08:07:59 INFO - 'cart']}, 08:07:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:07:59 INFO - 'tests': ['tsvgx', 08:07:59 INFO - 'tsvgr_opacity', 08:07:59 INFO - 'tart', 08:07:59 INFO - 'tscrollx', 08:07:59 INFO - 'cart']}, 08:07:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:59 INFO - 'tests': ['tp5o']}, 08:07:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:59 INFO - 'talos_options': ['--e10s'], 08:07:59 INFO - 'tests': ['tp5o']}, 08:07:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:59 INFO - 'talos_options': ['--xperf_path', 08:07:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:59 INFO - 'tests': ['tp5n']}, 08:07:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:59 INFO - 'talos_options': ['--e10s', 08:07:59 INFO - '--xperf_path', 08:07:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:59 INFO - 'tests': ['tp5n']}}, 08:07:59 INFO - 'talos.zip': {'path': '', 08:07:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:07:59 INFO - Running post-action listener: _resource_record_post_action 08:07:59 INFO - ##### 08:07:59 INFO - ##### Running create-virtualenv step. 08:07:59 INFO - ##### 08:07:59 INFO - Running pre-action listener: _resource_record_pre_action 08:07:59 INFO - Running main action method: create_virtualenv 08:07:59 INFO - Creating virtualenv /builds/slave/test/build/venv 08:07:59 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 08:07:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:07:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:07:59 INFO - Using real prefix '/usr' 08:07:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:08:00 INFO - Installing distribute.............................................................................................................................................................................................done. 08:08:02 INFO - Installing pip.................done. 08:08:02 INFO - Return code: 0 08:08:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f66d2443f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780b0>, '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 0x1078fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', '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 08:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:08:02 INFO - Using env: {'DISPLAY': ':0', 08:08:02 INFO - 'HOME': '/home/cltbld', 08:08:02 INFO - 'LANG': 'en_US.UTF-8', 08:08:02 INFO - 'LANGUAGE': 'en_US:en', 08:08:02 INFO - 'LOGNAME': 'cltbld', 08:08:02 INFO - 'MAIL': '/var/mail/cltbld', 08:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:02 INFO - 'MOZ_NO_REMOTE': '1', 08:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:02 INFO - 'NO_EM_RESTART': '1', 08:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:02 INFO - 'PWD': '/builds/slave/test', 08:08:02 INFO - 'SHELL': '/bin/bash', 08:08:02 INFO - 'SHLVL': '1', 08:08:02 INFO - 'TERM': 'linux', 08:08:02 INFO - 'TMOUT': '86400', 08:08:02 INFO - 'USER': 'cltbld', 08:08:02 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', 08:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:02 INFO - '_': '/tools/buildbot/bin/python'} 08:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:02 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 08:08:02 INFO - Cleaning up... 08:08:02 INFO - Return code: 0 08:08:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f66d2443f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780b0>, '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 0x1078fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', '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 08:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:08:02 INFO - Using env: {'DISPLAY': ':0', 08:08:02 INFO - 'HOME': '/home/cltbld', 08:08:02 INFO - 'LANG': 'en_US.UTF-8', 08:08:02 INFO - 'LANGUAGE': 'en_US:en', 08:08:02 INFO - 'LOGNAME': 'cltbld', 08:08:02 INFO - 'MAIL': '/var/mail/cltbld', 08:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:02 INFO - 'MOZ_NO_REMOTE': '1', 08:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:02 INFO - 'NO_EM_RESTART': '1', 08:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:02 INFO - 'PWD': '/builds/slave/test', 08:08:02 INFO - 'SHELL': '/bin/bash', 08:08:02 INFO - 'SHLVL': '1', 08:08:02 INFO - 'TERM': 'linux', 08:08:02 INFO - 'TMOUT': '86400', 08:08:02 INFO - 'USER': 'cltbld', 08:08:02 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', 08:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:02 INFO - '_': '/tools/buildbot/bin/python'} 08:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:03 INFO - Downloading/unpacking psutil>=0.7.1 08:08:03 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 08:08:03 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 08:08:03 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 08:08:03 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 08:08:03 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 08:08:03 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 08:08:07 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:08:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:08:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:08 INFO - Installing collected packages: psutil 08:08:08 INFO - Running setup.py install for psutil 08:08:08 INFO - building 'psutil._psutil_linux' extension 08:08:08 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 08:08:08 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 08:08:09 INFO - building 'psutil._psutil_posix' extension 08:08:09 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 08:08:09 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 08:08:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:09 INFO - Successfully installed psutil 08:08:09 INFO - Cleaning up... 08:08:09 INFO - Return code: 0 08:08:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f66d2443f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780b0>, '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 0x1078fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', '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 08:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:08:09 INFO - Using env: {'DISPLAY': ':0', 08:08:09 INFO - 'HOME': '/home/cltbld', 08:08:09 INFO - 'LANG': 'en_US.UTF-8', 08:08:09 INFO - 'LANGUAGE': 'en_US:en', 08:08:09 INFO - 'LOGNAME': 'cltbld', 08:08:09 INFO - 'MAIL': '/var/mail/cltbld', 08:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:09 INFO - 'MOZ_NO_REMOTE': '1', 08:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:09 INFO - 'NO_EM_RESTART': '1', 08:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:09 INFO - 'PWD': '/builds/slave/test', 08:08:09 INFO - 'SHELL': '/bin/bash', 08:08:09 INFO - 'SHLVL': '1', 08:08:09 INFO - 'TERM': 'linux', 08:08:09 INFO - 'TMOUT': '86400', 08:08:09 INFO - 'USER': 'cltbld', 08:08:09 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', 08:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:09 INFO - '_': '/tools/buildbot/bin/python'} 08:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:08:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:08:11 INFO - Installing collected packages: mozsystemmonitor 08:08:11 INFO - Running setup.py install for mozsystemmonitor 08:08:11 INFO - Successfully installed mozsystemmonitor 08:08:11 INFO - Cleaning up... 08:08:11 INFO - Return code: 0 08:08:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:08:11 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')]} 08:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:11 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')]} 08:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f66d2443f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780b0>, '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 0x1078fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', '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 08:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:08:11 INFO - Using env: {'DISPLAY': ':0', 08:08:11 INFO - 'HOME': '/home/cltbld', 08:08:11 INFO - 'LANG': 'en_US.UTF-8', 08:08:11 INFO - 'LANGUAGE': 'en_US:en', 08:08:11 INFO - 'LOGNAME': 'cltbld', 08:08:11 INFO - 'MAIL': '/var/mail/cltbld', 08:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:11 INFO - 'MOZ_NO_REMOTE': '1', 08:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:11 INFO - 'NO_EM_RESTART': '1', 08:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:11 INFO - 'PWD': '/builds/slave/test', 08:08:11 INFO - 'SHELL': '/bin/bash', 08:08:11 INFO - 'SHLVL': '1', 08:08:11 INFO - 'TERM': 'linux', 08:08:11 INFO - 'TMOUT': '86400', 08:08:11 INFO - 'USER': 'cltbld', 08:08:11 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', 08:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:11 INFO - '_': '/tools/buildbot/bin/python'} 08:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:11 INFO - Downloading/unpacking blobuploader==1.2.4 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:13 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:08:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:13 INFO - Downloading docopt-0.6.1.tar.gz 08:08:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:14 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:14 INFO - Running setup.py install for blobuploader 08:08:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:08:14 INFO - Running setup.py install for requests 08:08:14 INFO - Running setup.py install for docopt 08:08:14 INFO - Successfully installed blobuploader requests docopt 08:08:14 INFO - Cleaning up... 08:08:14 INFO - Return code: 0 08:08:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f66d2443f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780b0>, '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 0x1078fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', '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 08:08:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 08:08:14 INFO - Using env: {'DISPLAY': ':0', 08:08:14 INFO - 'HOME': '/home/cltbld', 08:08:14 INFO - 'LANG': 'en_US.UTF-8', 08:08:14 INFO - 'LANGUAGE': 'en_US:en', 08:08:14 INFO - 'LOGNAME': 'cltbld', 08:08:14 INFO - 'MAIL': '/var/mail/cltbld', 08:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:14 INFO - 'MOZ_NO_REMOTE': '1', 08:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:14 INFO - 'NO_EM_RESTART': '1', 08:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:14 INFO - 'PWD': '/builds/slave/test', 08:08:14 INFO - 'SHELL': '/bin/bash', 08:08:14 INFO - 'SHLVL': '1', 08:08:14 INFO - 'TERM': 'linux', 08:08:14 INFO - 'TMOUT': '86400', 08:08:14 INFO - 'USER': 'cltbld', 08:08:14 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', 08:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:14 INFO - '_': '/tools/buildbot/bin/python'} 08:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:14 INFO - Running setup.py (path:/tmp/pip-tc0Wtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:14 INFO - Running setup.py (path:/tmp/pip-zYiy4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:15 INFO - Running setup.py (path:/tmp/pip-Uwq_tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:15 INFO - Running setup.py (path:/tmp/pip-VtvMVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:15 INFO - Running setup.py (path:/tmp/pip-YJIMiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:15 INFO - Running setup.py (path:/tmp/pip-pFix4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:15 INFO - Running setup.py (path:/tmp/pip-yTEDr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:15 INFO - Running setup.py (path:/tmp/pip-Cnv07k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:15 INFO - Running setup.py (path:/tmp/pip-KBZdOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:15 INFO - Running setup.py (path:/tmp/pip-TIK3nO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:15 INFO - Running setup.py (path:/tmp/pip-caTpvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:15 INFO - Running setup.py (path:/tmp/pip-HPKsbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:15 INFO - Running setup.py (path:/tmp/pip-rAWq5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:15 INFO - Running setup.py (path:/tmp/pip-E6cEYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:15 INFO - Running setup.py (path:/tmp/pip-IbR77o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:15 INFO - Running setup.py (path:/tmp/pip-oVZ9T8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:16 INFO - Running setup.py (path:/tmp/pip-Y2Kv4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:08:16 INFO - Running setup.py install for manifestparser 08:08:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:08:16 INFO - Running setup.py install for mozcrash 08:08:16 INFO - Running setup.py install for mozdebug 08:08:16 INFO - Running setup.py install for mozdevice 08:08:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:08:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:08:16 INFO - Running setup.py install for mozfile 08:08:16 INFO - Running setup.py install for mozhttpd 08:08:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:08:16 INFO - Running setup.py install for mozinfo 08:08:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:08:16 INFO - Running setup.py install for mozInstall 08:08:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:08:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:08:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:08:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:08:16 INFO - Running setup.py install for mozleak 08:08:16 INFO - Running setup.py install for mozlog 08:08:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:08:17 INFO - Running setup.py install for moznetwork 08:08:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:08:17 INFO - Running setup.py install for mozprocess 08:08:17 INFO - Running setup.py install for mozprofile 08:08:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:08:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:08:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:08:17 INFO - Running setup.py install for mozrunner 08:08:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:08:17 INFO - Running setup.py install for mozscreenshot 08:08:17 INFO - Running setup.py install for moztest 08:08:17 INFO - Running setup.py install for mozversion 08:08:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:08:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:08:17 INFO - Cleaning up... 08:08:17 INFO - Return code: 0 08:08:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f66d2443f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780b0>, '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 0x1078fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', '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 08:08:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:08:17 INFO - Using env: {'DISPLAY': ':0', 08:08:17 INFO - 'HOME': '/home/cltbld', 08:08:17 INFO - 'LANG': 'en_US.UTF-8', 08:08:17 INFO - 'LANGUAGE': 'en_US:en', 08:08:17 INFO - 'LOGNAME': 'cltbld', 08:08:17 INFO - 'MAIL': '/var/mail/cltbld', 08:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:17 INFO - 'MOZ_NO_REMOTE': '1', 08:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:17 INFO - 'NO_EM_RESTART': '1', 08:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:17 INFO - 'PWD': '/builds/slave/test', 08:08:17 INFO - 'SHELL': '/bin/bash', 08:08:17 INFO - 'SHLVL': '1', 08:08:17 INFO - 'TERM': 'linux', 08:08:17 INFO - 'TMOUT': '86400', 08:08:17 INFO - 'USER': 'cltbld', 08:08:17 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', 08:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:17 INFO - '_': '/tools/buildbot/bin/python'} 08:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:18 INFO - Running setup.py (path:/tmp/pip-qmtHOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:18 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)) 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:18 INFO - Running setup.py (path:/tmp/pip-iyWdU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:18 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)) 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:18 INFO - Running setup.py (path:/tmp/pip-PxkSjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:18 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)) 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:18 INFO - Running setup.py (path:/tmp/pip-HMw8af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:18 INFO - Running setup.py (path:/tmp/pip-5Bh5gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:18 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)) 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:18 INFO - Running setup.py (path:/tmp/pip-zteVTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:18 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)) 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:18 INFO - Running setup.py (path:/tmp/pip-we69Ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:18 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)) 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:18 INFO - Running setup.py (path:/tmp/pip-CxzHp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:18 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)) 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:18 INFO - Running setup.py (path:/tmp/pip-Uc4GaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:18 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)) 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:18 INFO - Running setup.py (path:/tmp/pip-L89PXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:18 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)) 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:18 INFO - Running setup.py (path:/tmp/pip-RNCJWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:18 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)) 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:18 INFO - Running setup.py (path:/tmp/pip-FmdIYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:18 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)) 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:18 INFO - Running setup.py (path:/tmp/pip-5SRb9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 08:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:19 INFO - Running setup.py (path:/tmp/pip-z1vG4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:19 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)) 08:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:19 INFO - Running setup.py (path:/tmp/pip-zu33Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:19 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)) 08:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:19 INFO - Running setup.py (path:/tmp/pip-Wms88v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:19 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)) 08:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:19 INFO - Running setup.py (path:/tmp/pip-JC0oRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:19 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)) 08:08:19 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)) 08:08:19 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)) 08:08:19 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)) 08:08:19 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:08:19 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:08:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:19 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 08:08:19 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 08:08:19 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 08:08:19 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 08:08:19 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 08:08:19 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 08:08:21 INFO - Downloading blessings-1.5.1.tar.gz 08:08:21 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:08:21 INFO - Installing collected packages: blessings 08:08:21 INFO - Running setup.py install for blessings 08:08:21 INFO - Successfully installed blessings 08:08:21 INFO - Cleaning up... 08:08:21 INFO - Return code: 0 08:08:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:08:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:21 INFO - Reading from file tmpfile_stdout 08:08:21 INFO - Current package versions: 08:08:21 INFO - argparse == 1.2.1 08:08:21 INFO - blessings == 1.5.1 08:08:21 INFO - blobuploader == 1.2.4 08:08:21 INFO - docopt == 0.6.1 08:08:21 INFO - manifestparser == 1.1 08:08:21 INFO - mozInstall == 1.12 08:08:21 INFO - mozcrash == 0.16 08:08:21 INFO - mozdebug == 0.1 08:08:21 INFO - mozdevice == 0.47 08:08:21 INFO - mozfile == 1.2 08:08:21 INFO - mozhttpd == 0.7 08:08:21 INFO - mozinfo == 0.9 08:08:21 INFO - mozleak == 0.1 08:08:21 INFO - mozlog == 3.1 08:08:21 INFO - moznetwork == 0.27 08:08:21 INFO - mozprocess == 0.22 08:08:21 INFO - mozprofile == 0.27 08:08:21 INFO - mozrunner == 6.11 08:08:21 INFO - mozscreenshot == 0.1 08:08:21 INFO - mozsystemmonitor == 0.0 08:08:21 INFO - moztest == 0.7 08:08:21 INFO - mozversion == 1.4 08:08:21 INFO - psutil == 3.1.1 08:08:21 INFO - requests == 1.2.3 08:08:21 INFO - wsgiref == 0.1.2 08:08:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f66d2443f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780b0>, '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 0x1078fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', '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 08:08:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:08:21 INFO - Using env: {'DISPLAY': ':0', 08:08:21 INFO - 'HOME': '/home/cltbld', 08:08:21 INFO - 'LANG': 'en_US.UTF-8', 08:08:21 INFO - 'LANGUAGE': 'en_US:en', 08:08:21 INFO - 'LOGNAME': 'cltbld', 08:08:21 INFO - 'MAIL': '/var/mail/cltbld', 08:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:21 INFO - 'MOZ_NO_REMOTE': '1', 08:08:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:21 INFO - 'NO_EM_RESTART': '1', 08:08:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:21 INFO - 'PWD': '/builds/slave/test', 08:08:21 INFO - 'SHELL': '/bin/bash', 08:08:21 INFO - 'SHLVL': '1', 08:08:21 INFO - 'TERM': 'linux', 08:08:21 INFO - 'TMOUT': '86400', 08:08:21 INFO - 'USER': 'cltbld', 08:08:21 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', 08:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:21 INFO - '_': '/tools/buildbot/bin/python'} 08:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:21 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 1)) 08:08:21 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 2)) 08:08:21 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 3)) 08:08:21 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 4)) 08:08:21 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 5)) 08:08:21 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 6)) 08:08:21 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 7)) 08:08:21 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 8)) 08:08: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:08:21 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 3)) 08:08:21 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:08:21 INFO - Cleaning up... 08:08:21 INFO - Return code: 0 08:08:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f66d2443f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780b0>, '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 0x1078fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', '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 08:08:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:08:21 INFO - Using env: {'DISPLAY': ':0', 08:08:21 INFO - 'HOME': '/home/cltbld', 08:08:21 INFO - 'LANG': 'en_US.UTF-8', 08:08:21 INFO - 'LANGUAGE': 'en_US:en', 08:08:21 INFO - 'LOGNAME': 'cltbld', 08:08:21 INFO - 'MAIL': '/var/mail/cltbld', 08:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:21 INFO - 'MOZ_NO_REMOTE': '1', 08:08:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:21 INFO - 'NO_EM_RESTART': '1', 08:08:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:21 INFO - 'PWD': '/builds/slave/test', 08:08:21 INFO - 'SHELL': '/bin/bash', 08:08:21 INFO - 'SHLVL': '1', 08:08:21 INFO - 'TERM': 'linux', 08:08:21 INFO - 'TMOUT': '86400', 08:08:21 INFO - 'USER': 'cltbld', 08:08:21 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', 08:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:21 INFO - '_': '/tools/buildbot/bin/python'} 08:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:21 INFO - Downloading/unpacking jsonschema 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:08:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:08:23 INFO - Downloading/unpacking functools32 (from jsonschema) 08:08:23 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 08:08:23 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 08:08:23 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 08:08:23 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 08:08:23 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 08:08:23 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 08:08:23 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:08:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:23 INFO - warning: no files found matching '*.txt' 08:08:23 INFO - no previously-included directories found matching 'build' 08:08:23 INFO - no previously-included directories found matching 'dist' 08:08:23 INFO - no previously-included directories found matching '.git*' 08:08:23 INFO - Installing collected packages: jsonschema, functools32 08:08:23 INFO - Running setup.py install for functools32 08:08:24 INFO - warning: no files found matching '*.txt' 08:08:24 INFO - no previously-included directories found matching 'build' 08:08:24 INFO - no previously-included directories found matching 'dist' 08:08:24 INFO - no previously-included directories found matching '.git*' 08:08:24 INFO - Successfully installed jsonschema functools32 08:08:24 INFO - Cleaning up... 08:08:24 INFO - Return code: 0 08:08:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f66d2443f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10780b0>, '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 0x1078fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', '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 08:08:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:08:24 INFO - Using env: {'DISPLAY': ':0', 08:08:24 INFO - 'HOME': '/home/cltbld', 08:08:24 INFO - 'LANG': 'en_US.UTF-8', 08:08:24 INFO - 'LANGUAGE': 'en_US:en', 08:08:24 INFO - 'LOGNAME': 'cltbld', 08:08:24 INFO - 'MAIL': '/var/mail/cltbld', 08:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:24 INFO - 'MOZ_NO_REMOTE': '1', 08:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:24 INFO - 'NO_EM_RESTART': '1', 08:08:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:24 INFO - 'PWD': '/builds/slave/test', 08:08:24 INFO - 'SHELL': '/bin/bash', 08:08:24 INFO - 'SHLVL': '1', 08:08:24 INFO - 'TERM': 'linux', 08:08:24 INFO - 'TMOUT': '86400', 08:08:24 INFO - 'USER': 'cltbld', 08:08:24 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', 08:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:24 INFO - '_': '/tools/buildbot/bin/python'} 08:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:24 INFO - Downloading/unpacking flake8 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:08:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:08:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:08:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:08:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:08:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:08:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:08:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:26 INFO - no previously-included directories found matching 'docs/_build' 08:08:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:08:26 INFO - Running setup.py install for pep8 08:08:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:26 INFO - no previously-included directories found matching 'docs/_build' 08:08:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:08:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:08:26 INFO - Cleaning up... 08:08:26 INFO - Return code: 0 08:08:26 INFO - Running post-action listener: _resource_record_post_action 08:08:26 INFO - Running post-action listener: _start_resource_monitoring 08:08:26 INFO - Starting resource monitoring. 08:08:26 INFO - ##### 08:08:26 INFO - ##### Running install step. 08:08:26 INFO - ##### 08:08:26 INFO - Running pre-action listener: _resource_record_pre_action 08:08:26 INFO - Running main action method: install 08:08:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:27 INFO - Reading from file tmpfile_stdout 08:08:27 INFO - Detecting whether we're running mozinstall >=1.0... 08:08:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:08:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:08:27 INFO - Reading from file tmpfile_stdout 08:08:27 INFO - Output received: 08:08:27 INFO - Usage: mozinstall [options] installer 08:08:27 INFO - Options: 08:08:27 INFO - -h, --help show this help message and exit 08:08:27 INFO - -d DEST, --destination=DEST 08:08:27 INFO - Directory to install application into. [default: 08:08:27 INFO - "/builds/slave/test"] 08:08:27 INFO - --app=APP Application being installed. [default: firefox] 08:08:27 INFO - mkdir: /builds/slave/test/build/application 08:08:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:08:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:08:41 INFO - Reading from file tmpfile_stdout 08:08:41 INFO - Output received: 08:08:41 INFO - /builds/slave/test/build/application/firefox/firefox 08:08:41 INFO - Running post-action listener: _resource_record_post_action 08:08:41 INFO - ##### 08:08:41 INFO - ##### Running run-tests step. 08:08:41 INFO - ##### 08:08:41 INFO - Running pre-action listener: _resource_record_pre_action 08:08:41 INFO - Running main action method: run_tests 08:08:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:08:41 INFO - Python 2.7.3 08:08:41 INFO - Return code: 0 08:08:41 INFO - grabbing minidump binary from tooltool 08:08:41 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')]} 08:08:41 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 0x10780b0>, '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 0x1078fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:08:41 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 08:08:41 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 08:08:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:41 INFO - Return code: 0 08:08:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:08:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:08:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:08:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:08:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:08:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:08:42 INFO - Return code: 0 08:08:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost'] in /builds/slave/test/build 08:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost 08:08:42 INFO - Using env: {'DISPLAY': ':0', 08:08:42 INFO - 'HOME': '/home/cltbld', 08:08:42 INFO - 'LANG': 'en_US.UTF-8', 08:08:42 INFO - 'LANGUAGE': 'en_US:en', 08:08:42 INFO - 'LOGNAME': 'cltbld', 08:08:42 INFO - 'MAIL': '/var/mail/cltbld', 08:08:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:08:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:42 INFO - 'MOZ_NO_REMOTE': '1', 08:08:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:42 INFO - 'NO_EM_RESTART': '1', 08:08:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:42 INFO - 'PWD': '/builds/slave/test', 08:08:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:08:42 INFO - 'SHELL': '/bin/bash', 08:08:42 INFO - 'SHLVL': '1', 08:08:42 INFO - 'TERM': 'linux', 08:08:42 INFO - 'TMOUT': '86400', 08:08:42 INFO - 'USER': 'cltbld', 08:08:42 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271', 08:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:42 INFO - '_': '/tools/buildbot/bin/python'} 08:08:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost'] with output_timeout 3600 08:08:43 INFO - mozversion INFO | application_buildid: 20151209072942 08:08:43 INFO - mozversion INFO | application_changeset: 6c9319ab4430fd2858325fd1546d8fcc8fe513d7 08:08:43 INFO - mozversion INFO | application_display_name: Nightly 08:08:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:43 INFO - mozversion INFO | application_name: Firefox 08:08:43 INFO - mozversion INFO | application_remotingname: firefox 08:08:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:08:43 INFO - mozversion INFO | application_vendor: Mozilla 08:08:43 INFO - mozversion INFO | application_version: 45.0a1 08:08:43 INFO - mozversion INFO | platform_buildid: 20151209072942 08:08:43 INFO - mozversion INFO | platform_changeset: 6c9319ab4430fd2858325fd1546d8fcc8fe513d7 08:08:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:08:43 INFO - mozversion INFO | platform_version: 45.0a1 08:08:43 INFO - 2015-12-09 08:08:43,087 DEBUG : using testdate: 1449677323 08:08:43 INFO - 2015-12-09 08:08:43,087 DEBUG : actual date: 1449677323 08:08:43 INFO - 2015-12-09 08:08:43,094 INFO : starting webserver on 'localhost:52979' 08:08:43 INFO - 2015-12-09 08:08:43,095 INFO : Starting test suite talos-linux64-ix-063 08:08:43 INFO - 2015-12-09 08:08:43,095 INFO : Starting test dromaeo_css 08:08:43 INFO - 2015-12-09 08:08:43,095 DEBUG : operating with platform_type : linux_ 08:08:43 INFO - 2015-12-09 08:08:43,096 INFO : Initialising browser for dromaeo_css test... 08:08:43 INFO - 2015-12-09 08:08:43,126 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpusfnWt/profile http://localhost:52979/getInfo.html 08:08:49 INFO - 2015-12-09 08:08:49,290 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:08:49 INFO - 2015-12-09 08:08:49,290 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:08:49 INFO - 2015-12-09 08:08:49,290 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:08:49 INFO - 2015-12-09 08:08:49,290 DEBUG : BROWSER_OUTPUT: __metrics 08:08:49 INFO - 2015-12-09 08:08:49,366 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:08:49 INFO - 2015-12-09 08:08:49,434 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:08:49 INFO - 2015-12-09 08:08:49,740 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 08:08:50 INFO - 2015-12-09 08:08:50,395 INFO : Browser initialized. 08:08:50 INFO - 2015-12-09 08:08:50,396 INFO : Running cycle 1/1 for dromaeo_css test... 08:08:50 INFO - 2015-12-09 08:08:50,396 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpusfnWt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:09:02 INFO - 2015-12-09 08:09:02,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 140247040 08:09:02 INFO - 2015-12-09 08:09:02,399 DEBUG : BROWSER_OUTPUT: 08:09:53 INFO - 2015-12-09 08:09:53,809 DEBUG : BROWSER_OUTPUT: 1449677393805 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] 08:12:05 INFO - 2015-12-09 08:12:05,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52979/tests/dromaeo/cssquery-ext.html) 08:12:07 INFO - 2015-12-09 08:12:07,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 277831680 08:12:07 INFO - 2015-12-09 08:12:07,033 DEBUG : BROWSER_OUTPUT: 08:15:09 INFO - 2015-12-09 08:15:09,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/dromaeo/cssquery-ext.html (next: http://localhost:52979/tests/dromaeo/cssquery-jquery.html) 08:15:10 INFO - 2015-12-09 08:15:10,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 216686592 08:15:10 INFO - 2015-12-09 08:15:10,227 DEBUG : BROWSER_OUTPUT: 08:18:12 INFO - 2015-12-09 08:18:12,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52979/tests/dromaeo/cssquery-mootools.html) 08:18:12 INFO - 2015-12-09 08:18:12,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 216698880 08:18:12 INFO - 2015-12-09 08:18:12,689 DEBUG : BROWSER_OUTPUT: 08:21:14 INFO - 2015-12-09 08:21:14,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52979/tests/dromaeo/cssquery-prototype.html) 08:21:15 INFO - 2015-12-09 08:21:15,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 200478720 08:21:15 INFO - 2015-12-09 08:21:15,224 DEBUG : BROWSER_OUTPUT: 08:24:18 INFO - 2015-12-09 08:24:18,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52979/tests/dromaeo/cssquery-yui.html) 08:24:18 INFO - 2015-12-09 08:24:18,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 204840960 08:24:18 INFO - 2015-12-09 08:24:18,714 DEBUG : BROWSER_OUTPUT: 08:27:21 INFO - 2015-12-09 08:27:21,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/dromaeo/cssquery-yui.html (next: http://localhost:52979/tests/dromaeo/cssquery-dojo.html) 08:27:21 INFO - 2015-12-09 08:27:21,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 252166144 08:27:21 INFO - 2015-12-09 08:27:21,540 DEBUG : BROWSER_OUTPUT: 08:27:21 INFO - 2015-12-09 08:27:21,541 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:27:21 INFO - 2015-12-09 08:27:21,541 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:27:21 INFO - 2015-12-09 08:27:21,541 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:27:21 INFO - 2015-12-09 08:27:21,541 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:27:21 INFO - 2015-12-09 08:27:21,542 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2618.1360151150116;2719.1026961102825;2723.523383407903;2737.2062101990437;2753.366725653099;4436.578525040124;4538.410006699133;4663.440387153542;4705.741184234866;4707.952920470799;4633.90732185357;4674.76626168691;4768.761561921908;4777.808887644499;4828.324034635145;4333.11171209902;4361.214981303364;4365.956340436586;4466.196084704752;4495.235809912307;4395.120975804836;4444.266695995157;4458.71018383804;4470.7317560946285;4508.706934049276;4198.6850986176005;4236.06806502572;4300.440942677432;4303.870883873489;4372.650187984954;4331.675124365654;4355.063661312801;4382.737035777864;4393.912121757547;4404.977975110104;4353.846230748854;4357.128574285156;4369.410129632491;4380.540043295472;4401.031773009932;4521.7739113044545;4632.513586073481;4640.443146822369;4646.210144275481;4732.02993386355;4957.677750946177;4968.105740966625;4968.975155124202;4975.651704380694;5022.146235140035;5001.24981252815;5001.574866136383;5004.749762511859;5005.324281222025;5011.1481048221885;4549.31760235964;4665.206914824488;4667.836625718083;4707.529247075334;4789.4971028041555;5168.328117344721;5212.55693266069;5221.190715439113;5234.895302094013;5257.263983042377;4998.5751211146735;5017.071841709296;5021.794769255353;5026.220935754964;5067.974660126676;4842.951570484321;4971.726555039435;4974.328465657162;5001.949980500149;5092.719900405513;4940.6788558743565;4953.678010929278;4964.925526117111;4972.154733695281;5006.824761133415;4947.48051454592;4950.8267210647455;4956.8760780980765;4969.080720066727;5003.549680528697;4063.5326937401987;4161.167766446662;4176.081262122389;4177.436046133794;4262.062346283813;3613.349597072552;3626.1478552540134;3644.052546337918;3673.8530458781884;3687.3362794697214;4225.514065882401;4247.214265360918;4268.103698223408;4289.828406863753;4293.914121717548;4908.165611845995;5014.84955451337;5027.673201241908;5027.824026159067;5053.873653158627;4242.427272318259;4331.891702707458;4336.609705126553;4352.760598167131;4376.868693939187;4477.664175186809;4482.103579284156;4487.887802804956;4490.057088011489;4538.659600529973;4561.63506919439;4797.64017698681;4801.231802911518;4808.9901120765035;4852.95147048525;4978.551930326288;4982.825601103944;4983.6760610560195;4985.351904252424;4993.400791904995;4706.835260765994;4753.857384278477;4803.879903002453;4834.250691142878;4850.223964165716;5062.924056139087;5063;5073.923891141562;5075.365579302587;5084.1102807009365;4769.523047695203;4876.024795041077;4876.80492780299;5067.315912351785;5189.948100518946;4935.161022626234;5011.624128190473;5025.84922452327;5030.295758593873;5051.772670229922;4880.682755620874;4890.070886531547;4894.510548945077;4895.657303988686;4897.4857639947295;4568.132054909556;4698.154332220233;4702.459217190067;4812.711237325771;4845.781939812788;4828.444728856086;4836.758162091952;4850.248211527219;4850.878728031827;4958.975205123951;4789.185838407409;4837.564619184291;4867.172580661367;4868.926966095582;4911.3369695090705 08:27:21 INFO - 2015-12-09 08:27:21,543 DEBUG : BROWSER_OUTPUT: |1;ext.html;525.6950968438305;527.6332948600724;532.6670830730792;533.0937406409106;536.9785208591657;27259.86370068152;27855.721442785565;27875.860620696894;36090.63909360912;36848;39780.80109599455;40288.19423611526;40321.1855466504;40329.39505907414;40336.19327613446;7854.293113619788;7965.522068675898;8003.119656837744;8031.638576264082;8032.477888937229;6977.197622273427;7076.964615176917;9737.415755054684;9925.751856203617;9928.50357482123;9744.171745401649;9826.410415375065;9839.852402213972;9842.90157098427;9852.655157069505;7126;7366.226546212678;9713.854292185622;9847.16299114569;9851.852222216638;10097.495125243708;10384.221183411199;10384.480775961172;10391.324563903398;10392.896071039268;37348.43977340342;37780.43329350062;37887.62112378896;37961.24077518462;38011.61988380108;2875.2609005364943;2945.808522446034;2949.4101179764134;3512.08685741709;3537.7700449470703;28391.57412638812;28474.440694913137;28764.280892977633;28807.423851522854;29133.85433072821;3398.167448975017;3451.2234747181933;3463.809490478023;3512.0693016350688;3570.2145527983803;225777;226726;227591;227685;227773;43410.565894341285;47196.7640161797;54331.18503222455;56327;56955.14567281494;54646.726766365915;54887;55284.72357638186;55356.16965745517;55394;13934.37295321713;14120;14128.081674691111;14152;14209.502667406798;10664.733381665365;10760.677179684622;10780.568777248978;10780.94609526963;10940.726481838017;18949.715754263696;19053.61892762137;19070.61858762817;19081.522961926064;19098.427047188605;7068.646567671596;7249.637518124073;7319.2314806944505;7401.0748656417945;7404.407647388196;828.2007862412801;847.0301504776996;872.9476231426135;886.4769785826394;989.5645915797027;26063.73936260651;26659;26704.19887403381;26897;27033.864830676113;927.5037854747812;940.9012053734397;997.9720887485901;999.7850462150673;1029.5984566019258;12473;12500.747294792907;12663.620091397273;13050.934745326213;13187.73624527504;270378;274050;274206.0317587314;274325;274515;46120.308195377096;46347.51134841125;46417;46423.76788116038;46478.535214648095;1205.7769312677183;1232.9075319351084;1234.3581337704522;1236.5548402575066;1255.3785875991443;23311.650325245475;23392.883035584713;23912.28263152108;24042.39894002664;24261.636075459235;35176.82411587926;35257.47113793346;35418;35457;35489.29021419609;247952;248108;248811;249297;249673;24206.273811785675;24607.630885536375;27785.86107069452;28284.575731364457;28462.146135615963;33302.833485832416;33610.49584256189;33642.327153457285;33819.830900845336;34003.48994765031;29246.7075329244;31155;31617.5257371135;32161.839190803898;32314;26724.599131013438;27313.726862731117;27586.172414827586;27638.44723105567;31768.841155794074;29039.274018149714;29326;29330;29603;29743.553846691884;26411.867940660173;26547.734522654526;26800.865995669898;27244.455110898067;29533.704662953096;21622.35132946014;22597.2090976815;23166.884165579064;23589.174378896656;23663.408414789767 08:27:21 INFO - 2015-12-09 08:27:21,544 DEBUG : BROWSER_OUTPUT: |2;jquery.html;267.1171777276103;268.9367998520347;270.6819487102654;271.9415325704973;276.6224104097906;11106.833397499044;16186.676266474664;16603.33586656532;17119.914400427995;17140.22868970896;9295.814083718322;9522.285828562852;9535.189508891735;15391.538253852374;15797.763033554476;4490.371348011273;4620.168369693454;4621.861344159681;4624.421947256593;4625.722456652595;4579.22153233951;4604.3323718060865;4613.446386433633;4613.861584152481;4619.676622636417;3484.9651503484893;3539.4159963605975;4603.332516785064;4614.723116613014;5093;5231.790728370861;5240.161574148118;5256.605754568384;5283.28675628789;5285.497877701612;4955.504449555052;5060.772265248036;5077.060743762416;5082.110630639623;5086.109930762102;11067.72330691731;11127.332360058423;11261.155413344031;11426;11453.541858325658;1808.8706537689739;1815.5370380553006;1846.8799528030636;1853.8424233940132;1870.9812901870944;8869.866951995726;8936.687215947411;9029.458232506071;11835.230710003909;11878.643640690792;1773.6186719855293;1914.1673372083048;1915.9521011974673;1997.1412292714126;2015.123421311734;55283.72358138183;56667.43332566663;57013.14480282799;57284.71357643227;57997;9179.77050573741;9189.540522973824;9272.58273377686;9297.163255307054;9331.160195582295;11390.544378224778;11393.715157120972;11398.487068081957;11402.714932126597;11426.94286528562;6583.9012414813815;6596.60420374779;6699.464042876558;6722.529422940445;6735.191776986695;6548.214214294315;6549.967250163719;6556.672166391661;6609.570377925419;6614.140161778938;3942.211557688474;3995.5604883462797;4017.0760725032824;4033.2740106780475;4050.8177132029127;1665.53365057784;1702.1404190883773;1708.094709803806;1712.222898114272;1719.5443207550009;711.3775446484326;795.2882170457408;869.9434536755217;951.6478902805868;980.7401038724744;14472;14796.334164962602;14989.400423983137;15282.541523754306;15587.61030974212;836.5399030533182;843.3506200225792;877.6747111861008;881.5876537927631;909.5679552212646;8587.184217499327;8597.398182127316;8636.136386361313;8668.479891206547;8729.301655867515;461148;464223;466942;483179;484129;56042.719786400805;56990.43009569934;62348.37651623425;64484;71631;989.2333441582831;994.8656931314325;1005.3415013166388;1007.6825799873017;1013.4020927652721;13452;13577.321133943065;14085.788713169515;14479.565613031626;14486.710265794414;31057.378852422375;31453.8427307862;32129.35741285208;32722.34555308833;33280.1679958003;42476.57523424726;43344.78327608342;44458;44779.10441791081;46602.766986164854;8187.672493100447;8277.048139463797;8417.28453081495;8442.53566053873;8443.662253510036;9841.901580984098;9842.803143937224;9885.406875587487;9930.503474826086;16143.67712645764;10162.949185254027;13943.790843137158;14103.365348559135;14120.364583593557;14552.345144468312;12758.68103297425;12882.227066376048;13237.47050118023;13344.666383340495;13577.32113394346;12989.545365912149;13755.449782008607;14043.297835108408;14126.43494260218;14135.929320353333;8463.153684631488;8720.94468614046;8790.692325768567;8871.733847984571;8952.955235223782;13890.652733681738;13947.093438926437;13954.302284885918;14120.78818817698;14519.419223230952 08:27:21 INFO - 2015-12-09 08:27:21,546 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1437.8418373978866;1584.6117701163214;1644.5230883043914;1644.8272931342208;1681.361082788541;5877.147813567036;6917.2391036985955;7098.716051357939;7105.218425973138;7107.6090815005155;6974.546654467456;7130.465215108875;7143.3570978611915;7157.320054594818;7160.534565253268;2020.1717295908643;2051.6717325227964;2056.856020078588;2059.1351632314463;2060.8660437071617;1956.5597740508415;2007.9196832126697;2018.4146597486786;2024.068928292987;2028.7666918304362;1998.0808827939093;2040.6938959156098;2067.0904801887195;2067.9379618611392;2069.492974221318;1975.4073777866654;1985.6525108106168;1987.2448469581539;1993.990030049855;1996.580718049204;1989.5523507210908;2005.177877070394;2006.2576846566717;2013.2852837242715;2022.3023057045295;6938.653067346663;7008.053912721768;7022.754203602901;7025.82435439113;7033;4046.514418269797;4110.876673699794;4133.8966525836795;4138.461999939988;4143.8964025899295;2718.4698983698186;2748.6014527893344;2765.6542932133484;2773.0987429085426;2795.3850152966315;844.8310337932377;851.6593362654926;859.1837754133599;860.6729442811754;865.9567021648892;9682.806343873153;9692.73994380726;9697.951510242403;9707.369021013612;9719.757006074904;3765.4916586260506;3766.8304926278383;3824.0631045394057;3854.5181852267906;3870.5161854768153;8297.751067467985;8297.792555186048;8306.127856575093;8310.916890831135;8316.293115085164;4155.231282212801;4155.958440415618;4166.6250037496775;4167.416561681367;4187.413762073312;3238.2713889374704;3327.085051610826;3659.1035196377056;3804.771713697187;3817.9045523862123;3300.5544251526217;3300.6864347886913;3315.386653469068;3342.6824451677053;3415.79505229687;1049.6483677967813;1059.4279089291697;1062.3480487841327;1068.1188019883627;1081.491698901515;1173.9471723772451;1175.9118066145074;1178.6415858086764;1189.6550000499758;1201;6517.055027021055;6528.706208220641;6537.313582073909;6550.541462097703;6608.2400523939405;1022.8619136416637;1038.9064984151462;1056.2553399853084;1059.4755595979884;1063.112301228483;5234.528892399702;5248.8425347239645;5257.132573125468;5277.894442111136;5280.023195708806;8270.338372930151;8640.827183456297;8670.653173873101;8674.696385626472;8677.1756683115;8536.317094632415;8542.701005464778;8547.529885856338;8551.273141782895;8589.226969572768;6562.507811914125;6623.503237257225;6735.932640673531;6760.560563563451;6872.450203983669;6421.871562568629;6460.933945899062;6461.933780926094;6466.385693359123;6466.482681385383;7414.332710056121;7681.61591920413;7686.385089192963;7737.220439298881;7794.22057794216;7719.922800772145;7785.766427007199;7794.181610930771;7814.804629884298;7928.127905930228;5006.499350064964;5079.898402032012;5112.74436278192;5836.620619659709;5897.085951677497;6214.1921550198185;6281.59169653971;6416.32628573993;6417.101605775102;6442;5849.502792262705;6101.115338276014;6238.844028899314;6305.211848518935;6312.5581209314905;6075.392460753889;6163.106349579376;6209.223847019122;6250.406211409909;6266.342034086538;6402.839929001812;6453.935460645521;6456.838579035374;6459.095726598186;6466.256380516301;5894.70526473666;5917.556183286185;5928.436798504135;5929.555283353852;5931.347551769388;5546.667199968015;5618.85952851182;5660.320761508646;5673.177389278614;6045.486133678686 08:27:21 INFO - 2015-12-09 08:27:21,546 DEBUG : BROWSER_OUTPUT: |4;prototype.html;252.60215161121232;258.3296345982176;259.7337728827952;260.70540289472893;261.6925112992234;5265.526102650761;5272.472752724726;5296.62923595349;5364.490373414529;5366.356037275523;5171.0692075426405;5235.397929238139;5243.370795504536;5258.106121959267;5262.421133675292;4018.437418761383;4019.2765302245584;4021.919561608766;4032.495938007749;4039.7374170678813;4023.4568333275074;4027.174429242013;4029.697772667047;4034.2939985502567;4035.031592417828;3701.7408781385316;3750.887473375803;3875.2249550089955;3980.3432433648413;3986.043349596105;3971.106501037272;3974.344233201533;3989.3816458448987;4002.399640053986;4006;3435.7594968352223;3436.742244331685;3437.862485500577;3440.17435815405;3440.449528075496;4878.926636140043;4988.301637770715;5019.573336266421;5097.490250974873;5100.183970564692;4534.79593418297;4535.185925629741;4545.772711364419;4546.613537849286;4553.134904368193;5532.28080349552;5539.529140023103;5546.251256080418;5548.91676624851;5551;3708.8145592720525;3709;3711.684506816897;3712.7586706863967;3717.8141092945243;5602.467765562265;5820.476157145835;5836.5914385993;5837.532997360201;5839.6204246724255;3726.366517691945;3759.49246851677;3760.6615404613717;3762.1347090169415;3765.3975363941636;3804.7336686431686;3805.3911374179997;3812.542494900574;3818.3508803503473;3821.732478726518;4462.352958820953;4465.285554311295;4470.619997300201;4470.731756094645;4474.082813023322;4889.266610008527;5274.815381461631;5329.546988505943;5353.732313384316;5355.062863998784;1300.206873806977;1327.7278157977785;1329.2290471526492;1329.454923481368;1337.3981708231336;846.4032856835915;848.0840692052568;848.4824257203101;859.0421679827073;864.0754392799644;4762.285657151386;4784.091022705675;4787.593054590329;4787.880302992453;4789.616830653539;5717.771289148471;5719.656820590778;5720.170575266563;5723.599348045597;5725.942740572541;4753;4772.76136193189;4776.140294746979;4782.808687652455;4786.95213047865;2561.385267535778;2919.2701824543865;2975.4644164050246;2987.208389776711;3060.5256185291314;5299.311089558333;5375.892482150335;5388.434214407509;5456.427075157131;5476.890462190734;5708.257926469532;5734.426557344233;5823.883522329615;5914.526837852962;5940.79207227745;5460.044492213847;5461.208124821958;5461.781528738806;5465.180222966586;5466.590005749585;5779.248697669276;5812.73842677089;5816.156657284755;5817.185594016925;5818.359980402237;5496.7526461308535;5647.181158732043;5675.120356344773;5677.574181936288;5678.914816277676;5491.066518691752;5491.341039075336;5495.725213739217;5500.752466138953;5502.862428439161;3704.2221133562252;3728;3732.3654978653153;3733.5706393765063;3738.6448287412654;5785.537157027512;5789.073748200268;5789.710514474175;5802.593818432669;5805.651660900359;5447.264619276347;5577;5578.944210557843;5587.3015873015875;5589.692566908859;5538.9169162461785;5543.667379957215;5547.916781248204;5549.195366671729;5569.860753481195;5463.344398672026;5472.589555783253;5475.808346707846;5477.096279113902;5480.671159730429;5394.757235924314;5579.637323573955;5581.665100094007;5611.186377975252;5621.718914054362;5418.214358918013;5439.836804895859;5478.287822583039;5478.780848766005;5479.2602998594675 08:27:21 INFO - 2015-12-09 08:27:21,547 DEBUG : BROWSER_OUTPUT: |5;yui.html;585.7217821534769;640.1709785827353;675.4933799650262;703.5005146346094;749.3555542233678;12377.62867113987;12450.19073760205;12477.500899964014;12479.812802807965;12508.186967847083;11786.116041296895;11817.468213930373;11843.881561184386;11847.822282665746;11855.881441185586;620.6276234259453;627.0218459203634;786.4023342259895;794.7695168401185;799.436397339874;794.4597673581962;797.4736673795296;802.3701394405393;802.8153524689325;804.3203493048364;826.499967519651;826.8635675113599;827.0365024746163;833.2542374574751;833.5332213960202;654.9377809108128;662.7216569041015;820.3642177312571;832.4131487301438;836.8786525953702;621.6860485454862;621.968901554925;622.0420552349376;622.3465361370588;622.4864486798409;12010.939945300217;12012.819807702892;12132.514699412013;12161.087918406067;12181.695457613541;11032.44837758109;11251.381174035425;11269.718257043558;11709.355985420798;11719.941400292944;9415.058494150599;9430.434173949585;9511.952440237754;9559.235261179088;9614.134727874525;3239.7408207343356;3265;3274.279658475132;3296.159479332755;3300.47192449207;38742.41886371707;38810.02974925621;39281.41077883834;39611.40582891259;39825.60174398248;9179.541022948826;9314.673986410444;9360.90639093614;9400.529973501298;9521.333506654468;15604.609884752745;15604.609884752972;15654.686906262039;15663.765043524356;15721.606959826096;6088.634681919099;6093.2078829751845;6123.387661233841;6232.0963460298;6247.250329960434;3505.9824700876334;3535.5528359849454;3547.9645203548152;3560.287942411528;3572.5534308211472;2657.282533715886;2678.7053424123333;2678.8124831262016;2687.8118531702985;2688.9327766805986;494.12293179606485;494.8020791683355;496.9478204788445;497.2913598122661;498.74813219324733;462.8703962890329;472.58648682402895;487.82682147837716;493.8024790083923;561.2983770287141;7035.401990830735;7333.779986600411;7430.405567554582;7618.866907013658;7827.217278272127;506.9847904562869;532.8907573947331;592.8814237152586;603.9547033972469;608.4128815692877;3468.4623883298127;3567.250877315741;3755.2301778135416;3919.7256192066284;3922.980385098056;45477.54522454799;46365.30452043222;46378.30432543514;46581.5341846584;46870.53129468662;42833;43255.78372108119;43259.351109733376;43315.35026974598;43445.56554434478;38391.23217535634;38986.61013389887;39252.60747392547;40732.59267407347;42113.789431052646;7456.51532650376;7658.73194438192;7744.690212391667;7919.247671471201;8070.83858322842;30913;31890.20274493156;32711.182220443727;33086;33333.66666333305;37309.4403583941;37731;37815.43276850905;38476;38493.42259866048;10012.899871001197;10050.547725352231;10063.949680251551;10085.546150423103;10099.94950025245;11359.48882300282;11442.199046067028;11476.885231147582;11633.59282425111;11645.126615503701;10010.899891000996;10128.797424051625;10226;10795.19036072282;11143.777124457627;10455.215858810467;10551.208659350734;10686.198535109743;10943.890561094287;10946.233763636788;9736.9026309736;9906;10345.37927724339;10501;10752.83870741955;8690.695825646071;8929.821403572023;9215.953920230357;9464;9485;8688.826223475622;8915.910840891507;9192.95403522978;9197.356185067249;9216.447013179231 08:27:21 INFO - 2015-12-09 08:27:21,547 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:27:21 INFO - 2015-12-09 08:27:21,547 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:27:21 INFO - 2015-12-09 08:27:21,547 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1228 08:27:21 INFO - 2015-12-09 08:27:21,547 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:27:21 INFO - 2015-12-09 08:27:21,548 DEBUG : BROWSER_OUTPUT: __startTimestamp1449678441538__endTimestamp 08:27:21 INFO - 2015-12-09 08:27:21,548 DEBUG : BROWSER_OUTPUT: 08:27:21 INFO - 2015-12-09 08:27:21,548 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:27:21 INFO - 2015-12-09 08:27:21,548 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:27:21 INFO - 2015-12-09 08:27:21,548 DEBUG : BROWSER_OUTPUT: 08:27:21 INFO - 2015-12-09 08:27:21,548 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4643.07 Median:4797.64 stddev:481.71 (10.0%) stddev-sans-first:456.24 08:27:21 INFO - 2015-12-09 08:27:21,548 DEBUG : BROWSER_OUTPUT: Values: 2618.1 2719.1 2723.5 2737.2 2753.4 4436.6 4538.4 4663.4 4705.7 4708.0 4633.9 4674.8 4768.8 4777.8 4828.3 4333.1 4361.2 4366.0 4466.2 4495.2 4395.1 4444.3 4458.7 4470.7 4508.7 4198.7 4236.1 4300.4 4303.9 4372.7 4331.7 4355.1 4382.7 4393.9 4405.0 4353.8 4357.1 4369.4 4380.5 4401.0 4521.8 4632.5 4640.4 4646.2 4732.0 4957.7 4968.1 4969.0 4975.7 5022.1 5001.2 5001.6 5004.7 5005.3 5011.1 4549.3 4665.2 4667.8 4707.5 4789.5 5168.3 5212.6 5221.2 5234.9 5257.3 4998.6 5017.1 5021.8 5026.2 5068.0 4843.0 4971.7 4974.3 5001.9 5092.7 4940.7 4953.7 4964.9 4972.2 5006.8 4947.5 4950.8 4956.9 4969.1 5003.5 4063.5 4161.2 4176.1 4177.4 4262.1 3613.3 3626.1 3644.1 3673.9 3687.3 4225.5 4247.2 4268.1 4289.8 4293.9 4908.2 5014.8 5027.7 5027.8 5053.9 4242.4 4331.9 4336.6 4352.8 4376.9 4477.7 4482.1 4487.9 4490.1 4538.7 4561.6 4797.6 4801.2 4809.0 4853.0 4978.6 4982.8 4983.7 4985.4 4993.4 4706.8 4753.9 4803.9 4834.3 4850.2 5062.9 5063.0 5073.9 5075.4 5084.1 4769.5 4876.0 4876.8 5067.3 5189.9 4935.2 5011.6 5025.8 5030.3 5051.8 4880.7 4890.1 4894.5 4895.7 4897.5 4568.1 4698.2 4702.5 4812.7 4845.8 4828.4 4836.8 4850.2 4850.9 4959.0 4789.2 4837.6 4867.2 4868.9 4911.3 08:27:21 INFO - 2015-12-09 08:27:21,548 DEBUG : BROWSER_OUTPUT: 08:27:21 INFO - 2015-12-09 08:27:21,549 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40156.31 Median:29673.28 stddev:65288.25 (220.0%) stddev-sans-first:65403.59 08:27:21 INFO - 2015-12-09 08:27:21,550 DEBUG : BROWSER_OUTPUT: Values: 525.7 527.6 532.7 533.1 537.0 27259.9 27855.7 27875.9 36090.6 36848.0 39780.8 40288.2 40321.2 40329.4 40336.2 7854.3 7965.5 8003.1 8031.6 8032.5 6977.2 7077.0 9737.4 9925.8 9928.5 9744.2 9826.4 9839.9 9842.9 9852.7 7126.0 7366.2 9713.9 9847.2 9851.9 10097.5 10384.2 10384.5 10391.3 10392.9 37348.4 37780.4 37887.6 37961.2 38011.6 2875.3 2945.8 2949.4 3512.1 3537.8 28391.6 28474.4 28764.3 28807.4 29133.9 3398.2 3451.2 3463.8 3512.1 3570.2 225777.0 226726.0 227591.0 227685.0 227773.0 43410.6 47196.8 54331.2 56327.0 56955.1 54646.7 54887.0 55284.7 55356.2 55394.0 13934.4 14120.0 14128.1 14152.0 14209.5 10664.7 10760.7 10780.6 10780.9 10940.7 18949.7 19053.6 19070.6 19081.5 19098.4 7068.6 7249.6 7319.2 7401.1 7404.4 828.2 847.0 872.9 886.5 989.6 26063.7 26659.0 26704.2 26897.0 27033.9 927.5 940.9 998.0 999.8 1029.6 12473.0 12500.7 12663.6 13050.9 13187.7 270378.0 274050.0 274206.0 274325.0 274515.0 46120.3 46347.5 46417.0 46423.8 46478.5 1205.8 1232.9 1234.4 1236.6 1255.4 23311.7 23392.9 23912.3 24042.4 24261.6 35176.8 35257.5 35418.0 35457.0 35489.3 247952.0 248108.0 248811.0 249297.0 249673.0 24206.3 24607.6 27785.9 28284.6 28462.1 33302.8 33610.5 33642.3 33819.8 34003.5 29246.7 31155.0 31617.5 32161.8 32314.0 26724.6 27313.7 27586.2 27638.4 31768.8 29039.3 29326.0 29330.0 29603.0 29743.6 26411.9 26547.7 26800.9 27244.5 29533.7 21622.4 22597.2 23166.9 23589.2 23663.4 08:27:21 INFO - 2015-12-09 08:27:21,550 DEBUG : BROWSER_OUTPUT: 08:27:21 INFO - 2015-12-09 08:27:21,550 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25193.60 Median:4591.28 stddev:77080.05 (1678.8%) stddev-sans-first:77273.55 08:27:21 INFO - 2015-12-09 08:27:21,550 DEBUG : BROWSER_OUTPUT: Values: 267.1 268.9 270.7 271.9 276.6 11106.8 16186.7 16603.3 17119.9 17140.2 9295.8 9522.3 9535.2 15391.5 15797.8 4490.4 4620.2 4621.9 4624.4 4625.7 4579.2 4604.3 4613.4 4613.9 4619.7 3485.0 3539.4 4603.3 4614.7 5093.0 5231.8 5240.2 5256.6 5283.3 5285.5 4955.5 5060.8 5077.1 5082.1 5086.1 11067.7 11127.3 11261.2 11426.0 11453.5 1808.9 1815.5 1846.9 1853.8 1871.0 8869.9 8936.7 9029.5 11835.2 11878.6 1773.6 1914.2 1916.0 1997.1 2015.1 55283.7 56667.4 57013.1 57284.7 57997.0 9179.8 9189.5 9272.6 9297.2 9331.2 11390.5 11393.7 11398.5 11402.7 11426.9 6583.9 6596.6 6699.5 6722.5 6735.2 6548.2 6550.0 6556.7 6609.6 6614.1 3942.2 3995.6 4017.1 4033.3 4050.8 1665.5 1702.1 1708.1 1712.2 1719.5 711.4 795.3 869.9 951.6 980.7 14472.0 14796.3 14989.4 15282.5 15587.6 836.5 843.4 877.7 881.6 909.6 8587.2 8597.4 8636.1 8668.5 8729.3 461148.0 464223.0 466942.0 483179.0 484129.0 56042.7 56990.4 62348.4 64484.0 71631.0 989.2 994.9 1005.3 1007.7 1013.4 13452.0 13577.3 14085.8 14479.6 14486.7 31057.4 31453.8 32129.4 32722.3 33280.2 42476.6 43344.8 44458.0 44779.1 46602.8 8187.7 8277.0 8417.3 8442.5 8443.7 9841.9 9842.8 9885.4 9930.5 16143.7 10162.9 13943.8 14103.4 14120.4 14552.3 12758.7 12882.2 13237.5 13344.7 13577.3 12989.5 13755.4 14043.3 14126.4 14135.9 8463.2 8720.9 8790.7 8871.7 8953.0 13890.7 13947.1 13954.3 14120.8 14519.4 08:27:21 INFO - 2015-12-09 08:27:21,550 DEBUG : BROWSER_OUTPUT: 08:27:21 INFO - 2015-12-09 08:27:21,550 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4897.73 Median:5895.90 stddev:2549.80 (43.2%) stddev-sans-first:2543.70 08:27:21 INFO - 2015-12-09 08:27:21,550 DEBUG : BROWSER_OUTPUT: Values: 1437.8 1584.6 1644.5 1644.8 1681.4 5877.1 6917.2 7098.7 7105.2 7107.6 6974.5 7130.5 7143.4 7157.3 7160.5 2020.2 2051.7 2056.9 2059.1 2060.9 1956.6 2007.9 2018.4 2024.1 2028.8 1998.1 2040.7 2067.1 2067.9 2069.5 1975.4 1985.7 1987.2 1994.0 1996.6 1989.6 2005.2 2006.3 2013.3 2022.3 6938.7 7008.1 7022.8 7025.8 7033.0 4046.5 4110.9 4133.9 4138.5 4143.9 2718.5 2748.6 2765.7 2773.1 2795.4 844.8 851.7 859.2 860.7 866.0 9682.8 9692.7 9698.0 9707.4 9719.8 3765.5 3766.8 3824.1 3854.5 3870.5 8297.8 8297.8 8306.1 8310.9 8316.3 4155.2 4156.0 4166.6 4167.4 4187.4 3238.3 3327.1 3659.1 3804.8 3817.9 3300.6 3300.7 3315.4 3342.7 3415.8 1049.6 1059.4 1062.3 1068.1 1081.5 1173.9 1175.9 1178.6 1189.7 1201.0 6517.1 6528.7 6537.3 6550.5 6608.2 1022.9 1038.9 1056.3 1059.5 1063.1 5234.5 5248.8 5257.1 5277.9 5280.0 8270.3 8640.8 8670.7 8674.7 8677.2 8536.3 8542.7 8547.5 8551.3 8589.2 6562.5 6623.5 6735.9 6760.6 6872.5 6421.9 6460.9 6461.9 6466.4 6466.5 7414.3 7681.6 7686.4 7737.2 7794.2 7719.9 7785.8 7794.2 7814.8 7928.1 5006.5 5079.9 5112.7 5836.6 5897.1 6214.2 6281.6 6416.3 6417.1 6442.0 5849.5 6101.1 6238.8 6305.2 6312.6 6075.4 6163.1 6209.2 6250.4 6266.3 6402.8 6453.9 6456.8 6459.1 6466.3 5894.7 5917.6 5928.4 5929.6 5931.3 5546.7 5618.9 5660.3 5673.2 6045.5 08:27:21 INFO - 2015-12-09 08:27:21,551 DEBUG : BROWSER_OUTPUT: 08:27:21 INFO - 2015-12-09 08:27:21,551 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4531.37 Median:5263.97 stddev:1391.15 (26.4%) stddev-sans-first:1357.47 08:27:21 INFO - 2015-12-09 08:27:21,552 DEBUG : BROWSER_OUTPUT: Values: 252.6 258.3 259.7 260.7 261.7 5265.5 5272.5 5296.6 5364.5 5366.4 5171.1 5235.4 5243.4 5258.1 5262.4 4018.4 4019.3 4021.9 4032.5 4039.7 4023.5 4027.2 4029.7 4034.3 4035.0 3701.7 3750.9 3875.2 3980.3 3986.0 3971.1 3974.3 3989.4 4002.4 4006.0 3435.8 3436.7 3437.9 3440.2 3440.4 4878.9 4988.3 5019.6 5097.5 5100.2 4534.8 4535.2 4545.8 4546.6 4553.1 5532.3 5539.5 5546.3 5548.9 5551.0 3708.8 3709.0 3711.7 3712.8 3717.8 5602.5 5820.5 5836.6 5837.5 5839.6 3726.4 3759.5 3760.7 3762.1 3765.4 3804.7 3805.4 3812.5 3818.4 3821.7 4462.4 4465.3 4470.6 4470.7 4474.1 4889.3 5274.8 5329.5 5353.7 5355.1 1300.2 1327.7 1329.2 1329.5 1337.4 846.4 848.1 848.5 859.0 864.1 4762.3 4784.1 4787.6 4787.9 4789.6 5717.8 5719.7 5720.2 5723.6 5725.9 4753.0 4772.8 4776.1 4782.8 4787.0 2561.4 2919.3 2975.5 2987.2 3060.5 5299.3 5375.9 5388.4 5456.4 5476.9 5708.3 5734.4 5823.9 5914.5 5940.8 5460.0 5461.2 5461.8 5465.2 5466.6 5779.2 5812.7 5816.2 5817.2 5818.4 5496.8 5647.2 5675.1 5677.6 5678.9 5491.1 5491.3 5495.7 5500.8 5502.9 3704.2 3728.0 3732.4 3733.6 3738.6 5785.5 5789.1 5789.7 5802.6 5805.7 5447.3 5577.0 5578.9 5587.3 5589.7 5538.9 5543.7 5547.9 5549.2 5569.9 5463.3 5472.6 5475.8 5477.1 5480.7 5394.8 5579.6 5581.7 5611.2 5621.7 5418.2 5439.8 5478.3 5478.8 5479.3 08:27:21 INFO - 2015-12-09 08:27:21,552 DEBUG : BROWSER_OUTPUT: 08:27:21 INFO - 2015-12-09 08:27:21,553 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12031.26 Median:43287.35 stddev:13324.47 (30.8%) stddev-sans-first:13334.13 08:27:21 INFO - 2015-12-09 08:27:21,553 DEBUG : BROWSER_OUTPUT: Values: 585.7 640.2 675.5 703.5 749.4 12377.6 12450.2 12477.5 12479.8 12508.2 11786.1 11817.5 11843.9 11847.8 11855.9 620.6 627.0 786.4 794.8 799.4 794.5 797.5 802.4 802.8 804.3 826.5 826.9 827.0 833.3 833.5 654.9 662.7 820.4 832.4 836.9 621.7 622.0 622.0 622.3 622.5 12010.9 12012.8 12132.5 12161.1 12181.7 11032.4 11251.4 11269.7 11709.4 11719.9 9415.1 9430.4 9512.0 9559.2 9614.1 3239.7 3265.0 3274.3 3296.2 3300.5 38742.4 38810.0 39281.4 39611.4 39825.6 9179.5 9314.7 9360.9 9400.5 9521.3 15604.6 15604.6 15654.7 15663.8 15721.6 6088.6 6093.2 6123.4 6232.1 6247.3 3506.0 3535.6 3548.0 3560.3 3572.6 2657.3 2678.7 2678.8 2687.8 2688.9 494.1 494.8 496.9 497.3 498.7 462.9 472.6 487.8 493.8 561.3 7035.4 7333.8 7430.4 7618.9 7827.2 507.0 532.9 592.9 604.0 608.4 3468.5 3567.3 3755.2 3919.7 3923.0 45477.5 46365.3 46378.3 46581.5 46870.5 42833.0 43255.8 43259.4 43315.4 43445.6 38391.2 38986.6 39252.6 40732.6 42113.8 7456.5 7658.7 7744.7 7919.2 8070.8 30913.0 31890.2 32711.2 33086.0 33333.7 37309.4 37731.0 37815.4 38476.0 38493.4 10012.9 10050.5 10063.9 10085.5 10099.9 11359.5 11442.2 11476.9 11633.6 11645.1 10010.9 10128.8 10226.0 10795.2 11143.8 10455.2 10551.2 10686.2 10943.9 10946.2 9736.9 9906.0 10345.4 10501.0 10752.8 8690.7 8929.8 9216.0 9464.0 9485.0 8688.8 8915.9 9193.0 9197.4 9216.4 08:27:21 INFO - 2015-12-09 08:27:21,553 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:27:21 INFO - 2015-12-09 08:27:21,553 DEBUG : BROWSER_OUTPUT: 08:27:22 INFO - 2015-12-09 08:27:22,276 INFO : Browser exited with error code: 0 08:27:22 INFO - 2015-12-09 08:27:22,295 INFO : Completed test dromaeo_css (00:18:39) 08:27:22 INFO - 2015-12-09 08:27:22,295 INFO : Starting test kraken 08:27:22 INFO - 2015-12-09 08:27:22,295 DEBUG : operating with platform_type : linux_ 08:27:22 INFO - 2015-12-09 08:27:22,295 INFO : Initialising browser for kraken test... 08:27:22 INFO - 2015-12-09 08:27:22,301 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP9CDQh/profile http://localhost:52979/getInfo.html 08:27:26 INFO - 2015-12-09 08:27:26,025 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:27:26 INFO - 2015-12-09 08:27:26,025 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:27:26 INFO - 2015-12-09 08:27:26,025 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:27:26 INFO - 2015-12-09 08:27:26,025 DEBUG : BROWSER_OUTPUT: __metrics 08:27:26 INFO - 2015-12-09 08:27:26,093 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:27:26 INFO - 2015-12-09 08:27:26,150 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:27:26 ERROR - 2015-12-09 08:27:26,157 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 08:27:27 INFO - 2015-12-09 08:27:27,021 INFO : Browser initialized. 08:27:27 INFO - 2015-12-09 08:27:27,022 INFO : Running cycle 1/1 for kraken test... 08:27:27 INFO - 2015-12-09 08:27:27,022 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP9CDQh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:27:39 INFO - 2015-12-09 08:27:39,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 142659584 08:27:39 INFO - 2015-12-09 08:27:39,015 DEBUG : BROWSER_OUTPUT: 08:27:41 INFO - 2015-12-09 08:27:41,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52979/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:42 INFO - 2015-12-09 08:27:42,241 DEBUG : BROWSER_OUTPUT: RSS: Main: 181084160 08:27:42 INFO - 2015-12-09 08:27:42,241 DEBUG : BROWSER_OUTPUT: 08:27:44 INFO - 2015-12-09 08:27:44,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52979/tests/kraken/driver.html?testName=audio-dft) 08:27:45 INFO - 2015-12-09 08:27:45,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 168660992 08:27:45 INFO - 2015-12-09 08:27:45,524 DEBUG : BROWSER_OUTPUT: 08:27:48 INFO - 2015-12-09 08:27:48,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52979/tests/kraken/driver.html?testName=audio-fft) 08:27:49 INFO - 2015-12-09 08:27:49,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 152567808 08:27:49 INFO - 2015-12-09 08:27:49,111 DEBUG : BROWSER_OUTPUT: 08:27:51 INFO - 2015-12-09 08:27:51,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52979/tests/kraken/driver.html?testName=audio-oscillator) 08:27:51 INFO - 2015-12-09 08:27:51,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 155623424 08:27:51 INFO - 2015-12-09 08:27:51,711 DEBUG : BROWSER_OUTPUT: 08:27:53 INFO - 2015-12-09 08:27:53,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52979/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:27:54 INFO - 2015-12-09 08:27:54,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 156991488 08:27:54 INFO - 2015-12-09 08:27:54,519 DEBUG : BROWSER_OUTPUT: 08:27:57 INFO - 2015-12-09 08:27:57,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52979/tests/kraken/driver.html?testName=imaging-darkroom) 08:27:58 INFO - 2015-12-09 08:27:58,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 158957568 08:27:58 INFO - 2015-12-09 08:27:58,139 DEBUG : BROWSER_OUTPUT: 08:28:01 INFO - 2015-12-09 08:28:01,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52979/tests/kraken/driver.html?testName=imaging-desaturate) 08:28:02 INFO - 2015-12-09 08:28:02,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 159744000 08:28:02 INFO - 2015-12-09 08:28:02,163 DEBUG : BROWSER_OUTPUT: 08:28:05 INFO - 2015-12-09 08:28:05,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52979/tests/kraken/driver.html?testName=json-parse-financial) 08:28:05 INFO - 2015-12-09 08:28:05,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 157843456 08:28:05 INFO - 2015-12-09 08:28:05,595 DEBUG : BROWSER_OUTPUT: 08:28:07 INFO - 2015-12-09 08:28:07,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52979/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:28:07 INFO - 2015-12-09 08:28:07,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 169934848 08:28:07 INFO - 2015-12-09 08:28:07,977 DEBUG : BROWSER_OUTPUT: 08:28:09 INFO - 2015-12-09 08:28:09,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52979/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:28:10 INFO - 2015-12-09 08:28:10,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 169078784 08:28:10 INFO - 2015-12-09 08:28:10,458 DEBUG : BROWSER_OUTPUT: 08:28:12 INFO - 2015-12-09 08:28:12,630 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52979/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:28:13 INFO - 2015-12-09 08:28:13,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 181743616 08:28:13 INFO - 2015-12-09 08:28:13,212 DEBUG : BROWSER_OUTPUT: 08:28:15 INFO - 2015-12-09 08:28:15,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52979/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:28:16 INFO - 2015-12-09 08:28:16,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 185180160 08:28:16 INFO - 2015-12-09 08:28:16,365 DEBUG : BROWSER_OUTPUT: 08:28:18 INFO - 2015-12-09 08:28:18,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52979/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:28:19 INFO - 2015-12-09 08:28:19,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 183836672 08:28:19 INFO - 2015-12-09 08:28:19,568 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52979/tests/kraken/driver.html?testName=ai-astar) 08:28:21 INFO - 2015-12-09 08:28:21,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 243077120 08:28:21 INFO - 2015-12-09 08:28:21,592 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,594 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:28:21 INFO - 2015-12-09 08:28:21,594 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:28:21 INFO - 2015-12-09 08:28:21,595 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:28:21 INFO - 2015-12-09 08:28:21,595 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:28:21 INFO - 2015-12-09 08:28:21,595 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;114;107;114;114;114;105;114;111;119 08:28:21 INFO - 2015-12-09 08:28:21,595 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;129;155;175;131;152;146;129;170;130 08:28:21 INFO - 2015-12-09 08:28:21,595 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;159;161;160;161;161;163;161;161 08:28:21 INFO - 2015-12-09 08:28:21,595 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;79;97;71;78;70;102;87;72 08:28:21 INFO - 2015-12-09 08:28:21,596 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;133;94;95;95;136;94;94;128 08:28:21 INFO - 2015-12-09 08:28:21,596 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;109;109;109;110;109;109 08:28:21 INFO - 2015-12-09 08:28:21,596 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;147;146;146;146;146;146 08:28:21 INFO - 2015-12-09 08:28:21,596 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;96;96;95;95;96 08:28:21 INFO - 2015-12-09 08:28:21,596 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;75;74;75;73;83;73;73;75;71 08:28:21 INFO - 2015-12-09 08:28:21,596 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;70;69;70;69;69;68;68 08:28:21 INFO - 2015-12-09 08:28:21,596 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;83;86;85;84;93;85;86;87;85 08:28:21 INFO - 2015-12-09 08:28:21,597 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;122;118;118;123;120;129;133;122;118 08:28:21 INFO - 2015-12-09 08:28:21,597 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;151;147;149;140;138;151;158;150;139 08:28:21 INFO - 2015-12-09 08:28:21,597 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;69;70;69;69;69;68;68;68;71 08:28:21 INFO - 2015-12-09 08:28:21,597 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:28:21 INFO - 2015-12-09 08:28:21,597 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:28:21 INFO - 2015-12-09 08:28:21,597 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,998 08:28:21 INFO - 2015-12-09 08:28:21,597 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:28:21 INFO - 2015-12-09 08:28:21,598 DEBUG : BROWSER_OUTPUT: __startTimestamp1449678501593__endTimestamp 08:28:21 INFO - 2015-12-09 08:28:21,598 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,605 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:28:21 INFO - 2015-12-09 08:28:21,605 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:28:21 INFO - 2015-12-09 08:28:21,605 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,605 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:3.98 (3.5%) stddev-sans-first:4.22 08:28:21 INFO - 2015-12-09 08:28:21,605 DEBUG : BROWSER_OUTPUT: Values: 113.0 114.0 107.0 114.0 114.0 114.0 105.0 114.0 111.0 119.0 08:28:21 INFO - 2015-12-09 08:28:21,606 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,606 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.30 Median:153.50 stddev:17.24 (11.2%) stddev-sans-first:18.00 08:28:21 INFO - 2015-12-09 08:28:21,606 DEBUG : BROWSER_OUTPUT: Values: 156.0 129.0 155.0 175.0 131.0 152.0 146.0 129.0 170.0 130.0 08:28:21 INFO - 2015-12-09 08:28:21,606 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,606 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 08:28:21 INFO - 2015-12-09 08:28:21,606 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 159.0 161.0 160.0 161.0 161.0 163.0 161.0 161.0 08:28:21 INFO - 2015-12-09 08:28:21,606 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,606 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:75.50 stddev:11.47 (15.2%) stddev-sans-first:11.79 08:28:21 INFO - 2015-12-09 08:28:21,606 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 79.0 97.0 71.0 78.0 70.0 102.0 87.0 72.0 08:28:21 INFO - 2015-12-09 08:28:21,606 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,606 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:94.50 stddev:18.28 (19.3%) stddev-sans-first:19.03 08:28:21 INFO - 2015-12-09 08:28:21,607 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 133.0 94.0 95.0 95.0 136.0 94.0 94.0 128.0 08:28:21 INFO - 2015-12-09 08:28:21,607 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,607 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:28:21 INFO - 2015-12-09 08:28:21,607 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 08:28:21 INFO - 2015-12-09 08:28:21,607 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,607 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:28:21 INFO - 2015-12-09 08:28:21,607 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 08:28:21 INFO - 2015-12-09 08:28:21,607 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,607 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:28:21 INFO - 2015-12-09 08:28:21,607 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 08:28:21 INFO - 2015-12-09 08:28:21,607 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,607 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.60 Median:74.50 stddev:3.20 (4.3%) stddev-sans-first:3.39 08:28:21 INFO - 2015-12-09 08:28:21,607 DEBUG : BROWSER_OUTPUT: Values: 74.0 75.0 74.0 75.0 73.0 83.0 73.0 73.0 75.0 71.0 08:28:21 INFO - 2015-12-09 08:28:21,607 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 70.0 69.0 70.0 69.0 69.0 68.0 68.0 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:2.73 (3.2%) stddev-sans-first:2.87 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: Values: 85.0 83.0 86.0 85.0 84.0 93.0 85.0 86.0 87.0 85.0 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:122.50 stddev:5.14 (4.2%) stddev-sans-first:5.25 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: Values: 127.0 122.0 118.0 118.0 123.0 120.0 129.0 133.0 122.0 118.0 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.90 Median:149.50 stddev:7.22 (4.8%) stddev-sans-first:6.71 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: Values: 136.0 151.0 147.0 149.0 140.0 138.0 151.0 158.0 150.0 139.0 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:1.14 (1.6%) stddev-sans-first:1.00 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 70.0 69.0 69.0 69.0 68.0 68.0 68.0 71.0 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:28:21 INFO - 2015-12-09 08:28:21,608 DEBUG : BROWSER_OUTPUT: 08:28:22 INFO - 2015-12-09 08:28:22,376 INFO : Browser exited with error code: 0 08:28:22 INFO - 2015-12-09 08:28:22,422 INFO : Completed test kraken (00:01:00) 08:28:22 INFO - 2015-12-09 08:28:22,422 INFO : Starting test v8_7 08:28:22 INFO - 2015-12-09 08:28:22,422 DEBUG : operating with platform_type : linux_ 08:28:22 INFO - 2015-12-09 08:28:22,422 INFO : Initialising browser for v8_7 test... 08:28:22 INFO - 2015-12-09 08:28:22,428 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdoAvVt/profile http://localhost:52979/getInfo.html 08:28:26 INFO - 2015-12-09 08:28:26,000 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:28:26 INFO - 2015-12-09 08:28:26,000 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:28:26 INFO - 2015-12-09 08:28:26,000 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:28:26 INFO - 2015-12-09 08:28:26,000 DEBUG : BROWSER_OUTPUT: __metrics 08:28:26 INFO - 2015-12-09 08:28:26,076 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:28:26 INFO - 2015-12-09 08:28:26,153 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:27 INFO - 2015-12-09 08:28:27,149 INFO : Browser initialized. 08:28:27 INFO - 2015-12-09 08:28:27,149 INFO : Running cycle 1/1 for v8_7 test... 08:28:27 INFO - 2015-12-09 08:28:27,150 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdoAvVt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:28:39 INFO - 2015-12-09 08:28:39,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 143495168 08:28:39 INFO - 2015-12-09 08:28:39,141 DEBUG : BROWSER_OUTPUT: 08:29:00 INFO - 2015-12-09 08:29:00,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52979/tests/v8_7/run.html (next: http://localhost:52979/tests/v8_7/run.html) 08:29:00 INFO - 2015-12-09 08:29:00,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 451829760 08:29:00 INFO - 2015-12-09 08:29:00,873 DEBUG : BROWSER_OUTPUT: 08:29:00 INFO - 2015-12-09 08:29:00,874 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:29:00 INFO - 2015-12-09 08:29:00,874 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:29:00 INFO - 2015-12-09 08:29:00,874 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:29:00 INFO - 2015-12-09 08:29:00,874 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:29:00 INFO - 2015-12-09 08:29:00,874 DEBUG : BROWSER_OUTPUT: |0;Richards;165.56291390728478 08:29:00 INFO - 2015-12-09 08:29:00,874 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.35855385762207 08:29:00 INFO - 2015-12-09 08:29:00,875 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.55153203342616 08:29:00 INFO - 2015-12-09 08:29:00,875 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 08:29:00 INFO - 2015-12-09 08:29:00,875 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1960.7843137254902 08:29:00 INFO - 2015-12-09 08:29:00,875 DEBUG : BROWSER_OUTPUT: |5;Earley;792.3930269413629 08:29:00 INFO - 2015-12-09 08:29:00,875 DEBUG : BROWSER_OUTPUT: |6;Boyer;11952.941176470587 08:29:00 INFO - 2015-12-09 08:29:00,875 DEBUG : BROWSER_OUTPUT: |7;RegExp;27027.027027027027 08:29:00 INFO - 2015-12-09 08:29:00,875 DEBUG : BROWSER_OUTPUT: |8;Splay;651.7218973359325 08:29:00 INFO - 2015-12-09 08:29:00,876 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 08:29:00 INFO - 2015-12-09 08:29:00,876 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:29:00 INFO - 2015-12-09 08:29:00,876 DEBUG : BROWSER_OUTPUT: __startTimestamp1449678540872__endTimestamp 08:29:00 INFO - 2015-12-09 08:29:00,876 DEBUG : BROWSER_OUTPUT: 08:29:00 INFO - 2015-12-09 08:29:00,876 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:29:00 INFO - 2015-12-09 08:29:00,877 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:29:00 INFO - 2015-12-09 08:29:00,877 DEBUG : BROWSER_OUTPUT: 08:29:00 INFO - 2015-12-09 08:29:00,877 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.56 Median:165.56 stddev:0.00 (0.0%) 08:29:00 INFO - 2015-12-09 08:29:00,878 DEBUG : BROWSER_OUTPUT: Values: 165.6 08:29:00 INFO - 2015-12-09 08:29:00,878 DEBUG : BROWSER_OUTPUT: 08:29:00 INFO - 2015-12-09 08:29:00,878 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.36 Median:186.36 stddev:0.00 (0.0%) 08:29:00 INFO - 2015-12-09 08:29:00,879 DEBUG : BROWSER_OUTPUT: Values: 186.4 08:29:00 INFO - 2015-12-09 08:29:00,879 DEBUG : BROWSER_OUTPUT: 08:29:00 INFO - 2015-12-09 08:29:00,879 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 08:29:00 INFO - 2015-12-09 08:29:00,879 DEBUG : BROWSER_OUTPUT: Values: 278.6 08:29:00 INFO - 2015-12-09 08:29:00,879 DEBUG : BROWSER_OUTPUT: 08:29:00 INFO - 2015-12-09 08:29:00,879 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 08:29:00 INFO - 2015-12-09 08:29:00,879 DEBUG : BROWSER_OUTPUT: Values: 5175.3 08:29:00 INFO - 2015-12-09 08:29:00,880 DEBUG : BROWSER_OUTPUT: 08:29:00 INFO - 2015-12-09 08:29:00,880 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1960.78 Median:1960.78 stddev:0.00 (0.0%) 08:29:00 INFO - 2015-12-09 08:29:00,880 DEBUG : BROWSER_OUTPUT: Values: 1960.8 08:29:00 INFO - 2015-12-09 08:29:00,880 DEBUG : BROWSER_OUTPUT: 08:29:00 INFO - 2015-12-09 08:29:00,880 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 08:29:00 INFO - 2015-12-09 08:29:00,880 DEBUG : BROWSER_OUTPUT: Values: 792.4 08:29:00 INFO - 2015-12-09 08:29:00,880 DEBUG : BROWSER_OUTPUT: 08:29:00 INFO - 2015-12-09 08:29:00,880 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11952.94 Median:11952.94 stddev:0.00 (0.0%) 08:29:00 INFO - 2015-12-09 08:29:00,880 DEBUG : BROWSER_OUTPUT: Values: 11952.9 08:29:00 INFO - 2015-12-09 08:29:00,880 DEBUG : BROWSER_OUTPUT: 08:29:00 INFO - 2015-12-09 08:29:00,880 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27027.03 Median:27027.03 stddev:0.00 (0.0%) 08:29:00 INFO - 2015-12-09 08:29:00,880 DEBUG : BROWSER_OUTPUT: Values: 27027.0 08:29:00 INFO - 2015-12-09 08:29:00,880 DEBUG : BROWSER_OUTPUT: 08:29:00 INFO - 2015-12-09 08:29:00,881 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:651.72 Median:651.72 stddev:0.00 (0.0%) 08:29:00 INFO - 2015-12-09 08:29:00,881 DEBUG : BROWSER_OUTPUT: Values: 651.7 08:29:00 INFO - 2015-12-09 08:29:00,881 DEBUG : BROWSER_OUTPUT: 08:29:00 INFO - 2015-12-09 08:29:00,881 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 08:29:00 INFO - 2015-12-09 08:29:00,881 DEBUG : BROWSER_OUTPUT: Values: 4826.9 08:29:00 INFO - 2015-12-09 08:29:00,881 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:29:00 INFO - 2015-12-09 08:29:00,881 DEBUG : BROWSER_OUTPUT: 08:29:01 INFO - 2015-12-09 08:29:01,772 INFO : Browser exited with error code: 0 08:29:01 INFO - 2015-12-09 08:29:01,787 INFO : Completed test v8_7 (00:00:39) 08:29:01 INFO - 2015-12-09 08:29:01,840 INFO : Completed test suite (00:20:18) 08:29:01 INFO - 2015-12-09 08:29:01,841 DEBUG : Working with test: dromaeo_css 08:29:01 INFO - 2015-12-09 08:29:01,841 DEBUG : Generating results file: dromaeo_css 08:29:01 INFO - 2015-12-09 08:29:01,842 DEBUG : Working with test: kraken 08:29:01 INFO - 2015-12-09 08:29:01,842 DEBUG : Generating results file: kraken 08:29:01 INFO - 2015-12-09 08:29:01,842 INFO : javascript benchmark 08:29:01 INFO - 2015-12-09 08:29:01,842 DEBUG : Working with test: v8_7 08:29:01 INFO - 2015-12-09 08:29:01,842 DEBUG : Generating results file: v8_7 08:29:01 INFO - 2015-12-09 08:29:01,843 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:01 INFO - 2015-12-09 08:29:01,899 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 08:29:01 INFO - 2015-12-09 08:29:01,899 DEBUG : process_Request line: dromaeo_css 6177.09 graph.html#tests=[[72,132,35]] 08:29:01 INFO - 2015-12-09 08:29:01,899 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:01 INFO - 2015-12-09 08:29:01,932 DEBUG : process_Request line: kraken 1525.00 graph.html#tests=[[232,132,35]] 08:29:01 INFO - 2015-12-09 08:29:01,932 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:01 INFO - 2015-12-09 08:29:01,968 DEBUG : process_Request line: v8_7 19714.37 graph.html#tests=[[230,132,35]] 08:29:01 INFO - 2015-12-09 08:29:01,969 INFO : javascript benchmark 08:29:02 INFO - 2015-12-09 08:29:01,973 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2618.1360151150116, 2719.1026961102825, 2723.523383407903, 2737.2062101990437, 2753.366725653099, 4436.578525040124, 4538.410006699133, 4663.440387153542, 4705.741184234866, 4707.952920470799, 4633.90732185357, 4674.76626168691, 4768.761561921908, 4777.808887644499, 4828.324034635145, 4333.11171209902, 4361.214981303364, 4365.956340436586, 4466.196084704752, 4495.235809912307, 4395.120975804836, 4444.266695995157, 4458.71018383804, 4470.7317560946285, 4508.706934049276, 4198.6850986176005, 4236.06806502572, 4300.440942677432, 4303.870883873489, 4372.650187984954, 4331.675124365654, 4355.063661312801, 4382.737035777864, 4393.912121757547, 4404.977975110104, 4353.846230748854, 4357.128574285156, 4369.410129632491, 4380.540043295472, 4401.031773009932, 4521.7739113044545, 4632.513586073481, 4640.443146822369, 4646.210144275481, 4732.02993386355, 4957.677750946177, 4968.105740966625, 4968.975155124202, 4975.651704380694, 5022.146235140035, 5001.24981252815, 5001.574866136383, 5004.749762511859, 5005.324281222025, 5011.1481048221885, 4549.31760235964, 4665.206914824488, 4667.836625718083, 4707.529247075334, 4789.4971028041555, 5168.328117344721, 5212.55693266069, 5221.190715439113, 5234.895302094013, 5257.263983042377, 4998.5751211146735, 5017.071841709296, 5021.794769255353, 5026.220935754964, 5067.974660126676, 4842.951570484321, 4971.726555039435, 4974.328465657162, 5001.949980500149, 5092.719900405513, 4940.6788558743565, 4953.678010929278, 4964.925526117111, 4972.154733695281, 5006.824761133415, 4947.48051454592, 4950.8267210647455, 4956.8760780980765, 4969.080720066727, 5003.549680528697, 4063.5326937401987, 4161.167766446662, 4176.081262122389, 4177.436046133794, 4262.062346283813, 3613.349597072552, 3626.1478552540134, 3644.052546337918, 3673.8530458781884, 3687.3362794697214, 4225.514065882401, 4247.214265360918, 4268.103698223408, 4289.828406863753, 4293.914121717548, 4908.165611845995, 5014.84955451337, 5027.673201241908, 5027.824026159067, 5053.873653158627, 4242.427272318259, 4331.891702707458, 4336.609705126553, 4352.760598167131, 4376.868693939187, 4477.664175186809, 4482.103579284156, 4487.887802804956, 4490.057088011489, 4538.659600529973, 4561.63506919439, 4797.64017698681, 4801.231802911518, 4808.9901120765035, 4852.95147048525, 4978.551930326288, 4982.825601103944, 4983.6760610560195, 4985.351904252424, 4993.400791904995, 4706.835260765994, 4753.857384278477, 4803.879903002453, 4834.250691142878, 4850.223964165716, 5062.924056139087, 5063.0, 5073.923891141562, 5075.365579302587, 5084.1102807009365, 4769.523047695203, 4876.024795041077, 4876.80492780299, 5067.315912351785, 5189.948100518946, 4935.161022626234, 5011.624128190473, 5025.84922452327, 5030.295758593873, 5051.772670229922, 4880.682755620874, 4890.070886531547, 4894.510548945077, 4895.657303988686, 4897.4857639947295, 4568.132054909556, 4698.154332220233, 4702.459217190067, 4812.711237325771, 4845.781939812788, 4828.444728856086, 4836.758162091952, 4850.248211527219, 4850.878728031827, 4958.975205123951, 4789.185838407409, 4837.564619184291, 4867.172580661367, 4868.926966095582, 4911.3369695090705], "unit": "ms", "name": "dojo.html", "value": 4613.331795787195}, {"lowerIsBetter": false, "replicates": [525.6950968438305, 527.6332948600724, 532.6670830730792, 533.0937406409106, 536.9785208591657, 27259.86370068152, 27855.721442785565, 27875.860620696894, 36090.63909360912, 36848.0, 39780.80109599455, 40288.19423611526, 40321.1855466504, 40329.39505907414, 40336.19327613446, 7854.293113619788, 7965.522068675898, 8003.119656837744, 8031.638576264082, 8032.477888937229, 6977.197622273427, 7076.964615176917, 9737.415755054684, 9925.751856203617, 9928.50357482123, 9744.171745401649, 9826.410415375065, 9839.852402213972, 9842.90157098427, 9852.655157069505, 7126.0, 7366.226546212678, 9713.854292185622, 9847.16299114569, 9851.852222216638, 10097.495125243708, 10384.221183411199, 10384.480775961172, 10391.324563903398, 10392.896071039268, 37348.43977340342, 37780.43329350062, 37887.62112378896, 37961.24077518462, 38011.61988380108, 2875.2609005364943, 2945.808522446034, 2949.4101179764134, 3512.08685741709, 3537.7700449470703, 28391.57412638812, 28474.440694913137, 28764.280892977633, 28807.423851522854, 29133.85433072821, 3398.167448975017, 3451.2234747181933, 3463.809490478023, 3512.0693016350688, 3570.2145527983803, 225777.0, 226726.0, 227591.0, 227685.0, 227773.0, 43410.565894341285, 47196.7640161797, 54331.18503222455, 56327.0, 56955.14567281494, 54646.726766365915, 54887.0, 55284.72357638186, 55356.16965745517, 55394.0, 13934.37295321713, 14120.0, 14128.081674691111, 14152.0, 14209.502667406798, 10664.733381665365, 10760.677179684622, 10780.568777248978, 10780.94609526963, 10940.726481838017, 18949.715754263696, 19053.61892762137, 19070.61858762817, 19081.522961926064, 19098.427047188605, 7068.646567671596, 7249.637518124073, 7319.2314806944505, 7401.0748656417945, 7404.407647388196, 828.2007862412801, 847.0301504776996, 872.9476231426135, 886.4769785826394, 989.5645915797027, 26063.73936260651, 26659.0, 26704.19887403381, 26897.0, 27033.864830676113, 927.5037854747812, 940.9012053734397, 997.9720887485901, 999.7850462150673, 1029.5984566019258, 12473.0, 12500.747294792907, 12663.620091397273, 13050.934745326213, 13187.73624527504, 270378.0, 274050.0, 274206.0317587314, 274325.0, 274515.0, 46120.308195377096, 46347.51134841125, 46417.0, 46423.76788116038, 46478.535214648095, 1205.7769312677183, 1232.9075319351084, 1234.3581337704522, 1236.5548402575066, 1255.3785875991443, 23311.650325245475, 23392.883035584713, 23912.28263152108, 24042.39894002664, 24261.636075459235, 35176.82411587926, 35257.47113793346, 35418.0, 35457.0, 35489.29021419609, 247952.0, 248108.0, 248811.0, 249297.0, 249673.0, 24206.273811785675, 24607.630885536375, 27785.86107069452, 28284.575731364457, 28462.146135615963, 33302.833485832416, 33610.49584256189, 33642.327153457285, 33819.830900845336, 34003.48994765031, 29246.7075329244, 31155.0, 31617.5257371135, 32161.839190803898, 32314.0, 26724.599131013438, 27313.726862731117, 27586.172414827586, 27638.44723105567, 31768.841155794074, 29039.274018149714, 29326.0, 29330.0, 29603.0, 29743.553846691884, 26411.867940660173, 26547.734522654526, 26800.865995669898, 27244.455110898067, 29533.704662953096, 21622.35132946014, 22597.2090976815, 23166.884165579064, 23589.174378896656, 23663.408414789767], "unit": "ms", "name": "ext.html", "value": 16659.76464418851}, {"lowerIsBetter": false, "replicates": [267.1171777276103, 268.9367998520347, 270.6819487102654, 271.9415325704973, 276.6224104097906, 11106.833397499044, 16186.676266474664, 16603.33586656532, 17119.914400427995, 17140.22868970896, 9295.814083718322, 9522.285828562852, 9535.189508891735, 15391.538253852374, 15797.763033554476, 4490.371348011273, 4620.168369693454, 4621.861344159681, 4624.421947256593, 4625.722456652595, 4579.22153233951, 4604.3323718060865, 4613.446386433633, 4613.861584152481, 4619.676622636417, 3484.9651503484893, 3539.4159963605975, 4603.332516785064, 4614.723116613014, 5093.0, 5231.790728370861, 5240.161574148118, 5256.605754568384, 5283.28675628789, 5285.497877701612, 4955.504449555052, 5060.772265248036, 5077.060743762416, 5082.110630639623, 5086.109930762102, 11067.72330691731, 11127.332360058423, 11261.155413344031, 11426.0, 11453.541858325658, 1808.8706537689739, 1815.5370380553006, 1846.8799528030636, 1853.8424233940132, 1870.9812901870944, 8869.866951995726, 8936.687215947411, 9029.458232506071, 11835.230710003909, 11878.643640690792, 1773.6186719855293, 1914.1673372083048, 1915.9521011974673, 1997.1412292714126, 2015.123421311734, 55283.72358138183, 56667.43332566663, 57013.14480282799, 57284.71357643227, 57997.0, 9179.77050573741, 9189.540522973824, 9272.58273377686, 9297.163255307054, 9331.160195582295, 11390.544378224778, 11393.715157120972, 11398.487068081957, 11402.714932126597, 11426.94286528562, 6583.9012414813815, 6596.60420374779, 6699.464042876558, 6722.529422940445, 6735.191776986695, 6548.214214294315, 6549.967250163719, 6556.672166391661, 6609.570377925419, 6614.140161778938, 3942.211557688474, 3995.5604883462797, 4017.0760725032824, 4033.2740106780475, 4050.8177132029127, 1665.53365057784, 1702.1404190883773, 1708.094709803806, 1712.222898114272, 1719.5443207550009, 711.3775446484326, 795.2882170457408, 869.9434536755217, 951.6478902805868, 980.7401038724744, 14472.0, 14796.334164962602, 14989.400423983137, 15282.541523754306, 15587.61030974212, 836.5399030533182, 843.3506200225792, 877.6747111861008, 881.5876537927631, 909.5679552212646, 8587.184217499327, 8597.398182127316, 8636.136386361313, 8668.479891206547, 8729.301655867515, 461148.0, 464223.0, 466942.0, 483179.0, 484129.0, 56042.719786400805, 56990.43009569934, 62348.37651623425, 64484.0, 71631.0, 989.2333441582831, 994.8656931314325, 1005.3415013166388, 1007.6825799873017, 1013.4020927652721, 13452.0, 13577.321133943065, 14085.788713169515, 14479.565613031626, 14486.710265794414, 31057.378852422375, 31453.8427307862, 32129.35741285208, 32722.34555308833, 33280.1679958003, 42476.57523424726, 43344.78327608342, 44458.0, 44779.10441791081, 46602.766986164854, 8187.672493100447, 8277.048139463797, 8417.28453081495, 8442.53566053873, 8443.662253510036, 9841.901580984098, 9842.803143937224, 9885.406875587487, 9930.503474826086, 16143.67712645764, 10162.949185254027, 13943.790843137158, 14103.365348559135, 14120.364583593557, 14552.345144468312, 12758.68103297425, 12882.227066376048, 13237.47050118023, 13344.666383340495, 13577.32113394346, 12989.545365912149, 13755.449782008607, 14043.297835108408, 14126.43494260218, 14135.929320353333, 8463.153684631488, 8720.94468614046, 8790.692325768567, 8871.733847984571, 8952.955235223782, 13890.652733681738, 13947.093438926437, 13954.302284885918, 14120.78818817698, 14519.419223230952], "unit": "ms", "name": "jquery.html", "value": 7816.547963711144}, {"lowerIsBetter": false, "replicates": [1437.8418373978866, 1584.6117701163214, 1644.5230883043914, 1644.8272931342208, 1681.361082788541, 5877.147813567036, 6917.2391036985955, 7098.716051357939, 7105.218425973138, 7107.6090815005155, 6974.546654467456, 7130.465215108875, 7143.3570978611915, 7157.320054594818, 7160.534565253268, 2020.1717295908643, 2051.6717325227964, 2056.856020078588, 2059.1351632314463, 2060.8660437071617, 1956.5597740508415, 2007.9196832126697, 2018.4146597486786, 2024.068928292987, 2028.7666918304362, 1998.0808827939093, 2040.6938959156098, 2067.0904801887195, 2067.9379618611392, 2069.492974221318, 1975.4073777866654, 1985.6525108106168, 1987.2448469581539, 1993.990030049855, 1996.580718049204, 1989.5523507210908, 2005.177877070394, 2006.2576846566717, 2013.2852837242715, 2022.3023057045295, 6938.653067346663, 7008.053912721768, 7022.754203602901, 7025.82435439113, 7033.0, 4046.514418269797, 4110.876673699794, 4133.8966525836795, 4138.461999939988, 4143.8964025899295, 2718.4698983698186, 2748.6014527893344, 2765.6542932133484, 2773.0987429085426, 2795.3850152966315, 844.8310337932377, 851.6593362654926, 859.1837754133599, 860.6729442811754, 865.9567021648892, 9682.806343873153, 9692.73994380726, 9697.951510242403, 9707.369021013612, 9719.757006074904, 3765.4916586260506, 3766.8304926278383, 3824.0631045394057, 3854.5181852267906, 3870.5161854768153, 8297.751067467985, 8297.792555186048, 8306.127856575093, 8310.916890831135, 8316.293115085164, 4155.231282212801, 4155.958440415618, 4166.6250037496775, 4167.416561681367, 4187.413762073312, 3238.2713889374704, 3327.085051610826, 3659.1035196377056, 3804.771713697187, 3817.9045523862123, 3300.5544251526217, 3300.6864347886913, 3315.386653469068, 3342.6824451677053, 3415.79505229687, 1049.6483677967813, 1059.4279089291697, 1062.3480487841327, 1068.1188019883627, 1081.491698901515, 1173.9471723772451, 1175.9118066145074, 1178.6415858086764, 1189.6550000499758, 1201.0, 6517.055027021055, 6528.706208220641, 6537.313582073909, 6550.541462097703, 6608.2400523939405, 1022.8619136416637, 1038.9064984151462, 1056.2553399853084, 1059.4755595979884, 1063.112301228483, 5234.528892399702, 5248.8425347239645, 5257.132573125468, 5277.894442111136, 5280.023195708806, 8270.338372930151, 8640.827183456297, 8670.653173873101, 8674.696385626472, 8677.1756683115, 8536.317094632415, 8542.701005464778, 8547.529885856338, 8551.273141782895, 8589.226969572768, 6562.507811914125, 6623.503237257225, 6735.932640673531, 6760.560563563451, 6872.450203983669, 6421.871562568629, 6460.933945899062, 6461.933780926094, 6466.385693359123, 6466.482681385383, 7414.332710056121, 7681.61591920413, 7686.385089192963, 7737.220439298881, 7794.22057794216, 7719.922800772145, 7785.766427007199, 7794.181610930771, 7814.804629884298, 7928.127905930228, 5006.499350064964, 5079.898402032012, 5112.74436278192, 5836.620619659709, 5897.085951677497, 6214.1921550198185, 6281.59169653971, 6416.32628573993, 6417.101605775102, 6442.0, 5849.502792262705, 6101.115338276014, 6238.844028899314, 6305.211848518935, 6312.5581209314905, 6075.392460753889, 6163.106349579376, 6209.223847019122, 6250.406211409909, 6266.342034086538, 6402.839929001812, 6453.935460645521, 6456.838579035374, 6459.095726598186, 6466.256380516301, 5894.70526473666, 5917.556183286185, 5928.436798504135, 5929.555283353852, 5931.347551769388, 5546.667199968015, 5618.85952851182, 5660.320761508646, 5673.177389278614, 6045.486133678686], "unit": "ms", "name": "mootools.html", "value": 4039.0451609245924}, {"lowerIsBetter": false, "replicates": [252.60215161121232, 258.3296345982176, 259.7337728827952, 260.70540289472893, 261.6925112992234, 5265.526102650761, 5272.472752724726, 5296.62923595349, 5364.490373414529, 5366.356037275523, 5171.0692075426405, 5235.397929238139, 5243.370795504536, 5258.106121959267, 5262.421133675292, 4018.437418761383, 4019.2765302245584, 4021.919561608766, 4032.495938007749, 4039.7374170678813, 4023.4568333275074, 4027.174429242013, 4029.697772667047, 4034.2939985502567, 4035.031592417828, 3701.7408781385316, 3750.887473375803, 3875.2249550089955, 3980.3432433648413, 3986.043349596105, 3971.106501037272, 3974.344233201533, 3989.3816458448987, 4002.399640053986, 4006.0, 3435.7594968352223, 3436.742244331685, 3437.862485500577, 3440.17435815405, 3440.449528075496, 4878.926636140043, 4988.301637770715, 5019.573336266421, 5097.490250974873, 5100.183970564692, 4534.79593418297, 4535.185925629741, 4545.772711364419, 4546.613537849286, 4553.134904368193, 5532.28080349552, 5539.529140023103, 5546.251256080418, 5548.91676624851, 5551.0, 3708.8145592720525, 3709.0, 3711.684506816897, 3712.7586706863967, 3717.8141092945243, 5602.467765562265, 5820.476157145835, 5836.5914385993, 5837.532997360201, 5839.6204246724255, 3726.366517691945, 3759.49246851677, 3760.6615404613717, 3762.1347090169415, 3765.3975363941636, 3804.7336686431686, 3805.3911374179997, 3812.542494900574, 3818.3508803503473, 3821.732478726518, 4462.352958820953, 4465.285554311295, 4470.619997300201, 4470.731756094645, 4474.082813023322, 4889.266610008527, 5274.815381461631, 5329.546988505943, 5353.732313384316, 5355.062863998784, 1300.206873806977, 1327.7278157977785, 1329.2290471526492, 1329.454923481368, 1337.3981708231336, 846.4032856835915, 848.0840692052568, 848.4824257203101, 859.0421679827073, 864.0754392799644, 4762.285657151386, 4784.091022705675, 4787.593054590329, 4787.880302992453, 4789.616830653539, 5717.771289148471, 5719.656820590778, 5720.170575266563, 5723.599348045597, 5725.942740572541, 4753.0, 4772.76136193189, 4776.140294746979, 4782.808687652455, 4786.95213047865, 2561.385267535778, 2919.2701824543865, 2975.4644164050246, 2987.208389776711, 3060.5256185291314, 5299.311089558333, 5375.892482150335, 5388.434214407509, 5456.427075157131, 5476.890462190734, 5708.257926469532, 5734.426557344233, 5823.883522329615, 5914.526837852962, 5940.79207227745, 5460.044492213847, 5461.208124821958, 5461.781528738806, 5465.180222966586, 5466.590005749585, 5779.248697669276, 5812.73842677089, 5816.156657284755, 5817.185594016925, 5818.359980402237, 5496.7526461308535, 5647.181158732043, 5675.120356344773, 5677.574181936288, 5678.914816277676, 5491.066518691752, 5491.341039075336, 5495.725213739217, 5500.752466138953, 5502.862428439161, 3704.2221133562252, 3728.0, 3732.3654978653153, 3733.5706393765063, 3738.6448287412654, 5785.537157027512, 5789.073748200268, 5789.710514474175, 5802.593818432669, 5805.651660900359, 5447.264619276347, 5577.0, 5578.944210557843, 5587.3015873015875, 5589.692566908859, 5538.9169162461785, 5543.667379957215, 5547.916781248204, 5549.195366671729, 5569.860753481195, 5463.344398672026, 5472.589555783253, 5475.808346707846, 5477.096279113902, 5480.671159730429, 5394.757235924314, 5579.637323573955, 5581.665100094007, 5611.186377975252, 5621.718914054362, 5418.214358918013, 5439.836804895859, 5478.287822583039, 5478.780848766005, 5479.2602998594675], "unit": "ms", "name": "prototype.html", "value": 4062.619551751906}, {"lowerIsBetter": false, "replicates": [585.7217821534769, 640.1709785827353, 675.4933799650262, 703.5005146346094, 749.3555542233678, 12377.62867113987, 12450.19073760205, 12477.500899964014, 12479.812802807965, 12508.186967847083, 11786.116041296895, 11817.468213930373, 11843.881561184386, 11847.822282665746, 11855.881441185586, 620.6276234259453, 627.0218459203634, 786.4023342259895, 794.7695168401185, 799.436397339874, 794.4597673581962, 797.4736673795296, 802.3701394405393, 802.8153524689325, 804.3203493048364, 826.499967519651, 826.8635675113599, 827.0365024746163, 833.2542374574751, 833.5332213960202, 654.9377809108128, 662.7216569041015, 820.3642177312571, 832.4131487301438, 836.8786525953702, 621.6860485454862, 621.968901554925, 622.0420552349376, 622.3465361370588, 622.4864486798409, 12010.939945300217, 12012.819807702892, 12132.514699412013, 12161.087918406067, 12181.695457613541, 11032.44837758109, 11251.381174035425, 11269.718257043558, 11709.355985420798, 11719.941400292944, 9415.058494150599, 9430.434173949585, 9511.952440237754, 9559.235261179088, 9614.134727874525, 3239.7408207343356, 3265.0, 3274.279658475132, 3296.159479332755, 3300.47192449207, 38742.41886371707, 38810.02974925621, 39281.41077883834, 39611.40582891259, 39825.60174398248, 9179.541022948826, 9314.673986410444, 9360.90639093614, 9400.529973501298, 9521.333506654468, 15604.609884752745, 15604.609884752972, 15654.686906262039, 15663.765043524356, 15721.606959826096, 6088.634681919099, 6093.2078829751845, 6123.387661233841, 6232.0963460298, 6247.250329960434, 3505.9824700876334, 3535.5528359849454, 3547.9645203548152, 3560.287942411528, 3572.5534308211472, 2657.282533715886, 2678.7053424123333, 2678.8124831262016, 2687.8118531702985, 2688.9327766805986, 494.12293179606485, 494.8020791683355, 496.9478204788445, 497.2913598122661, 498.74813219324733, 462.8703962890329, 472.58648682402895, 487.82682147837716, 493.8024790083923, 561.2983770287141, 7035.401990830735, 7333.779986600411, 7430.405567554582, 7618.866907013658, 7827.217278272127, 506.9847904562869, 532.8907573947331, 592.8814237152586, 603.9547033972469, 608.4128815692877, 3468.4623883298127, 3567.250877315741, 3755.2301778135416, 3919.7256192066284, 3922.980385098056, 45477.54522454799, 46365.30452043222, 46378.30432543514, 46581.5341846584, 46870.53129468662, 42833.0, 43255.78372108119, 43259.351109733376, 43315.35026974598, 43445.56554434478, 38391.23217535634, 38986.61013389887, 39252.60747392547, 40732.59267407347, 42113.789431052646, 7456.51532650376, 7658.73194438192, 7744.690212391667, 7919.247671471201, 8070.83858322842, 30913.0, 31890.20274493156, 32711.182220443727, 33086.0, 33333.66666333305, 37309.4403583941, 37731.0, 37815.43276850905, 38476.0, 38493.42259866048, 10012.899871001197, 10050.547725352231, 10063.949680251551, 10085.546150423103, 10099.94950025245, 11359.48882300282, 11442.199046067028, 11476.885231147582, 11633.59282425111, 11645.126615503701, 10010.899891000996, 10128.797424051625, 10226.0, 10795.19036072282, 11143.777124457627, 10455.215858810467, 10551.208659350734, 10686.198535109743, 10943.890561094287, 10946.233763636788, 9736.9026309736, 9906.0, 10345.37927724339, 10501.0, 10752.83870741955, 8690.695825646071, 8929.821403572023, 9215.953920230357, 9464.0, 9485.0, 8688.826223475622, 8915.910840891507, 9192.95403522978, 9197.356185067249, 9216.447013179231], "unit": "ms", "name": "yui.html", "value": 5634.75104251146}], "name": "dromaeo_css", "value": 6177.08995403813}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 114.0, 107.0, 114.0, 114.0, 114.0, 105.0, 114.0, 111.0, 119.0], "unit": "ms", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 155.0, 175.0, 131.0, 152.0, 146.0, 129.0, 170.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 159.0, 161.0, 160.0, 161.0, 161.0, 163.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 79.0, 97.0, 71.0, 78.0, 70.0, 102.0, 87.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 133.0, 94.0, 95.0, 95.0, 136.0, 94.0, 94.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 74.0, 75.0, 73.0, 83.0, 73.0, 73.0, 75.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 74.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 70.0, 69.0, 70.0, 69.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 86.0, 85.0, 84.0, 93.0, 85.0, 86.0, 87.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [127.0, 122.0, 118.0, 118.0, 123.0, 120.0, 129.0, 133.0, 122.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [136.0, 151.0, 147.0, 149.0, 140.0, 138.0, 151.0, 158.0, 150.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.9}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 70.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1525.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.56291390728478], "unit": "score", "name": "Richards", "value": 213.2240799999999}, {"lowerIsBetter": false, "replicates": [186.35855385762207], "unit": "score", "name": "DeltaBlue", "value": 354.7891880000001}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1960.7843137254902], "unit": "score", "name": "RayTrace", "value": 377.39439}, {"lowerIsBetter": false, "replicates": [792.3930269413629], "unit": "score", "name": "Earley", "value": 841.0763060000003}, {"lowerIsBetter": false, "replicates": [11952.941176470587], "unit": "score", "name": "Boyer", "value": 55.75723917322837}, {"lowerIsBetter": false, "replicates": [27027.027027027027], "unit": "score", "name": "RegExp", "value": 33.70644499999999}, {"lowerIsBetter": false, "replicates": [651.7218973359325], "unit": "score", "name": "Splay", "value": 125.03953040877367}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19714.37040860343}]} 08:29:02 INFO - RETURN: dromaeo_css: 6177.09 08:29:02 INFO - RETURN: kraken: 1525.00 08:29:02 INFO - RETURN: v8_7: 19714.37 08:29:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19714.37"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1525.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6177.09"}}} 08:29:02 INFO - Return code: 0 08:29:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:29:02 ERROR - # TBPL SUCCESS # 08:29:02 INFO - Running post-action listener: _resource_record_post_action 08:29:02 INFO - Running post-run listener: _resource_record_post_run 08:29:03 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 10547200; Write bytes: 407756800; Read time: 2428; Write time: 301616 08:29:03 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 8327168; Read time: 0; Write time: 404 08:29:03 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8810496; Write bytes: 399429632; Read time: 2348; Write time: 301212 08:29:03 INFO - Running post-run listener: _upload_blobber_files 08:29:03 INFO - Blob upload gear active. 08:29:03 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:29:03 INFO - Copying logs to upload dir... 08:29:03 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1288.585316 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2015-12-09 08:29:03.168680) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 08:29:03.172021) ========= 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=edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009991 build_url: 'https://queue.taskcluster.net/v1/task/XBWxVkRjSaWwS9VpgkiKgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 08:29:03.223808) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 08:29:03.224159) ========= 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=edca6ca23558fe0608d91a4e00000196-1449675690.149221-84527271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 08:29:03.275202) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 08:29:03.275543) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 08:29:03.275865) ========= ========= Total master_lag: 0.23 =========