builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-029 starttime: 1447298795.47 results: success (0) buildid: 20151111171445 builduid: c8a30006877943a2bd30bd6d3c1e9b52 revision: eb938e57286dfc4021f6b83e10d51d9f94534134 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:35.473275) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:35.473740) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:35.474087) ========= 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=1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.003024 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:35.509881) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:35.510229) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:35.626623) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:35.626969) ========= 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=1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020965 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:35.695374) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:35.695893) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:35.696499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:35.696978) ========= 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=1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-11 19:26:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2015-11-11 19:26:35 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.322674 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:36.058654) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:36.059277) ========= 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=1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.148261 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:36.218926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:36.219376) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb938e57286dfc4021f6b83e10d51d9f94534134 --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 eb938e57286dfc4021f6b83e10d51d9f94534134 --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=1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-11 19:26:36,214 truncating revision to first 12 chars 2015-11-11 19:26:36,215 Setting DEBUG logging. 2015-11-11 19:26:36,215 attempt 1/10 2015-11-11 19:26:36,215 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb938e57286d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-11 19:26:36,457 unpacking tar archive at: fx-team-eb938e57286d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.521364 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:36.757232) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:36.757503) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:36.767410) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:36.767735) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 19:26:36.768215) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-11 19:26:36.768516) ========= /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=1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:26:36 INFO - MultiFileLogger online at 20151111 19:26:36 in /builds/slave/test 19:26:36 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 19:26:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:26:36 INFO - {'append_to_log': False, 19:26:36 INFO - 'base_work_dir': '/builds/slave/test', 19:26:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:26:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:26:36 INFO - 'branch': 'Fx-Team-Non-PGO', 19:26:36 INFO - 'buildbot_json_path': 'buildprops.json', 19:26:36 INFO - 'config_files': ('talos/linux_config.py',), 19:26:36 INFO - 'default_actions': ('clobber', 19:26:36 INFO - 'read-buildbot-config', 19:26:36 INFO - 'download-and-extract', 19:26:36 INFO - 'populate-webroot', 19:26:36 INFO - 'create-virtualenv', 19:26:36 INFO - 'install', 19:26:36 INFO - 'run-tests'), 19:26:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:26:36 INFO - 'download_minidump_stackwalk': True, 19:26:36 INFO - 'download_symbols': 'ondemand', 19:26:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:26:36 INFO - 'tooltool.py': '/tools/tooltool.py', 19:26:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:26:36 INFO - '/tools/misc-python/virtualenv.py')}, 19:26:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:26:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:26:36 INFO - 'installer_path': 'installer.exe', 19:26:36 INFO - 'log_level': 'info', 19:26:36 INFO - 'log_name': 'talos', 19:26:36 INFO - 'log_to_console': True, 19:26:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:26:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:26:36 INFO - 'opt_config_files': (), 19:26:36 INFO - 'pip_index': False, 19:26:36 INFO - 'sps_profile': False, 19:26:36 INFO - 'sps_profile_interval': 0, 19:26:36 INFO - 'suite': 'dromaeojs', 19:26:36 INFO - 'system_bits': '64', 19:26:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:26:36 INFO - 'title': 'talos-linux64-ix-029', 19:26:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:26:36 INFO - 'use_talos_json': True, 19:26:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:26:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:26:36 INFO - 'work_dir': 'build'} 19:26:36 INFO - ##### 19:26:36 INFO - ##### Running clobber step. 19:26:36 INFO - ##### 19:26:36 INFO - Running pre-action listener: _resource_record_pre_action 19:26:36 INFO - Running main action method: clobber 19:26:36 INFO - rmtree: /builds/slave/test/build 19:26:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:26:38 INFO - Running post-action listener: _resource_record_post_action 19:26:38 INFO - ##### 19:26:38 INFO - ##### Running read-buildbot-config step. 19:26:38 INFO - ##### 19:26:38 INFO - Running pre-action listener: _resource_record_pre_action 19:26:38 INFO - Running main action method: read_buildbot_config 19:26:38 INFO - Using buildbot properties: 19:26:38 INFO - { 19:26:38 INFO - "properties": { 19:26:38 INFO - "buildnumber": 2052, 19:26:38 INFO - "product": "firefox", 19:26:38 INFO - "script_repo_revision": "production", 19:26:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:26:38 INFO - "repository": "", 19:26:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:26:38 INFO - "buildid": "20151111171445", 19:26:38 INFO - "slavename": "talos-linux64-ix-029", 19:26:38 INFO - "pgo_build": "False", 19:26:38 INFO - "basedir": "/builds/slave/test", 19:26:38 INFO - "project": "", 19:26:38 INFO - "platform": "ubuntu64_hw", 19:26:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:26:38 INFO - "slavebuilddir": "test", 19:26:38 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:26:38 INFO - "branch": "fx-team", 19:26:38 INFO - "repo_path": "integration/fx-team", 19:26:38 INFO - "stage_platform": "linux64", 19:26:38 INFO - "builduid": "c8a30006877943a2bd30bd6d3c1e9b52", 19:26:38 INFO - "revision": "eb938e57286dfc4021f6b83e10d51d9f94534134" 19:26:38 INFO - }, 19:26:38 INFO - "sourcestamp": { 19:26:38 INFO - "repository": "", 19:26:38 INFO - "hasPatch": false, 19:26:38 INFO - "project": "", 19:26:38 INFO - "branch": "fx-team-linux64-talos", 19:26:38 INFO - "changes": [ 19:26:38 INFO - { 19:26:38 INFO - "category": null, 19:26:38 INFO - "files": [ 19:26:38 INFO - { 19:26:38 INFO - "url": null, 19:26:38 INFO - "name": "https://queue.taskcluster.net/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 19:26:38 INFO - } 19:26:38 INFO - ], 19:26:38 INFO - "repository": "", 19:26:38 INFO - "rev": "eb938e57286dfc4021f6b83e10d51d9f94534134", 19:26:38 INFO - "who": "kwierso@gmail.com", 19:26:38 INFO - "when": 1447298760, 19:26:38 INFO - "number": 6651846, 19:26:38 INFO - "comments": "Merge m-c to fx-team, a=merge", 19:26:38 INFO - "project": "", 19:26:38 INFO - "at": "Wed 11 Nov 2015 19:26:00", 19:26:38 INFO - "branch": "fx-team-linux64-talos", 19:26:38 INFO - "revlink": "", 19:26:38 INFO - "properties": [ 19:26:38 INFO - [ 19:26:38 INFO - "buildid", 19:26:38 INFO - "20151111171445", 19:26:38 INFO - "Change" 19:26:38 INFO - ], 19:26:38 INFO - [ 19:26:38 INFO - "builduid", 19:26:38 INFO - "c8a30006877943a2bd30bd6d3c1e9b52", 19:26:38 INFO - "Change" 19:26:38 INFO - ], 19:26:38 INFO - [ 19:26:38 INFO - "pgo_build", 19:26:38 INFO - "False", 19:26:38 INFO - "Change" 19:26:38 INFO - ] 19:26:38 INFO - ], 19:26:38 INFO - "revision": "eb938e57286dfc4021f6b83e10d51d9f94534134" 19:26:38 INFO - } 19:26:38 INFO - ], 19:26:38 INFO - "revision": "eb938e57286dfc4021f6b83e10d51d9f94534134" 19:26:38 INFO - } 19:26:38 INFO - } 19:26:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 19:26:38 INFO - Running post-action listener: _resource_record_post_action 19:26:38 INFO - ##### 19:26:38 INFO - ##### Running download-and-extract step. 19:26:38 INFO - ##### 19:26:38 INFO - Running pre-action listener: _resource_record_pre_action 19:26:38 INFO - Running main action method: download_and_extract 19:26:38 INFO - mkdir: /builds/slave/test/build/tests 19:26:38 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')]} 19:26:38 INFO - https://queue.taskcluster.net/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:26:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/test_packages.json 19:26:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/test_packages.json 19:26:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:26:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:26:45 INFO - Downloaded 1302 bytes. 19:26:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:26:46 INFO - Using the following test package requirements: 19:26:46 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:26:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:26:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:26:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:26:46 INFO - u'jsshell-linux-x86_64.zip'], 19:26:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:26:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:26:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:26:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:26:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:26:46 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:26:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:26:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:26:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:26:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:26:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:26:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:26:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:46 INFO - https://queue.taskcluster.net/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:26:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:26:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:26:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/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 19:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/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 19:26:47 INFO - Downloaded 21251544 bytes. 19:26:47 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 19:26:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:26:47 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 19:26:48 INFO - Return code: 0 19:26:48 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 19:26:48 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')]} 19:26:48 INFO - https://queue.taskcluster.net/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:26:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:26:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:26:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/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 19:26:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/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 19:26:58 INFO - Downloaded 21251544 bytes. 19:26:58 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 19:26:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:26:58 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 19:26:59 INFO - Return code: 0 19:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:59 INFO - https://queue.taskcluster.net/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:26:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:26:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:26:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/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 19:26:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/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 19:27:00 INFO - Downloaded 11131693 bytes. 19:27:00 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 19:27:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:27:00 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 19:27:00 INFO - Return code: 0 19:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:00 INFO - https://queue.taskcluster.net/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:27:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:27:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:27:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/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 19:27:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/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 19:27:01 INFO - Downloaded 55649502 bytes. 19:27:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:27:01 INFO - mkdir: /builds/slave/test/properties 19:27:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:27:01 INFO - Writing to file /builds/slave/test/properties/build_url 19:27:01 INFO - Contents: 19:27:01 INFO - build_url:https://queue.taskcluster.net/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:27:01 INFO - Running post-action listener: _resource_record_post_action 19:27:01 INFO - Running post-action listener: set_extra_try_arguments 19:27:01 INFO - ##### 19:27:01 INFO - ##### Running populate-webroot step. 19:27:01 INFO - ##### 19:27:01 INFO - Running pre-action listener: _resource_record_pre_action 19:27:01 INFO - Running main action method: populate_webroot 19:27:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:27:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:27:01 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:27:01 INFO - '../fennec_ids.txt'], 19:27:01 INFO - 'tests': ['tcheck2']}, 19:27:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:27:01 INFO - '--tppagecycles', 19:27:01 INFO - '7'], 19:27:01 INFO - 'tests': ['tsvgm']}}, 19:27:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:27:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:27:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:27:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:27:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:27:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:27:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:01 INFO - 'talos_options': ['--e10s'], 19:27:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:01 INFO - 'tests': ['damp', 'tps']}, 19:27:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:01 INFO - 'talos_options': ['--e10s'], 19:27:01 INFO - 'tests': ['damp', 'tps']}, 19:27:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:27:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:27:01 INFO - 'other': {'tests': ['a11yr', 19:27:01 INFO - 'ts_paint', 19:27:01 INFO - 'tpaint', 19:27:01 INFO - 'sessionrestore', 19:27:01 INFO - 'sessionrestore_no_auto_restore']}, 19:27:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:27:01 INFO - 'tests': ['a11yr', 19:27:01 INFO - 'ts_paint', 19:27:01 INFO - 'tpaint', 19:27:01 INFO - 'sessionrestore', 19:27:01 INFO - 'sessionrestore_no_auto_restore']}, 19:27:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:27:01 INFO - 'tests': ['a11yr', 19:27:01 INFO - 'ts_paint', 19:27:01 INFO - 'tpaint', 19:27:01 INFO - 'sessionrestore', 19:27:01 INFO - 'sessionrestore_no_auto_restore']}, 19:27:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:27:01 INFO - 'tests': ['a11yr', 19:27:01 INFO - 'ts_paint', 19:27:01 INFO - 'tpaint', 19:27:01 INFO - 'sessionrestore', 19:27:01 INFO - 'sessionrestore_no_auto_restore']}, 19:27:01 INFO - 'other_l64': {'tests': ['a11yr', 19:27:01 INFO - 'ts_paint', 19:27:01 INFO - 'tpaint', 19:27:01 INFO - 'sessionrestore', 19:27:01 INFO - 'sessionrestore_no_auto_restore']}, 19:27:01 INFO - 'other_nol64': {'tests': ['a11yr', 19:27:01 INFO - 'ts_paint', 19:27:01 INFO - 'tpaint', 19:27:01 INFO - 'sessionrestore', 19:27:01 INFO - 'sessionrestore_no_auto_restore']}, 19:27:01 INFO - 'svgr': {'tests': ['tsvgx', 19:27:01 INFO - 'tsvgr_opacity', 19:27:01 INFO - 'tart', 19:27:01 INFO - 'tscrollx', 19:27:01 INFO - 'cart']}, 19:27:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:27:01 INFO - 'tests': ['tsvgx', 19:27:01 INFO - 'tsvgr_opacity', 19:27:01 INFO - 'tart', 19:27:01 INFO - 'tscrollx', 19:27:01 INFO - 'cart']}, 19:27:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:01 INFO - 'tests': ['tp5o']}, 19:27:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:01 INFO - 'talos_options': ['--e10s'], 19:27:01 INFO - 'tests': ['tp5o']}, 19:27:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:01 INFO - 'talos_options': ['--xperf_path', 19:27:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:01 INFO - 'tests': ['tp5n']}, 19:27:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:01 INFO - 'talos_options': ['--e10s', 19:27:01 INFO - '--xperf_path', 19:27:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:01 INFO - 'tests': ['tp5n']}}, 19:27:01 INFO - 'talos.zip': {'path': '', 19:27:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:27:01 INFO - Running post-action listener: _resource_record_post_action 19:27:01 INFO - ##### 19:27:01 INFO - ##### Running create-virtualenv step. 19:27:01 INFO - ##### 19:27:01 INFO - Running pre-action listener: _resource_record_pre_action 19:27:01 INFO - Running main action method: create_virtualenv 19:27:01 INFO - Creating virtualenv /builds/slave/test/build/venv 19:27:01 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 19:27:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:27:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:27:02 INFO - Using real prefix '/usr' 19:27:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:27:03 INFO - Installing distribute.............................................................................................................................................................................................done. 19:27:05 INFO - Installing pip.................done. 19:27:05 INFO - Return code: 0 19:27:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:05 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 0x7f5c92eacc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f166c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2056ac0>, '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 0x20579a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2057e50>, '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': '1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866', '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 19:27:05 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 19:27:05 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 19:27:05 INFO - Using env: {'DISPLAY': ':0', 19:27:05 INFO - 'HOME': '/home/cltbld', 19:27:05 INFO - 'LANG': 'en_US.UTF-8', 19:27:05 INFO - 'LANGUAGE': 'en_US:en', 19:27:05 INFO - 'LOGNAME': 'cltbld', 19:27:05 INFO - 'MAIL': '/var/mail/cltbld', 19:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:05 INFO - 'MOZ_NO_REMOTE': '1', 19:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:05 INFO - 'NO_EM_RESTART': '1', 19:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:05 INFO - 'PWD': '/builds/slave/test', 19:27:05 INFO - 'SHELL': '/bin/bash', 19:27:05 INFO - 'SHLVL': '1', 19:27:05 INFO - 'TERM': 'linux', 19:27:05 INFO - 'TMOUT': '86400', 19:27:05 INFO - 'USER': 'cltbld', 19:27:05 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866', 19:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:05 INFO - '_': '/tools/buildbot/bin/python'} 19:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:05 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 19:27:05 INFO - Cleaning up... 19:27:05 INFO - Return code: 0 19:27:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:05 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 0x7f5c92eacc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f166c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2056ac0>, '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 0x20579a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2057e50>, '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': '1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866', '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 19:27:05 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 19:27:05 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 19:27:05 INFO - Using env: {'DISPLAY': ':0', 19:27:05 INFO - 'HOME': '/home/cltbld', 19:27:05 INFO - 'LANG': 'en_US.UTF-8', 19:27:05 INFO - 'LANGUAGE': 'en_US:en', 19:27:05 INFO - 'LOGNAME': 'cltbld', 19:27:05 INFO - 'MAIL': '/var/mail/cltbld', 19:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:05 INFO - 'MOZ_NO_REMOTE': '1', 19:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:05 INFO - 'NO_EM_RESTART': '1', 19:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:05 INFO - 'PWD': '/builds/slave/test', 19:27:05 INFO - 'SHELL': '/bin/bash', 19:27:05 INFO - 'SHLVL': '1', 19:27:05 INFO - 'TERM': 'linux', 19:27:05 INFO - 'TMOUT': '86400', 19:27:05 INFO - 'USER': 'cltbld', 19:27:05 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866', 19:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:05 INFO - '_': '/tools/buildbot/bin/python'} 19:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:06 INFO - Downloading/unpacking psutil>=0.7.1 19:27:06 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 19:27:06 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 19:27:06 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 19:27:06 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 19:27:06 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 19:27:06 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 19:27:07 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:27:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:27:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:07 INFO - Installing collected packages: psutil 19:27:07 INFO - Running setup.py install for psutil 19:27:07 INFO - building 'psutil._psutil_linux' extension 19:27:07 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 19:27: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 19:27:09 INFO - building 'psutil._psutil_posix' extension 19:27: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 19:27: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 19:27:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:09 INFO - Successfully installed psutil 19:27:09 INFO - Cleaning up... 19:27:09 INFO - Return code: 0 19:27:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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 0x7f5c92eacc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f166c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2056ac0>, '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 0x20579a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2057e50>, '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': '1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866', '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 19:27: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 19:27: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 19:27:09 INFO - Using env: {'DISPLAY': ':0', 19:27:09 INFO - 'HOME': '/home/cltbld', 19:27:09 INFO - 'LANG': 'en_US.UTF-8', 19:27:09 INFO - 'LANGUAGE': 'en_US:en', 19:27:09 INFO - 'LOGNAME': 'cltbld', 19:27:09 INFO - 'MAIL': '/var/mail/cltbld', 19:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:09 INFO - 'MOZ_NO_REMOTE': '1', 19:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:09 INFO - 'NO_EM_RESTART': '1', 19:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:09 INFO - 'PWD': '/builds/slave/test', 19:27:09 INFO - 'SHELL': '/bin/bash', 19:27:09 INFO - 'SHLVL': '1', 19:27:09 INFO - 'TERM': 'linux', 19:27:09 INFO - 'TMOUT': '86400', 19:27:09 INFO - 'USER': 'cltbld', 19:27:09 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866', 19:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:09 INFO - '_': '/tools/buildbot/bin/python'} 19:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:27:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:27: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) 19:27:11 INFO - Installing collected packages: mozsystemmonitor 19:27:11 INFO - Running setup.py install for mozsystemmonitor 19:27:11 INFO - Successfully installed mozsystemmonitor 19:27:11 INFO - Cleaning up... 19:27:11 INFO - Return code: 0 19:27:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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 0x7f5c92eacc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f166c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2056ac0>, '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 0x20579a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2057e50>, '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': '1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866', '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 19:27: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 19:27: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 19:27:11 INFO - Using env: {'DISPLAY': ':0', 19:27:11 INFO - 'HOME': '/home/cltbld', 19:27:11 INFO - 'LANG': 'en_US.UTF-8', 19:27:11 INFO - 'LANGUAGE': 'en_US:en', 19:27:11 INFO - 'LOGNAME': 'cltbld', 19:27:11 INFO - 'MAIL': '/var/mail/cltbld', 19:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:11 INFO - 'MOZ_NO_REMOTE': '1', 19:27:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:11 INFO - 'NO_EM_RESTART': '1', 19:27:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:11 INFO - 'PWD': '/builds/slave/test', 19:27:11 INFO - 'SHELL': '/bin/bash', 19:27:11 INFO - 'SHLVL': '1', 19:27:11 INFO - 'TERM': 'linux', 19:27:11 INFO - 'TMOUT': '86400', 19:27:11 INFO - 'USER': 'cltbld', 19:27:11 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866', 19:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:11 INFO - '_': '/tools/buildbot/bin/python'} 19:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:11 INFO - Downloading/unpacking blobuploader==1.2.4 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:13 INFO - Downloading blobuploader-1.2.4.tar.gz 19:27:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:27:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:27:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:13 INFO - Downloading docopt-0.6.1.tar.gz 19:27:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:27:14 INFO - Installing collected packages: blobuploader, requests, docopt 19:27:14 INFO - Running setup.py install for blobuploader 19:27:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:27:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:27:14 INFO - Running setup.py install for requests 19:27:14 INFO - Running setup.py install for docopt 19:27:14 INFO - Successfully installed blobuploader requests docopt 19:27:14 INFO - Cleaning up... 19:27:14 INFO - Return code: 0 19:27:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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 0x7f5c92eacc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f166c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2056ac0>, '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 0x20579a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2057e50>, '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': '1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866', '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 19:27: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 19:27: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 19:27:14 INFO - Using env: {'DISPLAY': ':0', 19:27:14 INFO - 'HOME': '/home/cltbld', 19:27:14 INFO - 'LANG': 'en_US.UTF-8', 19:27:14 INFO - 'LANGUAGE': 'en_US:en', 19:27:14 INFO - 'LOGNAME': 'cltbld', 19:27:14 INFO - 'MAIL': '/var/mail/cltbld', 19:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:14 INFO - 'MOZ_NO_REMOTE': '1', 19:27:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:14 INFO - 'NO_EM_RESTART': '1', 19:27:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:14 INFO - 'PWD': '/builds/slave/test', 19:27:14 INFO - 'SHELL': '/bin/bash', 19:27:14 INFO - 'SHLVL': '1', 19:27:14 INFO - 'TERM': 'linux', 19:27:14 INFO - 'TMOUT': '86400', 19:27:14 INFO - 'USER': 'cltbld', 19:27:14 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866', 19:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:14 INFO - '_': '/tools/buildbot/bin/python'} 19:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:14 INFO - Running setup.py (path:/tmp/pip-iDEdE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:14 INFO - Running setup.py (path:/tmp/pip-GosE_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:15 INFO - Running setup.py (path:/tmp/pip-d_9XED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:15 INFO - Running setup.py (path:/tmp/pip-AHfg2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:15 INFO - Running setup.py (path:/tmp/pip-yI_U7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:15 INFO - Running setup.py (path:/tmp/pip-sCQNal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:15 INFO - Running setup.py (path:/tmp/pip-aFW2DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:15 INFO - Running setup.py (path:/tmp/pip-r1LMHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:15 INFO - Running setup.py (path:/tmp/pip-5lk3yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:15 INFO - Running setup.py (path:/tmp/pip-33gwJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:15 INFO - Running setup.py (path:/tmp/pip-c0dK_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:15 INFO - Running setup.py (path:/tmp/pip-t8za4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:15 INFO - Running setup.py (path:/tmp/pip-2F2STC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:15 INFO - Running setup.py (path:/tmp/pip-jj2Uap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:15 INFO - Running setup.py (path:/tmp/pip-Odd6Vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:15 INFO - Running setup.py (path:/tmp/pip-kBkYfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:16 INFO - Running setup.py (path:/tmp/pip-dltc9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:27:16 INFO - Running setup.py install for manifestparser 19:27:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:27:16 INFO - Running setup.py install for mozcrash 19:27:16 INFO - Running setup.py install for mozdebug 19:27:16 INFO - Running setup.py install for mozdevice 19:27:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:27:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:27:16 INFO - Running setup.py install for mozfile 19:27:16 INFO - Running setup.py install for mozhttpd 19:27:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:27:16 INFO - Running setup.py install for mozinfo 19:27:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:27:16 INFO - Running setup.py install for mozInstall 19:27:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:27:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:27:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:27:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:27:16 INFO - Running setup.py install for mozleak 19:27:16 INFO - Running setup.py install for mozlog 19:27:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:27:17 INFO - Running setup.py install for moznetwork 19:27:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:27:17 INFO - Running setup.py install for mozprocess 19:27:17 INFO - Running setup.py install for mozprofile 19:27:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:27:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:27:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:27:17 INFO - Running setup.py install for mozrunner 19:27:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:27:17 INFO - Running setup.py install for mozscreenshot 19:27:17 INFO - Running setup.py install for moztest 19:27:17 INFO - Running setup.py install for mozversion 19:27:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:27:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:27:17 INFO - Cleaning up... 19:27:17 INFO - Return code: 0 19:27:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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 0x7f5c92eacc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f166c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2056ac0>, '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 0x20579a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2057e50>, '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': '1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866', '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 19:27: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 19:27: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 19:27:17 INFO - Using env: {'DISPLAY': ':0', 19:27:17 INFO - 'HOME': '/home/cltbld', 19:27:17 INFO - 'LANG': 'en_US.UTF-8', 19:27:17 INFO - 'LANGUAGE': 'en_US:en', 19:27:17 INFO - 'LOGNAME': 'cltbld', 19:27:17 INFO - 'MAIL': '/var/mail/cltbld', 19:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:17 INFO - 'MOZ_NO_REMOTE': '1', 19:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:17 INFO - 'NO_EM_RESTART': '1', 19:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:17 INFO - 'PWD': '/builds/slave/test', 19:27:17 INFO - 'SHELL': '/bin/bash', 19:27:17 INFO - 'SHLVL': '1', 19:27:17 INFO - 'TERM': 'linux', 19:27:17 INFO - 'TMOUT': '86400', 19:27:17 INFO - 'USER': 'cltbld', 19:27:17 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866', 19:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:17 INFO - '_': '/tools/buildbot/bin/python'} 19:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:18 INFO - Running setup.py (path:/tmp/pip-C4pv1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27: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)) 19:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:18 INFO - Running setup.py (path:/tmp/pip-I2RgBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27: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)) 19:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:18 INFO - Running setup.py (path:/tmp/pip-Ftq8B8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27: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)) 19:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:18 INFO - Running setup.py (path:/tmp/pip-kQ0IGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27: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)) 19:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:18 INFO - Running setup.py (path:/tmp/pip-cmH1mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27: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)) 19:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:18 INFO - Running setup.py (path:/tmp/pip-ZcShqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27: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)) 19:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:18 INFO - Running setup.py (path:/tmp/pip-6hx2Uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27: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)) 19:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:18 INFO - Running setup.py (path:/tmp/pip-bus2Bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27: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)) 19:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:18 INFO - Running setup.py (path:/tmp/pip-mnZ_cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27: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)) 19:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:18 INFO - Running setup.py (path:/tmp/pip-mwa3iO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 19:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:18 INFO - Running setup.py (path:/tmp/pip-T8Jhzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27: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)) 19:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:18 INFO - Running setup.py (path:/tmp/pip-okqpMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27: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)) 19:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:18 INFO - Running setup.py (path:/tmp/pip-oYaTQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27: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)) 19:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:19 INFO - Running setup.py (path:/tmp/pip-hkU7Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27: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)) 19:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:19 INFO - Running setup.py (path:/tmp/pip-y8aq3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27: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)) 19:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:19 INFO - Running setup.py (path:/tmp/pip-EtUjrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27: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)) 19:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:19 INFO - Running setup.py (path:/tmp/pip-cB_0L9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27: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)) 19:27: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)) 19:27: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)) 19:27: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)) 19:27: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)) 19:27: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)) 19:27:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:20 INFO - Downloading blessings-1.5.1.tar.gz 19:27:20 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 19:27:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:27:21 INFO - Installing collected packages: blessings 19:27:21 INFO - Running setup.py install for blessings 19:27:21 INFO - Successfully installed blessings 19:27:21 INFO - Cleaning up... 19:27:21 INFO - Return code: 0 19:27:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:27:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:21 INFO - Reading from file tmpfile_stdout 19:27:21 INFO - Current package versions: 19:27:21 INFO - argparse == 1.2.1 19:27:21 INFO - blessings == 1.5.1 19:27:21 INFO - blobuploader == 1.2.4 19:27:21 INFO - docopt == 0.6.1 19:27:21 INFO - manifestparser == 1.1 19:27:21 INFO - mozInstall == 1.12 19:27:21 INFO - mozcrash == 0.16 19:27:21 INFO - mozdebug == 0.1 19:27:21 INFO - mozdevice == 0.47 19:27:21 INFO - mozfile == 1.2 19:27:21 INFO - mozhttpd == 0.7 19:27:21 INFO - mozinfo == 0.9 19:27:21 INFO - mozleak == 0.1 19:27:21 INFO - mozlog == 3.0 19:27:21 INFO - moznetwork == 0.27 19:27:21 INFO - mozprocess == 0.22 19:27:21 INFO - mozprofile == 0.27 19:27:21 INFO - mozrunner == 6.11 19:27:21 INFO - mozscreenshot == 0.1 19:27:21 INFO - mozsystemmonitor == 0.0 19:27:21 INFO - moztest == 0.7 19:27:21 INFO - mozversion == 1.4 19:27:21 INFO - psutil == 3.1.1 19:27:21 INFO - requests == 1.2.3 19:27:21 INFO - wsgiref == 0.1.2 19:27:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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 0x7f5c92eacc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f166c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2056ac0>, '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 0x20579a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2057e50>, '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': '1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866', '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 19:27: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 19:27: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 19:27:21 INFO - Using env: {'DISPLAY': ':0', 19:27:21 INFO - 'HOME': '/home/cltbld', 19:27:21 INFO - 'LANG': 'en_US.UTF-8', 19:27:21 INFO - 'LANGUAGE': 'en_US:en', 19:27:21 INFO - 'LOGNAME': 'cltbld', 19:27:21 INFO - 'MAIL': '/var/mail/cltbld', 19:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:21 INFO - 'MOZ_NO_REMOTE': '1', 19:27:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:21 INFO - 'NO_EM_RESTART': '1', 19:27:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:21 INFO - 'PWD': '/builds/slave/test', 19:27:21 INFO - 'SHELL': '/bin/bash', 19:27:21 INFO - 'SHLVL': '1', 19:27:21 INFO - 'TERM': 'linux', 19:27:21 INFO - 'TMOUT': '86400', 19:27:21 INFO - 'USER': 'cltbld', 19:27:21 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866', 19:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:21 INFO - '_': '/tools/buildbot/bin/python'} 19:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27: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)) 19:27: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)) 19:27: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)) 19:27: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)) 19:27: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)) 19:27: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)) 19:27: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)) 19:27: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)) 19:27: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)) 19:27: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)) 19:27: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)) 19:27:21 INFO - Cleaning up... 19:27:21 INFO - Return code: 0 19:27:21 INFO - Running post-action listener: _resource_record_post_action 19:27:21 INFO - Running post-action listener: _start_resource_monitoring 19:27:21 INFO - Starting resource monitoring. 19:27:21 INFO - ##### 19:27:21 INFO - ##### Running install step. 19:27:21 INFO - ##### 19:27:21 INFO - Running pre-action listener: _resource_record_pre_action 19:27:21 INFO - Running main action method: install 19:27:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:21 INFO - Reading from file tmpfile_stdout 19:27:21 INFO - Detecting whether we're running mozinstall >=1.0... 19:27:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:27:21 INFO - Reading from file tmpfile_stdout 19:27:21 INFO - Output received: 19:27:21 INFO - Usage: mozinstall [options] installer 19:27:21 INFO - Options: 19:27:21 INFO - -h, --help show this help message and exit 19:27:21 INFO - -d DEST, --destination=DEST 19:27:21 INFO - Directory to install application into. [default: 19:27:21 INFO - "/builds/slave/test"] 19:27:21 INFO - --app=APP Application being installed. [default: firefox] 19:27:21 INFO - mkdir: /builds/slave/test/build/application 19:27:21 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'] 19:27:21 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 19:27:36 INFO - Reading from file tmpfile_stdout 19:27:36 INFO - Output received: 19:27:36 INFO - /builds/slave/test/build/application/firefox/firefox 19:27:36 INFO - Running post-action listener: _resource_record_post_action 19:27:36 INFO - ##### 19:27:36 INFO - ##### Running run-tests step. 19:27:36 INFO - ##### 19:27:36 INFO - Running pre-action listener: _resource_record_pre_action 19:27:36 INFO - Running main action method: run_tests 19:27:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:27:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:27:36 INFO - Python 2.7.3 19:27:36 INFO - Return code: 0 19:27:36 INFO - grabbing minidump binary from tooltool 19:27: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')]} 19:27:36 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 0x2056ac0>, '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 0x20579a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2057e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:27:36 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 19:27:36 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 19:27:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:27:36 INFO - Return code: 0 19:27:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:27:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:27:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:27:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:27:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:27:36 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/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] in /builds/slave/test/build 19:27:36 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/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost 19:27:36 INFO - Using env: {'DISPLAY': ':0', 19:27:36 INFO - 'HOME': '/home/cltbld', 19:27:36 INFO - 'LANG': 'en_US.UTF-8', 19:27:36 INFO - 'LANGUAGE': 'en_US:en', 19:27:36 INFO - 'LOGNAME': 'cltbld', 19:27:36 INFO - 'MAIL': '/var/mail/cltbld', 19:27:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:27:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:36 INFO - 'MOZ_NO_REMOTE': '1', 19:27:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:27:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:36 INFO - 'NO_EM_RESTART': '1', 19:27:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:36 INFO - 'PWD': '/builds/slave/test', 19:27:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:27:36 INFO - 'SHELL': '/bin/bash', 19:27:36 INFO - 'SHLVL': '1', 19:27:36 INFO - 'TERM': 'linux', 19:27:36 INFO - 'TMOUT': '86400', 19:27:36 INFO - 'USER': 'cltbld', 19:27:36 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866', 19:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:36 INFO - '_': '/tools/buildbot/bin/python'} 19:27:36 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/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] with output_timeout 3600 19:27:36 INFO - mozversion INFO | application_buildid: 20151111171445 19:27:36 INFO - mozversion INFO | application_changeset: eb938e57286dfc4021f6b83e10d51d9f94534134 19:27:36 INFO - mozversion INFO | application_display_name: Nightly 19:27:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:27:36 INFO - mozversion INFO | application_name: Firefox 19:27:36 INFO - mozversion INFO | application_remotingname: firefox 19:27:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:27:36 INFO - mozversion INFO | application_vendor: Mozilla 19:27:36 INFO - mozversion INFO | application_version: 45.0a1 19:27:36 INFO - mozversion INFO | platform_buildid: 20151111171445 19:27:36 INFO - mozversion INFO | platform_changeset: eb938e57286dfc4021f6b83e10d51d9f94534134 19:27:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:27:36 INFO - mozversion INFO | platform_version: 45.0a1 19:27:36 INFO - 2015-11-11 19:27:36,380 DEBUG : using testdate: 1447298856 19:27:36 INFO - 2015-11-11 19:27:36,380 DEBUG : actual date: 1447298856 19:27:36 INFO - 2015-11-11 19:27:36,428 INFO : starting webserver on 'localhost:60966' 19:27:36 INFO - 2015-11-11 19:27:36,429 INFO : Starting test suite talos-linux64-ix-029 19:27:36 INFO - 2015-11-11 19:27:36,429 INFO : Starting test dromaeo_css 19:27:36 INFO - 2015-11-11 19:27:36,429 DEBUG : operating with platform_type : linux_ 19:27:36 INFO - 2015-11-11 19:27:36,430 INFO : Initialising browser for dromaeo_css test... 19:27:36 INFO - 2015-11-11 19:27:36,456 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcepuR4/profile http://localhost:60966/getInfo.html 19:27:43 INFO - 2015-11-11 19:27:43,096 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:27:43 INFO - 2015-11-11 19:27:43,096 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:27:43 INFO - 2015-11-11 19:27:43,096 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:27:43 INFO - 2015-11-11 19:27:43,096 DEBUG : BROWSER_OUTPUT: __metrics 19:27:43 INFO - 2015-11-11 19:27:43,177 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:27:44 INFO - 2015-11-11 19:27:44,525 INFO : Browser initialized. 19:27:44 INFO - 2015-11-11 19:27:44,526 INFO : Running cycle 1/1 for dromaeo_css test... 19:27:44 INFO - 2015-11-11 19:27:44,526 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcepuR4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:27:56 INFO - 2015-11-11 19:27:56,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 139587584 19:27:56 INFO - 2015-11-11 19:27:56,353 DEBUG : BROWSER_OUTPUT: 19:28:48 INFO - 2015-11-11 19:28:48,057 DEBUG : BROWSER_OUTPUT: 1447298928054 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] 19:31:00 INFO - 2015-11-11 19:31:00,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60966/tests/dromaeo/cssquery-ext.html) 19:31:01 INFO - 2015-11-11 19:31:01,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 254140416 19:31:01 INFO - 2015-11-11 19:31:01,426 DEBUG : BROWSER_OUTPUT: 19:34:03 INFO - 2015-11-11 19:34:03,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/dromaeo/cssquery-ext.html (next: http://localhost:60966/tests/dromaeo/cssquery-jquery.html) 19:34:04 INFO - 2015-11-11 19:34:04,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 215891968 19:34:04 INFO - 2015-11-11 19:34:04,498 DEBUG : BROWSER_OUTPUT: 19:37:06 INFO - 2015-11-11 19:37:06,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60966/tests/dromaeo/cssquery-mootools.html) 19:37:07 INFO - 2015-11-11 19:37:07,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 208633856 19:37:07 INFO - 2015-11-11 19:37:07,028 DEBUG : BROWSER_OUTPUT: 19:40:08 INFO - 2015-11-11 19:40:08,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60966/tests/dromaeo/cssquery-prototype.html) 19:40:09 INFO - 2015-11-11 19:40:09,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 198447104 19:40:09 INFO - 2015-11-11 19:40:09,558 DEBUG : BROWSER_OUTPUT: 19:43:12 INFO - 2015-11-11 19:43:12,077 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60966/tests/dromaeo/cssquery-yui.html) 19:43:12 INFO - 2015-11-11 19:43:12,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 200970240 19:43:12 INFO - 2015-11-11 19:43:12,679 DEBUG : BROWSER_OUTPUT: 19:46:14 INFO - 2015-11-11 19:46:14,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/dromaeo/cssquery-yui.html (next: http://localhost:60966/tests/dromaeo/cssquery-dojo.html) 19:46:15 INFO - 2015-11-11 19:46:15,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 247484416 19:46:15 INFO - 2015-11-11 19:46:15,228 DEBUG : BROWSER_OUTPUT: 19:46:15 INFO - 2015-11-11 19:46:15,232 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:46:15 INFO - 2015-11-11 19:46:15,232 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:46:15 INFO - 2015-11-11 19:46:15,232 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:46:15 INFO - 2015-11-11 19:46:15,232 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:46:15 INFO - 2015-11-11 19:46:15,233 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2672.933176670583;2784.3595972926228;2787.317107308707;2801.6918139004706;2804.5232310507226;4685.180093483644;4773.284007398892;4820.710757354557;4895.388076490439;4907.0185962807445;4668.299755036746;4685.297205419189;4724.669273150872;4757.452892917316;4876.926846097312;4357.738535687861;4445.51099379068;4452.154090722768;4454.665900057493;4513.661475389343;4287.442632457776;4527.52460991596;4540.704854184468;4574.679772415916;4574.679772415932;4340.305551111807;4409.4488188976375;4428.689991700582;4431.224535706271;4458.8439404620685;4399.64802815774;4410.625096866738;4411.492678342;4419.712718673276;4472.9776351118035;4301.634361079312;4376.277914144194;4387.1883701515;4400.7579583122915;4428.3800267962515;4722.905541889143;4825.131476334259;4826.01066781309;4848.345473361122;4872.098661747588;5187.870303242411;5206.219067139921;5209.218617207412;5212.8957420851375;5249.028929648028;4944.33251511045;5050.267711181858;5052.873678158038;5210;5220.660657057279;4617.5151609080895;4675.08835777027;4690.343351930733;4694.577488026094;4717.43390793107;5304.151335786256;5305.098133317345;5315.521603055744;5337.893242135136;5356.812511562077;4856.660033797601;4985.027919555652;4986.850394488171;5062.848114556569;5100;4968.826091086795;5059.772310246048;5065.797368105308;5070.923936140961;5109.795608175706;5100.005498927673;5112.923306150411;5141.897162056738;5144.6398752087;5152;4873.31773551703;4970.602351811919;4986.227134794112;5101.770420331094;5113.744312784346;4205.852795152155;4261.893452663646;4271.466066741657;4291.163223171514;4306.181825453154;3758.9060273492832;3772;3788.6590206881515;3803.6576708096404;3803.8858834235016;4228.133232687292;4332.155229730172;4474.597286244254;4480.081583275421;4501.48232953208;5105.821296254613;5148.4851514848215;5192.143296356135;5214.035403450373;5260.421353651172;4365.847195348211;4376.868693939187;4384.276594361958;4400.955990440055;4405.735655860659;4356.978215108968;4471.597556219956;4509.188346097734;4513.187626227245;4567.885802854888;4805.27920811881;4830.2513110467935;4865.464798872192;4880.829170978998;4916.459189489082;5150.40770311419;5257.316548848626;5257.8159764408065;5259.815906443256;5302.973485132704;4650.279206722963;4749.24012158053;4931.654784165217;4951.3810773653295;4960.503949605155;4983.9501604984935;5048.5203905628905;5053.469385714594;5071.670341427795;5086.64393492452;5118.71847048401;5137.948620513747;5139.203423469368;5175.9741201293755;5188.403333616682;4869.366982292279;4957.776900039579;4958;4982.501749824988;4987.2768448574025;4888.633352498506;4969.403671559436;4972.328735620789;4979.477154898684;4991.975040124777;4938;4945.455999840086;4952.430470495795;4955.50444955516;4990.525900039491;4878.975605121952;4994.375703037121;5023.397192336797;5068.949310506848;5090.745462726923;4757.904841903073;4811.807527698993;4814.879628009187;4830.275458681226;4857.611391088633 19:46:15 INFO - 2015-11-11 19:46:15,236 DEBUG : BROWSER_OUTPUT: |1;ext.html;563.9929933976247;579.0619196901021;585.8593937455007;590.2002786224668;598.7844376024631;27860.721392786065;37423;37842.62157378429;37843.432348514725;37857.24285514288;40978.59021409785;41917.58082419175;41934.16131677364;41936.161276774445;42087.15825683492;7048.68280927357;7155.998160257542;7928.722494712686;8113.229243221885;8117.431779775418;9927.90072099277;10182.28723989321;10211.387316761018;10217.438040907748;10219.131373833234;9872.555734991942;9978;9983.500824958759;9986.800263994715;10000.699979000641;7101.467389945749;7303.269673032707;10014.449205293706;10037.247206459508;10309.484525773756;9883.703488895344;9955.701328960144;9973.35173213746;10005.649802256887;10017.69946901594;36480.452793207856;36600;36682.816585917164;36689.266214675554;37125.814370928245;2882.279430142464;2944.07261712562;2950.262434391402;2975.8065725727756;3016.230861130398;28066;28464;28470.145895623165;28727.856360718062;28781.42437151266;2808.592754050672;2821.6755073166437;2827.802053856231;2839.3469502014445;2882.8702708378173;227639;228419;228534.99999999834;229416;230919;50131.24278164663;50334.49665503298;53915;54362.72818635961;60527;55205;55217;55360.72319638456;55514.44485555174;55540;12659.620211393672;12821.935890320488;12910.612681619567;12975.740485190243;13053.216806991612;9198.310126740522;9230.400023998418;9237.676681316256;9238.538073096319;9243.399179053475;18593.814061859477;18692.252309907723;18892.244310227437;18905.527361815788;18930.242790288234;7336.926630733731;7468.589227592534;7503.174650788409;7571.280728330799;7661.578613176217;861.9224269815746;916.7937214126902;959.0122174160625;993.7515621094726;1000.4497526360473;26410;26473.338166545604;26793.06224282141;27091.593626095626;29293.85353073221;873.9257163141077;925.3984909808544;941.7410212191566;961.2790407194605;992.072412294507;13167.407466664023;13294.534691285759;13401;13409.731805364034;13483.662908427172;249777;253798;254191;254547;255681;44272.77863610726;44406.77796610996;44538;44547.77726111413;44552.77723611361;1184.988150118505;1221.2367270455966;1233.7532493501155;1234.2964510229262;1234.327291626066;24417.877910610332;24768.752312476645;25178.62232066484;25247.621285681096;25339.08600510965;35580.82209588936;36320.45519317265;42156.36765448582;43028.13943721171;43035.3544696836;172337;172505;173514;173619;173859.13070434568;23938.40153996164;24301.392465187804;25788;26159.869200653873;26207;37230.627693722716;38008;38548.229035418575;38599.42100868433;38861.80569097136;30938;30982.535261971538;31728.841355793073;32155.51766723548;32498.675013249565;31236.37527249397;31619.525707114874;31731;31781;31804.681953181098;32299.838500807346;32338.191545210615;32541;32975.50536741903;33021.50467742938;28012.019579314627;28049.298767530974;29379.706202937698;29454.263643409085;29692.851535742182;20089.598208036048;20232.59534809325;20358.28745993883;20421.57049006555;20479.59040819205 19:46:15 INFO - 2015-11-11 19:46:15,236 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.85354444044634;334.7706820827732;336.68688120048347;337.9307242015386;338.72563223788734;12707.618771436872;13124.737505249914;15439.536813895587;15547.922260388696;17617.64764704705;15582.298796554154;15633.452829150981;16223.83776162238;16233.594160146002;16237.188140592982;4837;5131.563817075553;5133.974330128344;5138.152204886189;5139.177731562951;3605.2248766515195;3744.8502059917705;5595.552355811526;5797.623154494965;5800;5572.916406253909;5687.601867869251;5711.029125048752;5712.200291959109;5726.828195154152;5686.601937864351;5704.087346024637;5721.656700597978;5725.055365864649;5729.398413166599;4913.606911447076;4998.050370429607;5003.474635163292;5006.249062640597;5029.949700503022;18913.527161821065;19056;19207.711884321605;19604.901975490033;19807.00964951761;1756.8594512438974;1763.6120053588318;1824.14265295311;1911.054028256022;1946.202057156559;12366.75266494674;12498.125131240817;12508.624741257778;12514.874851251552;13214.603561893158;1584.627612511059;1596.6966276407445;1647.283431707211;1648.934042638293;1756.7891852977596;54297.72851135719;54455.455445445434;54684.72657636726;54867;54899.451005489835;9179.127982841619;9383.765405864908;9618.951905240428;9630.133288004114;9666.613335466502;12004.579839705568;12008;12022.917937385677;12025.63923082309;12031.759364812655;6582.506312026617;6585.209774827052;6601.801945941629;6621.735130594722;6638.070670106189;5949.10763385487;5977.103434484862;6011.579189456696;6018.699065046818;6185.659788711574;5652.74562644682;5740.966626007275;5753.8561535961935;5781;5821.301443826683;1511.5465360391838;1592.9044257344597;1606.7509536021935;1670.2567357526027;1684.9663006739797;883.2183517586982;888.4447220487195;906.1482206725657;936.7330310861372;964.3972517176765;13685.247311397969;15860.365585376456;16409.42567010149;16481.25834337458;16566.917165414096;874.4185116897319;884.6019291318933;887.8135591525722;940.8965013848472;951.7620594851287;9015.954920225357;9215.078492150731;9252.444853308823;9295.72112836616;9425.05749425052;484297;488138;492098;492985;500488;60630.696846516366;63435;63666;64191.358086419474;65268;991.7074463033423;1013.8834034086175;1014.2595904989547;1019.7909428567126;1020.9336393134422;14665.48670796517;14756;14946.103744710585;14988.264886758512;15018.324175412352;30794.384112318075;31702.207444814063;31783.682163178073;31796.68203317937;32662;41685.58314416817;41831.37252941148;42290.942726432084;42454;43383.56616433795;8978.371513993958;8991.41555798871;9185.724428267162;9189.86215206759;9204.217641500547;10711.678649640524;11215.327080375204;11441;11535.596254131066;11614.593489227836;9175.77060573491;9863.506824658594;10300.381977081399;10387.532561034923;10422.478876056319;9541.618335266512;9850.753731156778;9954.303198776017;10050.849237261593;10071;9373.250139988648;9509.334346595671;9823.852642210515;9874.259430542881;9917.30578859473;6181.35095814933;6223.284322302812;6291.716872740646;6302.086197501245;6304.117423560797;9526.66656667041;9648.324617276723;9691;9790.706278811647;9796.559154838193 19:46:15 INFO - 2015-11-11 19:46:15,240 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1236;1593.5139782366377;1668.0992264177348;1671.6573102513985;1702.5743564108973;6065.727042283097;6622.139121914151;6729.865402691949;6740.157480314961;6757.256701762814;6784.592924424538;6852.417544508723;6870.587764734119;6875.553089049208;6876.037354770337;1771.123293969487;1803.2877013579628;1998.1407994562333;2050.9794902050976;2074.294739788472;2057.8250848677803;2063.68012957991;2064.783197764236;2065.3700621310495;2068.0383621615947;1989.353460125465;2001.6497113005166;2046.1201683276186;2046.7850875657991;2047.5597746484502;1893.3846499887454;1911.3883557261681;1924.7786504551946;1954.5699946011925;1955.2960934063797;2058.3927741316347;2080.9895950520304;2085.0200405809246;2089.63431399506;2090.4878304815416;7155.749548765768;7203.855922881566;7211.350978411916;7214.67533960973;7217.603031833247;4096.139810639769;4174.269502837022;4175.5615660355525;4196.643285320752;4197.433346498215;2302.9654555181687;2537.5432422164004;2668.6397336359537;2678.9196324110308;2694.501517219301;798;839.886615306938;841.2807049972247;845.7335939179201;864.5633954852759;9284.907150928539;9359.953200234024;9383.765405864908;9384.155426011623;9391.201747851372;3854.8650797221962;3859.5754467008605;3900.7269491135917;3917.5494818095713;3925.5485619154165;8359.205875441823;8367.623456944451;8398.244158025807;8402.327813774884;8417.452865563719;4245.681573881971;4253.234417804763;4253.404523366731;4254.638355739797;4254.829806807755;3701.592824789271;3773.6981041516615;3781.716371272111;3802.0304822270696;3812.218495208476;3276.819774912403;3289.753268504872;3343.114074770188;3374.865005399806;3378.493226016117;1085.8045551800594;1092.9125669946386;1101.9338839669645;1104.5305745058317;1109.2346281066039;936.8079543693526;953.699584630839;955.1117460761559;999.8650182225452;1168.456667649547;6670;6672.532922695462;6678.766243181465;6685.632290223987;6703.22912865017;442.72993473980847;443.3748414735208;1100.1089117814595;1131.4399372310595;1139.7777433400408;5177.534021938043;5218.66078704883;5246.554042906396;5247.501487358772;5252.317198764213;7274.381677557361;7370.815729606696;8310.168983101641;8331.458455200514;8459.365547583955;8305.294050005818;8457.873131903027;8514.914850851535;8529.786755331043;8535.829283414298;6620.801375958729;6709.4296984755865;6720.126383570105;6797.388235058868;6806.387425131663;6774.491913106635;6777.085093512313;6790.049393085071;6791.932080679328;6814.965925170342;7436.702531898663;7672.232776722283;7678.232176782277;7693.538387696756;7756.418268629988;7774.883376749241;7872;7964.123946365779;7987.440879138405;8069.475484093515;6143.938560614337;6217.160683307696;6224.097505861715;6226.159468471879;6234.9688251558455;6629.270780214076;6775.695093720696;6794.8641027180165;6843.589384636938;6874.381305682513;6441.645709486023;6458.063580780855;6530.869382612416;6614.603123812394;6625.834354141185;6419.325970773001;6469.288378278292;6485.383888530582;6515.54391192612;6582.605043697394;6601.33986601336;6649.700763465752;6661.900071498834;6663.666816659244;6674.766383176566;6114.0828875669;6174.104754810617;6179.721912513858;6181.041938499539;6186.1648677427975;6022.156898034191;6052.061930400795;6076.6961651916345;6081.574289799849;6099.329073801967 19:46:15 INFO - 2015-11-11 19:46:15,241 DEBUG : BROWSER_OUTPUT: |4;prototype.html;307.33002055518966;309.58051839757127;312.7404254468791;314.9417357788809;316.0676005782938;5143.7428128593565;5162.896742065162;5192.169252919533;5199.974000129994;5206.193040078784;5123.948760512394;5138.049460849746;5138.280640710294;5140.0490909181735;5143.254228136927;3915.0212446888277;3982.123932734794;4102.994766282265;4105.8973525661795;4107.917841643173;4014.1770936957855;4047.8380864765372;4082.3876418537307;4085.060436099699;4091.2022155679656;3979.084810493588;3988.302047141753;3997.600239976008;4001.519817621875;4008.97995510022;3846.326892793764;3907.4920260366252;3955.4857868476915;4006.679465642756;4045.9595404045876;3575.410057340536;3589.964100358989;3592.2276710507103;3596.2447885943984;3603.297357015383;4965.851024469272;4981.128302547076;4982.800687972477;4983.576396006308;4985.875353116201;4609.7695115244105;4614.146382919171;4619.74591397473;4621.3299071634765;4622.2835460503675;5131.948680513185;5360.812371567015;5370.5435038021815;5393.05621516237;5422.5119739223655;3881.941770873439;3908.1402091539817;3913.9217215655526;3923.0780766519847;3926.4699265599065;5663.518600918886;5663.943360566424;5671.262735844355;5676.772929082832;5680.11958146488;4024.2756303865585;4024.7182697210915;4025.0742329264435;4026.355783074694;4039.7576145431367;4002.399640054015;4092.7135100543273;4094.3449048152747;4097.467329247238;4098.1189044355015;4604.148232576984;4616.976915115403;4618.076384723069;4620.399348084795;4621.445426548836;5410;5416.404195538487;5419.268398766116;5456.317960254968;5459.563234941195;1473.395907677847;1491.2767307855681;1492.9626759330886;1493.133982290269;1494.133402626474;1026.5688410867454;1031.1956673794302;1031.2265800649513;1032.5198782565992;1060.2419270221828;4753.287006948916;4753.881152971203;4759.690620109682;4759.904801904012;4791.616670666338;5645.858853528694;5651.463111004448;5652.85867853307;5657.915131273035;5664.68844213564;4756.857294281108;4768.237082066922;4783.473817880031;4787.61699064074;4793.736344501086;2932.1057077591113;3003.1140813460083;3058.847057647153;3065.7394121499924;3083.429565530384;4996.075725990703;5285.894282114336;5338.759755810997;5348;5349.652272602269;5727.341355744059;5742.856428589235;5753.85615359611;5754.597178197486;5764.481196692318;5299.12564426873;5299.231611416323;5304.098303288373;5305.36335639718;5307.150855863043;5438.510534051954;5582.441755824385;5615.859603509945;5704.3154821421695;5705.543556515552;5584.134459158674;5586.32964044301;5587.832365029056;5593.105103183471;5594.524465420485;5380.650257733235;5382.354117505768;5387.0572649785345;5387.676739395649;5387.730613469389;3986;4066.8002939132434;4067.796610169539;4071.5521292658377;4076.3477843544892;5687.090065589486;5692.943070569407;5695;5698.287714035746;5700.914486282792;5437.102878025082;5486.204500347507;5491.36849262324;5497.175423686479;5500.972495137498;5420.864478388072;5428.70142142186;5431.131019036935;5452.045891968969;5452.754626041917;5288.81489147878;5376.193570964387;5393.298871146726;5400.567954563704;5401.405845356929;5519.668819870821;5535.169724541351;5537.833864984057;5538.556915446835;5539.390667026543;5313.681179129265;5363.222332761649;5365.195220716923;5374.381946076252;5378.327709036371 19:46:15 INFO - 2015-11-11 19:46:15,242 DEBUG : BROWSER_OUTPUT: |5;yui.html;663.3068443476567;683.8116536215679;691.7959202035399;705.178467085845;710.8862581986883;11220.607278745245;11413.25813822101;11445.771084578304;11452.599159029436;11465.254758440706;11768.470418831152;11923.7615247695;12975.15661482003;13602.523911663095;13603;602.2321540036467;606.5056978562479;750.3059669805408;751.7857410637955;755.2560727683227;764.8852672099201;771.4445599168617;778.1362687416963;778.2489897249153;778.4861991085885;805.9314958228557;811.427943299975;811.8498077855586;818.7134502923959;818.8075802186481;621.3693101501957;630.2437075509384;778.2178910195217;799.8120441696196;800.4196957206008;579.2383016333508;582.8688545077366;583.212662905079;583.8686295583502;584.4068270705237;11629.825552616718;11739.47172377245;11785.410729463578;11786.292822430596;11794.174407791457;8460.407771456;8493.235608795238;8900.465972041698;9288.024757400512;9294.117058879396;7966.6415011324625;7988.720394786154;8670.566471676391;8809.735707928772;8812.955935220347;2590.6632137822153;2624.3439140214946;2645.6692913385828;2674.1442738323744;2689.099151784155;40036.59963400358;40222.79888600538;40305.79847100746;40325;40404.797976010224;6290.21372328459;6293.653849038255;6326.841828954221;6344.904826427607;6375;9971.850422243671;9972.900270997197;9985.550650220757;9991.900080999243;9993.450360230112;5565.109582466866;5672.517835983905;5711.457411545896;5717.971410143005;5895.263092113486;3430.622631510532;3642.3261696586214;3687.59436461989;3689.7048236141045;3691.2617476504806;2357.0925193800167;2389.6535002424553;2394.150076722773;2394.7485514021128;2400.7239167495964;371.4483991272958;372.88254199926934;378.03977896144033;379.31722898782084;382.65560995104073;405.52350987589466;432.9437173167531;437.36363590975054;445.8261278101543;472.56996133518334;6523.739050438025;7722.065615066239;7772.378209743207;7909.24862138096;8131.186881311822;513.8543025415992;540.4492484377602;544.7633871112553;548.0510985798248;551.2300689037538;3177.4280629486916;3286.6220384655594;3339.749518786101;3434.8282585870606;3438.054535002894;55173.72413137909;56459.71770141123;56782;56800;57149.42850571441;49079.75460122676;49419;49571.50428495741;49790.253146202835;50268.49731502638;44460.3330950036;44674.55325446769;44781.77609111933;45216;45396.54603453989;6521.347865213441;6538.771143009972;6545.083688283549;6570.901436478553;6763.5941843489545;32463.35073298568;32466.188345291557;32877.342453150326;33015;33133.83433082819;39249.80375098106;39300.41049384204;40332.39501407422;42589.36115958325;42679.78660106679;5538.806141785019;5745.052066409163;5844.020590948193;5864.648121112747;5937.940620593911;8974.102589740975;9089;9164.129407706258;9377.531123443665;9528.237740980843;8567.571621419029;8696.17386348296;8730.781730456789;8740.912590874264;8743.956280218557;8262.380321475794;8368.330533557422;8405.663773448994;8412.537310447738;8412.957935210285;7849.646765895434;7892.0529536456;7909.24862138096;7917.485363451357;7947.920520794718;7353.338199562065;7477.663505142173;7512.661930213044;7534.4725869190825;7692.92307076922;7137.714491420285;7743.380529557509;7823.804404889924;7834.569252973718;8375.078741338326 19:46:15 INFO - 2015-11-11 19:46:15,242 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:46:15 INFO - 2015-11-11 19:46:15,243 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:46:15 INFO - 2015-11-11 19:46:15,243 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1033 19:46:15 INFO - 2015-11-11 19:46:15,243 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:46:15 INFO - 2015-11-11 19:46:15,243 DEBUG : BROWSER_OUTPUT: __startTimestamp1447299975229__endTimestamp 19:46:15 INFO - 2015-11-11 19:46:15,243 DEBUG : BROWSER_OUTPUT: 19:46:15 INFO - 2015-11-11 19:46:15,243 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:46:15 INFO - 2015-11-11 19:46:15,243 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:46:15 INFO - 2015-11-11 19:46:15,243 DEBUG : BROWSER_OUTPUT: 19:46:15 INFO - 2015-11-11 19:46:15,244 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4732.50 Median:4869.37 stddev:493.20 (10.1%) stddev-sans-first:467.50 19:46:15 INFO - 2015-11-11 19:46:15,244 DEBUG : BROWSER_OUTPUT: Values: 2672.9 2784.4 2787.3 2801.7 2804.5 4685.2 4773.3 4820.7 4895.4 4907.0 4668.3 4685.3 4724.7 4757.5 4876.9 4357.7 4445.5 4452.2 4454.7 4513.7 4287.4 4527.5 4540.7 4574.7 4574.7 4340.3 4409.4 4428.7 4431.2 4458.8 4399.6 4410.6 4411.5 4419.7 4473.0 4301.6 4376.3 4387.2 4400.8 4428.4 4722.9 4825.1 4826.0 4848.3 4872.1 5187.9 5206.2 5209.2 5212.9 5249.0 4944.3 5050.3 5052.9 5210.0 5220.7 4617.5 4675.1 4690.3 4694.6 4717.4 5304.2 5305.1 5315.5 5337.9 5356.8 4856.7 4985.0 4986.9 5062.8 5100.0 4968.8 5059.8 5065.8 5070.9 5109.8 5100.0 5112.9 5141.9 5144.6 5152.0 4873.3 4970.6 4986.2 5101.8 5113.7 4205.9 4261.9 4271.5 4291.2 4306.2 3758.9 3772.0 3788.7 3803.7 3803.9 4228.1 4332.2 4474.6 4480.1 4501.5 5105.8 5148.5 5192.1 5214.0 5260.4 4365.8 4376.9 4384.3 4401.0 4405.7 4357.0 4471.6 4509.2 4513.2 4567.9 4805.3 4830.3 4865.5 4880.8 4916.5 5150.4 5257.3 5257.8 5259.8 5303.0 4650.3 4749.2 4931.7 4951.4 4960.5 4984.0 5048.5 5053.5 5071.7 5086.6 5118.7 5137.9 5139.2 5176.0 5188.4 4869.4 4957.8 4958.0 4982.5 4987.3 4888.6 4969.4 4972.3 4979.5 4992.0 4938.0 4945.5 4952.4 4955.5 4990.5 4879.0 4994.4 5023.4 5068.9 5090.7 4757.9 4811.8 4814.9 4830.3 4857.6 19:46:15 INFO - 2015-11-11 19:46:15,244 DEBUG : BROWSER_OUTPUT: 19:46:15 INFO - 2015-11-11 19:46:15,244 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38085.44 Median:31674.18 stddev:57504.53 (181.6%) stddev-sans-first:57596.83 19:46:15 INFO - 2015-11-11 19:46:15,244 DEBUG : BROWSER_OUTPUT: Values: 564.0 579.1 585.9 590.2 598.8 27860.7 37423.0 37842.6 37843.4 37857.2 40978.6 41917.6 41934.2 41936.2 42087.2 7048.7 7156.0 7928.7 8113.2 8117.4 9927.9 10182.3 10211.4 10217.4 10219.1 9872.6 9978.0 9983.5 9986.8 10000.7 7101.5 7303.3 10014.4 10037.2 10309.5 9883.7 9955.7 9973.4 10005.6 10017.7 36480.5 36600.0 36682.8 36689.3 37125.8 2882.3 2944.1 2950.3 2975.8 3016.2 28066.0 28464.0 28470.1 28727.9 28781.4 2808.6 2821.7 2827.8 2839.3 2882.9 227639.0 228419.0 228535.0 229416.0 230919.0 50131.2 50334.5 53915.0 54362.7 60527.0 55205.0 55217.0 55360.7 55514.4 55540.0 12659.6 12821.9 12910.6 12975.7 13053.2 9198.3 9230.4 9237.7 9238.5 9243.4 18593.8 18692.3 18892.2 18905.5 18930.2 7336.9 7468.6 7503.2 7571.3 7661.6 861.9 916.8 959.0 993.8 1000.4 26410.0 26473.3 26793.1 27091.6 29293.9 873.9 925.4 941.7 961.3 992.1 13167.4 13294.5 13401.0 13409.7 13483.7 249777.0 253798.0 254191.0 254547.0 255681.0 44272.8 44406.8 44538.0 44547.8 44552.8 1185.0 1221.2 1233.8 1234.3 1234.3 24417.9 24768.8 25178.6 25247.6 25339.1 35580.8 36320.5 42156.4 43028.1 43035.4 172337.0 172505.0 173514.0 173619.0 173859.1 23938.4 24301.4 25788.0 26159.9 26207.0 37230.6 38008.0 38548.2 38599.4 38861.8 30938.0 30982.5 31728.8 32155.5 32498.7 31236.4 31619.5 31731.0 31781.0 31804.7 32299.8 32338.2 32541.0 32975.5 33021.5 28012.0 28049.3 29379.7 29454.3 29692.9 20089.6 20232.6 20358.3 20421.6 20479.6 19:46:15 INFO - 2015-11-11 19:46:15,244 DEBUG : BROWSER_OUTPUT: 19:46:15 INFO - 2015-11-11 19:46:15,244 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25750.30 Median:5018.10 stddev:80214.52 (1598.5%) stddev-sans-first:80416.84 19:46:15 INFO - 2015-11-11 19:46:15,246 DEBUG : BROWSER_OUTPUT: Values: 332.9 334.8 336.7 337.9 338.7 12707.6 13124.7 15439.5 15547.9 17617.6 15582.3 15633.5 16223.8 16233.6 16237.2 4837.0 5131.6 5134.0 5138.2 5139.2 3605.2 3744.9 5595.6 5797.6 5800.0 5572.9 5687.6 5711.0 5712.2 5726.8 5686.6 5704.1 5721.7 5725.1 5729.4 4913.6 4998.1 5003.5 5006.2 5029.9 18913.5 19056.0 19207.7 19604.9 19807.0 1756.9 1763.6 1824.1 1911.1 1946.2 12366.8 12498.1 12508.6 12514.9 13214.6 1584.6 1596.7 1647.3 1648.9 1756.8 54297.7 54455.5 54684.7 54867.0 54899.5 9179.1 9383.8 9619.0 9630.1 9666.6 12004.6 12008.0 12022.9 12025.6 12031.8 6582.5 6585.2 6601.8 6621.7 6638.1 5949.1 5977.1 6011.6 6018.7 6185.7 5652.7 5741.0 5753.9 5781.0 5821.3 1511.5 1592.9 1606.8 1670.3 1685.0 883.2 888.4 906.1 936.7 964.4 13685.2 15860.4 16409.4 16481.3 16566.9 874.4 884.6 887.8 940.9 951.8 9016.0 9215.1 9252.4 9295.7 9425.1 484297.0 488138.0 492098.0 492985.0 500488.0 60630.7 63435.0 63666.0 64191.4 65268.0 991.7 1013.9 1014.3 1019.8 1020.9 14665.5 14756.0 14946.1 14988.3 15018.3 30794.4 31702.2 31783.7 31796.7 32662.0 41685.6 41831.4 42290.9 42454.0 43383.6 8978.4 8991.4 9185.7 9189.9 9204.2 10711.7 11215.3 11441.0 11535.6 11614.6 9175.8 9863.5 10300.4 10387.5 10422.5 9541.6 9850.8 9954.3 10050.8 10071.0 9373.3 9509.3 9823.9 9874.3 9917.3 6181.4 6223.3 6291.7 6302.1 6304.1 9526.7 9648.3 9691.0 9790.7 9796.6 19:46:15 INFO - 2015-11-11 19:46:15,246 DEBUG : BROWSER_OUTPUT: 19:46:15 INFO - 2015-11-11 19:46:15,246 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4947.77 Median:6230.56 stddev:2570.44 (41.3%) stddev-sans-first:2562.50 19:46:15 INFO - 2015-11-11 19:46:15,246 DEBUG : BROWSER_OUTPUT: Values: 1236.0 1593.5 1668.1 1671.7 1702.6 6065.7 6622.1 6729.9 6740.2 6757.3 6784.6 6852.4 6870.6 6875.6 6876.0 1771.1 1803.3 1998.1 2051.0 2074.3 2057.8 2063.7 2064.8 2065.4 2068.0 1989.4 2001.6 2046.1 2046.8 2047.6 1893.4 1911.4 1924.8 1954.6 1955.3 2058.4 2081.0 2085.0 2089.6 2090.5 7155.7 7203.9 7211.4 7214.7 7217.6 4096.1 4174.3 4175.6 4196.6 4197.4 2303.0 2537.5 2668.6 2678.9 2694.5 798.0 839.9 841.3 845.7 864.6 9284.9 9360.0 9383.8 9384.2 9391.2 3854.9 3859.6 3900.7 3917.5 3925.5 8359.2 8367.6 8398.2 8402.3 8417.5 4245.7 4253.2 4253.4 4254.6 4254.8 3701.6 3773.7 3781.7 3802.0 3812.2 3276.8 3289.8 3343.1 3374.9 3378.5 1085.8 1092.9 1101.9 1104.5 1109.2 936.8 953.7 955.1 999.9 1168.5 6670.0 6672.5 6678.8 6685.6 6703.2 442.7 443.4 1100.1 1131.4 1139.8 5177.5 5218.7 5246.6 5247.5 5252.3 7274.4 7370.8 8310.2 8331.5 8459.4 8305.3 8457.9 8514.9 8529.8 8535.8 6620.8 6709.4 6720.1 6797.4 6806.4 6774.5 6777.1 6790.0 6791.9 6815.0 7436.7 7672.2 7678.2 7693.5 7756.4 7774.9 7872.0 7964.1 7987.4 8069.5 6143.9 6217.2 6224.1 6226.2 6235.0 6629.3 6775.7 6794.9 6843.6 6874.4 6441.6 6458.1 6530.9 6614.6 6625.8 6419.3 6469.3 6485.4 6515.5 6582.6 6601.3 6649.7 6661.9 6663.7 6674.8 6114.1 6174.1 6179.7 6181.0 6186.2 6022.2 6052.1 6076.7 6081.6 6099.3 19:46:15 INFO - 2015-11-11 19:46:15,246 DEBUG : BROWSER_OUTPUT: 19:46:15 INFO - 2015-11-11 19:46:15,246 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4542.41 Median:5060.01 stddev:1303.88 (25.8%) stddev-sans-first:1268.20 19:46:15 INFO - 2015-11-11 19:46:15,246 DEBUG : BROWSER_OUTPUT: Values: 307.3 309.6 312.7 314.9 316.1 5143.7 5162.9 5192.2 5200.0 5206.2 5123.9 5138.0 5138.3 5140.0 5143.3 3915.0 3982.1 4103.0 4105.9 4107.9 4014.2 4047.8 4082.4 4085.1 4091.2 3979.1 3988.3 3997.6 4001.5 4009.0 3846.3 3907.5 3955.5 4006.7 4046.0 3575.4 3590.0 3592.2 3596.2 3603.3 4965.9 4981.1 4982.8 4983.6 4985.9 4609.8 4614.1 4619.7 4621.3 4622.3 5131.9 5360.8 5370.5 5393.1 5422.5 3881.9 3908.1 3913.9 3923.1 3926.5 5663.5 5663.9 5671.3 5676.8 5680.1 4024.3 4024.7 4025.1 4026.4 4039.8 4002.4 4092.7 4094.3 4097.5 4098.1 4604.1 4617.0 4618.1 4620.4 4621.4 5410.0 5416.4 5419.3 5456.3 5459.6 1473.4 1491.3 1493.0 1493.1 1494.1 1026.6 1031.2 1031.2 1032.5 1060.2 4753.3 4753.9 4759.7 4759.9 4791.6 5645.9 5651.5 5652.9 5657.9 5664.7 4756.9 4768.2 4783.5 4787.6 4793.7 2932.1 3003.1 3058.8 3065.7 3083.4 4996.1 5285.9 5338.8 5348.0 5349.7 5727.3 5742.9 5753.9 5754.6 5764.5 5299.1 5299.2 5304.1 5305.4 5307.2 5438.5 5582.4 5615.9 5704.3 5705.5 5584.1 5586.3 5587.8 5593.1 5594.5 5380.7 5382.4 5387.1 5387.7 5387.7 3986.0 4066.8 4067.8 4071.6 4076.3 5687.1 5692.9 5695.0 5698.3 5700.9 5437.1 5486.2 5491.4 5497.2 5501.0 5420.9 5428.7 5431.1 5452.0 5452.8 5288.8 5376.2 5393.3 5400.6 5401.4 5519.7 5535.2 5537.8 5538.6 5539.4 5313.7 5363.2 5365.2 5374.4 5378.3 19:46:15 INFO - 2015-11-11 19:46:15,247 DEBUG : BROWSER_OUTPUT: 19:46:15 INFO - 2015-11-11 19:46:15,247 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11868.82 Median:3214.21 stddev:15230.73 (473.9%) stddev-sans-first:15250.21 19:46:15 INFO - 2015-11-11 19:46:15,248 DEBUG : BROWSER_OUTPUT: Values: 663.3 683.8 691.8 705.2 710.9 11220.6 11413.3 11445.8 11452.6 11465.3 11768.5 11923.8 12975.2 13602.5 13603.0 602.2 606.5 750.3 751.8 755.3 764.9 771.4 778.1 778.2 778.5 805.9 811.4 811.8 818.7 818.8 621.4 630.2 778.2 799.8 800.4 579.2 582.9 583.2 583.9 584.4 11629.8 11739.5 11785.4 11786.3 11794.2 8460.4 8493.2 8900.5 9288.0 9294.1 7966.6 7988.7 8670.6 8809.7 8813.0 2590.7 2624.3 2645.7 2674.1 2689.1 40036.6 40222.8 40305.8 40325.0 40404.8 6290.2 6293.7 6326.8 6344.9 6375.0 9971.9 9972.9 9985.6 9991.9 9993.5 5565.1 5672.5 5711.5 5718.0 5895.3 3430.6 3642.3 3687.6 3689.7 3691.3 2357.1 2389.7 2394.2 2394.7 2400.7 371.4 372.9 378.0 379.3 382.7 405.5 432.9 437.4 445.8 472.6 6523.7 7722.1 7772.4 7909.2 8131.2 513.9 540.4 544.8 548.1 551.2 3177.4 3286.6 3339.7 3434.8 3438.1 55173.7 56459.7 56782.0 56800.0 57149.4 49079.8 49419.0 49571.5 49790.3 50268.5 44460.3 44674.6 44781.8 45216.0 45396.5 6521.3 6538.8 6545.1 6570.9 6763.6 32463.4 32466.2 32877.3 33015.0 33133.8 39249.8 39300.4 40332.4 42589.4 42679.8 5538.8 5745.1 5844.0 5864.6 5937.9 8974.1 9089.0 9164.1 9377.5 9528.2 8567.6 8696.2 8730.8 8740.9 8744.0 8262.4 8368.3 8405.7 8412.5 8413.0 7849.6 7892.1 7909.2 7917.5 7947.9 7353.3 7477.7 7512.7 7534.5 7692.9 7137.7 7743.4 7823.8 7834.6 8375.1 19:46:15 INFO - 2015-11-11 19:46:15,248 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:46:15 INFO - 2015-11-11 19:46:15,248 DEBUG : BROWSER_OUTPUT: 19:46:15 INFO - 2015-11-11 19:46:15,957 INFO : Browser exited with error code: 0 19:46:15 INFO - 2015-11-11 19:46:15,974 INFO : Completed test dromaeo_css (00:18:39) 19:46:15 INFO - 2015-11-11 19:46:15,974 INFO : Starting test kraken 19:46:15 INFO - 2015-11-11 19:46:15,974 DEBUG : operating with platform_type : linux_ 19:46:15 INFO - 2015-11-11 19:46:15,974 INFO : Initialising browser for kraken test... 19:46:15 INFO - 2015-11-11 19:46:15,980 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwPMWcU/profile http://localhost:60966/getInfo.html 19:46:19 INFO - 2015-11-11 19:46:19,671 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:46:19 INFO - 2015-11-11 19:46:19,671 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:46:19 INFO - 2015-11-11 19:46:19,671 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:46:19 INFO - 2015-11-11 19:46:19,671 DEBUG : BROWSER_OUTPUT: __metrics 19:46:19 INFO - 2015-11-11 19:46:19,809 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:46:21 INFO - 2015-11-11 19:46:21,000 INFO : Browser initialized. 19:46:21 INFO - 2015-11-11 19:46:21,001 INFO : Running cycle 1/1 for kraken test... 19:46:21 INFO - 2015-11-11 19:46:21,001 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwPMWcU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:46:32 INFO - 2015-11-11 19:46:32,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 141385728 19:46:32 INFO - 2015-11-11 19:46:32,942 DEBUG : BROWSER_OUTPUT: 19:46:35 INFO - 2015-11-11 19:46:35,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60966/tests/kraken/driver.html?testName=audio-beat-detection) 19:46:36 INFO - 2015-11-11 19:46:36,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 176168960 19:46:36 INFO - 2015-11-11 19:46:36,139 DEBUG : BROWSER_OUTPUT: 19:46:38 INFO - 2015-11-11 19:46:38,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60966/tests/kraken/driver.html?testName=audio-dft) 19:46:39 INFO - 2015-11-11 19:46:39,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 169373696 19:46:39 INFO - 2015-11-11 19:46:39,436 DEBUG : BROWSER_OUTPUT: 19:46:42 INFO - 2015-11-11 19:46:42,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60966/tests/kraken/driver.html?testName=audio-fft) 19:46:43 INFO - 2015-11-11 19:46:43,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 153378816 19:46:43 INFO - 2015-11-11 19:46:43,007 DEBUG : BROWSER_OUTPUT: 19:46:45 INFO - 2015-11-11 19:46:45,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60966/tests/kraken/driver.html?testName=audio-oscillator) 19:46:45 INFO - 2015-11-11 19:46:45,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 153845760 19:46:45 INFO - 2015-11-11 19:46:45,629 DEBUG : BROWSER_OUTPUT: 19:46:47 INFO - 2015-11-11 19:46:47,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60966/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:46:48 INFO - 2015-11-11 19:46:48,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 154951680 19:46:48 INFO - 2015-11-11 19:46:48,411 DEBUG : BROWSER_OUTPUT: 19:46:51 INFO - 2015-11-11 19:46:51,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60966/tests/kraken/driver.html?testName=imaging-darkroom) 19:46:51 INFO - 2015-11-11 19:46:51,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 156250112 19:46:51 INFO - 2015-11-11 19:46:51,978 DEBUG : BROWSER_OUTPUT: 19:46:55 INFO - 2015-11-11 19:46:55,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60966/tests/kraken/driver.html?testName=imaging-desaturate) 19:46:55 INFO - 2015-11-11 19:46:55,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 157503488 19:46:55 INFO - 2015-11-11 19:46:55,952 DEBUG : BROWSER_OUTPUT: 19:46:58 INFO - 2015-11-11 19:46:58,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60966/tests/kraken/driver.html?testName=json-parse-financial) 19:46:59 INFO - 2015-11-11 19:46:59,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 155975680 19:46:59 INFO - 2015-11-11 19:46:59,383 DEBUG : BROWSER_OUTPUT: 19:47:01 INFO - 2015-11-11 19:47:01,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60966/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:47:01 INFO - 2015-11-11 19:47:01,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 166346752 19:47:01 INFO - 2015-11-11 19:47:01,703 DEBUG : BROWSER_OUTPUT: 19:47:03 INFO - 2015-11-11 19:47:03,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60966/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:47:04 INFO - 2015-11-11 19:47:04,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 165851136 19:47:04 INFO - 2015-11-11 19:47:04,157 DEBUG : BROWSER_OUTPUT: 19:47:06 INFO - 2015-11-11 19:47:06,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60966/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:47:06 INFO - 2015-11-11 19:47:06,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 174637056 19:47:06 INFO - 2015-11-11 19:47:06,877 DEBUG : BROWSER_OUTPUT: 19:47:09 INFO - 2015-11-11 19:47:09,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60966/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:47:09 INFO - 2015-11-11 19:47:09,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 182312960 19:47:09 INFO - 2015-11-11 19:47:09,975 DEBUG : BROWSER_OUTPUT: 19:47:12 INFO - 2015-11-11 19:47:12,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60966/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:47:13 INFO - 2015-11-11 19:47:13,114 DEBUG : BROWSER_OUTPUT: RSS: Main: 180989952 19:47:13 INFO - 2015-11-11 19:47:13,115 DEBUG : BROWSER_OUTPUT: 19:47:14 INFO - 2015-11-11 19:47:14,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60966/tests/kraken/driver.html?testName=ai-astar) 19:47:15 INFO - 2015-11-11 19:47:15,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 239996928 19:47:15 INFO - 2015-11-11 19:47:15,116 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,119 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:47:15 INFO - 2015-11-11 19:47:15,119 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:47:15 INFO - 2015-11-11 19:47:15,119 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:47:15 INFO - 2015-11-11 19:47:15,120 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:47:15 INFO - 2015-11-11 19:47:15,120 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;105;111;113;111;104;110;104;112 19:47:15 INFO - 2015-11-11 19:47:15,120 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;163;133;153;165;132;152;152;129;164;131 19:47:15 INFO - 2015-11-11 19:47:15,120 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;160;160;161;159;163;161;162;162 19:47:15 INFO - 2015-11-11 19:47:15,120 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;78;98;71;73;70;96;88;72 19:47:15 INFO - 2015-11-11 19:47:15,120 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;91;128;91;92;91;126;92;92;131 19:47:15 INFO - 2015-11-11 19:47:15,120 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;109;110;110;110;110 19:47:15 INFO - 2015-11-11 19:47:15,121 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;146;146;148;147;147;147 19:47:15 INFO - 2015-11-11 19:47:15,121 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;96;96;95;95;96 19:47:15 INFO - 2015-11-11 19:47:15,121 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;71;70;71;71;71;79;69;69 19:47:15 INFO - 2015-11-11 19:47:15,121 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;68;68;67;66;67;66;67;67;67 19:47:15 INFO - 2015-11-11 19:47:15,121 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;84;87;91;83;85;83;83;83;91 19:47:15 INFO - 2015-11-11 19:47:15,121 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;119;123;127;128;125;125;127;117;118 19:47:15 INFO - 2015-11-11 19:47:15,121 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;137;148;146;144;135;144;144;149;137 19:47:15 INFO - 2015-11-11 19:47:15,121 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;69;69;71;69;67;69;70;67 19:47:15 INFO - 2015-11-11 19:47:15,121 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:47:15 INFO - 2015-11-11 19:47:15,121 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:47:15 INFO - 2015-11-11 19:47:15,121 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,961 19:47:15 INFO - 2015-11-11 19:47:15,121 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:47:15 INFO - 2015-11-11 19:47:15,122 DEBUG : BROWSER_OUTPUT: __startTimestamp1447300035117__endTimestamp 19:47:15 INFO - 2015-11-11 19:47:15,122 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,125 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:47:15 INFO - 2015-11-11 19:47:15,125 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:47:15 INFO - 2015-11-11 19:47:15,125 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,125 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:3.48 (3.1%) stddev-sans-first:3.69 19:47:15 INFO - 2015-11-11 19:47:15,125 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 105.0 111.0 113.0 111.0 104.0 110.0 104.0 112.0 19:47:15 INFO - 2015-11-11 19:47:15,125 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,125 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.40 Median:152.50 stddev:14.74 (9.7%) stddev-sans-first:14.51 19:47:15 INFO - 2015-11-11 19:47:15,125 DEBUG : BROWSER_OUTPUT: Values: 163.0 133.0 153.0 165.0 132.0 152.0 152.0 129.0 164.0 131.0 19:47:15 INFO - 2015-11-11 19:47:15,125 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.27 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 160.0 160.0 161.0 159.0 163.0 161.0 162.0 162.0 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.90 Median:75.50 stddev:10.93 (14.5%) stddev-sans-first:11.21 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 78.0 98.0 71.0 73.0 70.0 96.0 88.0 72.0 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.70 Median:91.50 stddev:17.74 (19.4%) stddev-sans-first:18.46 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: Values: 93.0 91.0 128.0 91.0 92.0 91.0 126.0 92.0 92.0 131.0 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 146.0 146.0 148.0 147.0 147.0 147.0 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,126 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:47:15 INFO - 2015-11-11 19:47:15,127 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 19:47:15 INFO - 2015-11-11 19:47:15,127 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,127 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.40 Median:71.00 stddev:2.84 (4.0%) stddev-sans-first:3.00 19:47:15 INFO - 2015-11-11 19:47:15,127 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 70.0 71.0 71.0 71.0 79.0 69.0 69.0 19:47:15 INFO - 2015-11-11 19:47:15,127 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,127 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 19:47:15 INFO - 2015-11-11 19:47:15,127 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 68.0 67.0 66.0 67.0 66.0 67.0 67.0 67.0 19:47:15 INFO - 2015-11-11 19:47:15,127 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,127 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:3.60 (4.2%) stddev-sans-first:3.36 19:47:15 INFO - 2015-11-11 19:47:15,127 DEBUG : BROWSER_OUTPUT: Values: 91.0 84.0 87.0 91.0 83.0 85.0 83.0 83.0 83.0 91.0 19:47:15 INFO - 2015-11-11 19:47:15,127 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,127 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:125.00 stddev:4.18 (3.3%) stddev-sans-first:4.21 19:47:15 INFO - 2015-11-11 19:47:15,127 DEBUG : BROWSER_OUTPUT: Values: 119.0 119.0 123.0 127.0 128.0 125.0 125.0 127.0 117.0 118.0 19:47:15 INFO - 2015-11-11 19:47:15,127 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,127 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:144.00 stddev:5.53 (3.8%) stddev-sans-first:5.10 19:47:15 INFO - 2015-11-11 19:47:15,128 DEBUG : BROWSER_OUTPUT: Values: 134.0 137.0 148.0 146.0 144.0 135.0 144.0 144.0 149.0 137.0 19:47:15 INFO - 2015-11-11 19:47:15,128 DEBUG : BROWSER_OUTPUT: 19:47:15 INFO - 2015-11-11 19:47:15,128 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.25 (1.8%) stddev-sans-first:1.30 19:47:15 INFO - 2015-11-11 19:47:15,128 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 69.0 71.0 69.0 67.0 69.0 70.0 67.0 19:47:15 INFO - 2015-11-11 19:47:15,128 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:47:15 INFO - 2015-11-11 19:47:15,128 DEBUG : BROWSER_OUTPUT: 19:47:16 INFO - 2015-11-11 19:47:16,009 INFO : Browser exited with error code: 0 19:47:16 INFO - 2015-11-11 19:47:16,058 INFO : Completed test kraken (00:01:00) 19:47:16 INFO - 2015-11-11 19:47:16,058 INFO : Starting test v8_7 19:47:16 INFO - 2015-11-11 19:47:16,058 DEBUG : operating with platform_type : linux_ 19:47:16 INFO - 2015-11-11 19:47:16,058 INFO : Initialising browser for v8_7 test... 19:47:16 INFO - 2015-11-11 19:47:16,064 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ODxwO/profile http://localhost:60966/getInfo.html 19:47:19 INFO - 2015-11-11 19:47:19,743 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:47:19 INFO - 2015-11-11 19:47:19,743 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:47:19 INFO - 2015-11-11 19:47:19,743 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:47:19 INFO - 2015-11-11 19:47:19,743 DEBUG : BROWSER_OUTPUT: __metrics 19:47:19 INFO - 2015-11-11 19:47:19,880 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:47:21 INFO - 2015-11-11 19:47:21,035 INFO : Browser initialized. 19:47:21 INFO - 2015-11-11 19:47:21,035 INFO : Running cycle 1/1 for v8_7 test... 19:47:21 INFO - 2015-11-11 19:47:21,036 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ODxwO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:47:32 INFO - 2015-11-11 19:47:32,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 141090816 19:47:32 INFO - 2015-11-11 19:47:32,918 DEBUG : BROWSER_OUTPUT: 19:47:54 INFO - 2015-11-11 19:47:54,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60966/tests/v8_7/run.html (next: http://localhost:60966/tests/v8_7/run.html) 19:47:54 INFO - 2015-11-11 19:47:54,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 436027392 19:47:54 INFO - 2015-11-11 19:47:54,648 DEBUG : BROWSER_OUTPUT: 19:47:54 INFO - 2015-11-11 19:47:54,648 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:47:54 INFO - 2015-11-11 19:47:54,648 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:47:54 INFO - 2015-11-11 19:47:54,648 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:47:54 INFO - 2015-11-11 19:47:54,648 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:47:54 INFO - 2015-11-11 19:47:54,648 DEBUG : BROWSER_OUTPUT: |0;Richards;165.31658125309968 19:47:54 INFO - 2015-11-11 19:47:54,648 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.0949742021785 19:47:54 INFO - 2015-11-11 19:47:54,649 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.42624789680315 19:47:54 INFO - 2015-11-11 19:47:54,649 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 19:47:54 INFO - 2015-11-11 19:47:54,649 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2000 19:47:54 INFO - 2015-11-11 19:47:54,649 DEBUG : BROWSER_OUTPUT: |5;Earley;805.8017727639001 19:47:54 INFO - 2015-11-11 19:47:54,649 DEBUG : BROWSER_OUTPUT: |6;Boyer;11847.058823529413 19:47:54 INFO - 2015-11-11 19:47:54,649 DEBUG : BROWSER_OUTPUT: |7;RegExp;26025.641025641027 19:47:54 INFO - 2015-11-11 19:47:54,649 DEBUG : BROWSER_OUTPUT: |8;Splay;609.4602789569436 19:47:54 INFO - 2015-11-11 19:47:54,649 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 19:47:54 INFO - 2015-11-11 19:47:54,649 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:47:54 INFO - 2015-11-11 19:47:54,649 DEBUG : BROWSER_OUTPUT: __startTimestamp1447300074642__endTimestamp 19:47:54 INFO - 2015-11-11 19:47:54,649 DEBUG : BROWSER_OUTPUT: 19:47:54 INFO - 2015-11-11 19:47:54,650 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:47:54 INFO - 2015-11-11 19:47:54,650 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:47:54 INFO - 2015-11-11 19:47:54,650 DEBUG : BROWSER_OUTPUT: 19:47:54 INFO - 2015-11-11 19:47:54,650 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.32 Median:165.32 stddev:0.00 (0.0%) 19:47:54 INFO - 2015-11-11 19:47:54,650 DEBUG : BROWSER_OUTPUT: Values: 165.3 19:47:54 INFO - 2015-11-11 19:47:54,650 DEBUG : BROWSER_OUTPUT: 19:47:54 INFO - 2015-11-11 19:47:54,650 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.09 Median:191.09 stddev:0.00 (0.0%) 19:47:54 INFO - 2015-11-11 19:47:54,650 DEBUG : BROWSER_OUTPUT: Values: 191.1 19:47:54 INFO - 2015-11-11 19:47:54,650 DEBUG : BROWSER_OUTPUT: 19:47:54 INFO - 2015-11-11 19:47:54,650 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 19:47:54 INFO - 2015-11-11 19:47:54,651 DEBUG : BROWSER_OUTPUT: Values: 280.4 19:47:54 INFO - 2015-11-11 19:47:54,651 DEBUG : BROWSER_OUTPUT: 19:47:54 INFO - 2015-11-11 19:47:54,651 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 19:47:54 INFO - 2015-11-11 19:47:54,651 DEBUG : BROWSER_OUTPUT: Values: 5030.2 19:47:54 INFO - 2015-11-11 19:47:54,651 DEBUG : BROWSER_OUTPUT: 19:47:54 INFO - 2015-11-11 19:47:54,651 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2000.00 Median:2000.00 stddev:0.00 (0.0%) 19:47:54 INFO - 2015-11-11 19:47:54,651 DEBUG : BROWSER_OUTPUT: Values: 2000.0 19:47:54 INFO - 2015-11-11 19:47:54,651 DEBUG : BROWSER_OUTPUT: 19:47:54 INFO - 2015-11-11 19:47:54,651 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:805.80 Median:805.80 stddev:0.00 (0.0%) 19:47:54 INFO - 2015-11-11 19:47:54,651 DEBUG : BROWSER_OUTPUT: Values: 805.8 19:47:54 INFO - 2015-11-11 19:47:54,652 DEBUG : BROWSER_OUTPUT: 19:47:54 INFO - 2015-11-11 19:47:54,652 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11847.06 Median:11847.06 stddev:0.00 (0.0%) 19:47:54 INFO - 2015-11-11 19:47:54,652 DEBUG : BROWSER_OUTPUT: Values: 11847.1 19:47:54 INFO - 2015-11-11 19:47:54,652 DEBUG : BROWSER_OUTPUT: 19:47:54 INFO - 2015-11-11 19:47:54,652 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26025.64 Median:26025.64 stddev:0.00 (0.0%) 19:47:54 INFO - 2015-11-11 19:47:54,652 DEBUG : BROWSER_OUTPUT: Values: 26025.6 19:47:54 INFO - 2015-11-11 19:47:54,652 DEBUG : BROWSER_OUTPUT: 19:47:54 INFO - 2015-11-11 19:47:54,652 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:609.46 Median:609.46 stddev:0.00 (0.0%) 19:47:54 INFO - 2015-11-11 19:47:54,652 DEBUG : BROWSER_OUTPUT: Values: 609.5 19:47:54 INFO - 2015-11-11 19:47:54,652 DEBUG : BROWSER_OUTPUT: 19:47:54 INFO - 2015-11-11 19:47:54,652 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 19:47:54 INFO - 2015-11-11 19:47:54,652 DEBUG : BROWSER_OUTPUT: Values: 4830.9 19:47:54 INFO - 2015-11-11 19:47:54,652 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:47:54 INFO - 2015-11-11 19:47:54,652 DEBUG : BROWSER_OUTPUT: 19:47:55 INFO - 2015-11-11 19:47:55,565 INFO : Browser exited with error code: 0 19:47:55 INFO - 2015-11-11 19:47:55,577 INFO : Completed test v8_7 (00:00:39) 19:47:55 INFO - 2015-11-11 19:47:55,619 INFO : Completed test suite (00:20:19) 19:47:55 INFO - 2015-11-11 19:47:55,620 DEBUG : Working with test: dromaeo_css 19:47:55 INFO - 2015-11-11 19:47:55,620 DEBUG : Generating results file: dromaeo_css 19:47:55 INFO - 2015-11-11 19:47:55,621 DEBUG : Working with test: kraken 19:47:55 INFO - 2015-11-11 19:47:55,621 DEBUG : Generating results file: kraken 19:47:55 INFO - 2015-11-11 19:47:55,621 INFO : javascript benchmark 19:47:55 INFO - 2015-11-11 19:47:55,621 DEBUG : Working with test: v8_7 19:47:55 INFO - 2015-11-11 19:47:55,622 DEBUG : Generating results file: v8_7 19:47:55 INFO - 2015-11-11 19:47:55,622 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:47:55 INFO - 2015-11-11 19:47:55,671 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 19:47:55 INFO - 2015-11-11 19:47:55,671 DEBUG : process_Request line: dromaeo_css 6121.70 graph.html#tests=[[72,132,35]] 19:47:55 INFO - 2015-11-11 19:47:55,671 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:47:55 INFO - 2015-11-11 19:47:55,701 DEBUG : process_Request line: kraken 1508.60 graph.html#tests=[[232,132,35]] 19:47:55 INFO - 2015-11-11 19:47:55,701 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:47:55 INFO - 2015-11-11 19:47:55,742 DEBUG : process_Request line: v8_7 19858.11 graph.html#tests=[[230,132,35]] 19:47:55 INFO - 2015-11-11 19:47:55,743 INFO : javascript benchmark 19:47:55 INFO - 2015-11-11 19:47:55,747 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [332.85354444044634, 334.7706820827732, 336.68688120048347, 337.9307242015386, 338.72563223788734, 12707.618771436872, 13124.737505249914, 15439.536813895587, 15547.922260388696, 17617.64764704705, 15582.298796554154, 15633.452829150981, 16223.83776162238, 16233.594160146002, 16237.188140592982, 4837.0, 5131.563817075553, 5133.974330128344, 5138.152204886189, 5139.177731562951, 3605.2248766515195, 3744.8502059917705, 5595.552355811526, 5797.623154494965, 5800.0, 5572.916406253909, 5687.601867869251, 5711.029125048752, 5712.200291959109, 5726.828195154152, 5686.601937864351, 5704.087346024637, 5721.656700597978, 5725.055365864649, 5729.398413166599, 4913.606911447076, 4998.050370429607, 5003.474635163292, 5006.249062640597, 5029.949700503022, 18913.527161821065, 19056.0, 19207.711884321605, 19604.901975490033, 19807.00964951761, 1756.8594512438974, 1763.6120053588318, 1824.14265295311, 1911.054028256022, 1946.202057156559, 12366.75266494674, 12498.125131240817, 12508.624741257778, 12514.874851251552, 13214.603561893158, 1584.627612511059, 1596.6966276407445, 1647.283431707211, 1648.934042638293, 1756.7891852977596, 54297.72851135719, 54455.455445445434, 54684.72657636726, 54867.0, 54899.451005489835, 9179.127982841619, 9383.765405864908, 9618.951905240428, 9630.133288004114, 9666.613335466502, 12004.579839705568, 12008.0, 12022.917937385677, 12025.63923082309, 12031.759364812655, 6582.506312026617, 6585.209774827052, 6601.801945941629, 6621.735130594722, 6638.070670106189, 5949.10763385487, 5977.103434484862, 6011.579189456696, 6018.699065046818, 6185.659788711574, 5652.74562644682, 5740.966626007275, 5753.8561535961935, 5781.0, 5821.301443826683, 1511.5465360391838, 1592.9044257344597, 1606.7509536021935, 1670.2567357526027, 1684.9663006739797, 883.2183517586982, 888.4447220487195, 906.1482206725657, 936.7330310861372, 964.3972517176765, 13685.247311397969, 15860.365585376456, 16409.42567010149, 16481.25834337458, 16566.917165414096, 874.4185116897319, 884.6019291318933, 887.8135591525722, 940.8965013848472, 951.7620594851287, 9015.954920225357, 9215.078492150731, 9252.444853308823, 9295.72112836616, 9425.05749425052, 484297.0, 488138.0, 492098.0, 492985.0, 500488.0, 60630.696846516366, 63435.0, 63666.0, 64191.358086419474, 65268.0, 991.7074463033423, 1013.8834034086175, 1014.2595904989547, 1019.7909428567126, 1020.9336393134422, 14665.48670796517, 14756.0, 14946.103744710585, 14988.264886758512, 15018.324175412352, 30794.384112318075, 31702.207444814063, 31783.682163178073, 31796.68203317937, 32662.0, 41685.58314416817, 41831.37252941148, 42290.942726432084, 42454.0, 43383.56616433795, 8978.371513993958, 8991.41555798871, 9185.724428267162, 9189.86215206759, 9204.217641500547, 10711.678649640524, 11215.327080375204, 11441.0, 11535.596254131066, 11614.593489227836, 9175.77060573491, 9863.506824658594, 10300.381977081399, 10387.532561034923, 10422.478876056319, 9541.618335266512, 9850.753731156778, 9954.303198776017, 10050.849237261593, 10071.0, 9373.250139988648, 9509.334346595671, 9823.852642210515, 9874.259430542881, 9917.30578859473, 6181.35095814933, 6223.284322302812, 6291.716872740646, 6302.086197501245, 6304.117423560797, 9526.66656667041, 9648.324617276723, 9691.0, 9790.706278811647, 9796.559154838193], "dojo.html": [2672.933176670583, 2784.3595972926228, 2787.317107308707, 2801.6918139004706, 2804.5232310507226, 4685.180093483644, 4773.284007398892, 4820.710757354557, 4895.388076490439, 4907.0185962807445, 4668.299755036746, 4685.297205419189, 4724.669273150872, 4757.452892917316, 4876.926846097312, 4357.738535687861, 4445.51099379068, 4452.154090722768, 4454.665900057493, 4513.661475389343, 4287.442632457776, 4527.52460991596, 4540.704854184468, 4574.679772415916, 4574.679772415932, 4340.305551111807, 4409.4488188976375, 4428.689991700582, 4431.224535706271, 4458.8439404620685, 4399.64802815774, 4410.625096866738, 4411.492678342, 4419.712718673276, 4472.9776351118035, 4301.634361079312, 4376.277914144194, 4387.1883701515, 4400.7579583122915, 4428.3800267962515, 4722.905541889143, 4825.131476334259, 4826.01066781309, 4848.345473361122, 4872.098661747588, 5187.870303242411, 5206.219067139921, 5209.218617207412, 5212.8957420851375, 5249.028929648028, 4944.33251511045, 5050.267711181858, 5052.873678158038, 5210.0, 5220.660657057279, 4617.5151609080895, 4675.08835777027, 4690.343351930733, 4694.577488026094, 4717.43390793107, 5304.151335786256, 5305.098133317345, 5315.521603055744, 5337.893242135136, 5356.812511562077, 4856.660033797601, 4985.027919555652, 4986.850394488171, 5062.848114556569, 5100.0, 4968.826091086795, 5059.772310246048, 5065.797368105308, 5070.923936140961, 5109.795608175706, 5100.005498927673, 5112.923306150411, 5141.897162056738, 5144.6398752087, 5152.0, 4873.31773551703, 4970.602351811919, 4986.227134794112, 5101.770420331094, 5113.744312784346, 4205.852795152155, 4261.893452663646, 4271.466066741657, 4291.163223171514, 4306.181825453154, 3758.9060273492832, 3772.0, 3788.6590206881515, 3803.6576708096404, 3803.8858834235016, 4228.133232687292, 4332.155229730172, 4474.597286244254, 4480.081583275421, 4501.48232953208, 5105.821296254613, 5148.4851514848215, 5192.143296356135, 5214.035403450373, 5260.421353651172, 4365.847195348211, 4376.868693939187, 4384.276594361958, 4400.955990440055, 4405.735655860659, 4356.978215108968, 4471.597556219956, 4509.188346097734, 4513.187626227245, 4567.885802854888, 4805.27920811881, 4830.2513110467935, 4865.464798872192, 4880.829170978998, 4916.459189489082, 5150.40770311419, 5257.316548848626, 5257.8159764408065, 5259.815906443256, 5302.973485132704, 4650.279206722963, 4749.24012158053, 4931.654784165217, 4951.3810773653295, 4960.503949605155, 4983.9501604984935, 5048.5203905628905, 5053.469385714594, 5071.670341427795, 5086.64393492452, 5118.71847048401, 5137.948620513747, 5139.203423469368, 5175.9741201293755, 5188.403333616682, 4869.366982292279, 4957.776900039579, 4958.0, 4982.501749824988, 4987.2768448574025, 4888.633352498506, 4969.403671559436, 4972.328735620789, 4979.477154898684, 4991.975040124777, 4938.0, 4945.455999840086, 4952.430470495795, 4955.50444955516, 4990.525900039491, 4878.975605121952, 4994.375703037121, 5023.397192336797, 5068.949310506848, 5090.745462726923, 4757.904841903073, 4811.807527698993, 4814.879628009187, 4830.275458681226, 4857.611391088633], "mootools.html": [1236.0, 1593.5139782366377, 1668.0992264177348, 1671.6573102513985, 1702.5743564108973, 6065.727042283097, 6622.139121914151, 6729.865402691949, 6740.157480314961, 6757.256701762814, 6784.592924424538, 6852.417544508723, 6870.587764734119, 6875.553089049208, 6876.037354770337, 1771.123293969487, 1803.2877013579628, 1998.1407994562333, 2050.9794902050976, 2074.294739788472, 2057.8250848677803, 2063.68012957991, 2064.783197764236, 2065.3700621310495, 2068.0383621615947, 1989.353460125465, 2001.6497113005166, 2046.1201683276186, 2046.7850875657991, 2047.5597746484502, 1893.3846499887454, 1911.3883557261681, 1924.7786504551946, 1954.5699946011925, 1955.2960934063797, 2058.3927741316347, 2080.9895950520304, 2085.0200405809246, 2089.63431399506, 2090.4878304815416, 7155.749548765768, 7203.855922881566, 7211.350978411916, 7214.67533960973, 7217.603031833247, 4096.139810639769, 4174.269502837022, 4175.5615660355525, 4196.643285320752, 4197.433346498215, 2302.9654555181687, 2537.5432422164004, 2668.6397336359537, 2678.9196324110308, 2694.501517219301, 798.0, 839.886615306938, 841.2807049972247, 845.7335939179201, 864.5633954852759, 9284.907150928539, 9359.953200234024, 9383.765405864908, 9384.155426011623, 9391.201747851372, 3854.8650797221962, 3859.5754467008605, 3900.7269491135917, 3917.5494818095713, 3925.5485619154165, 8359.205875441823, 8367.623456944451, 8398.244158025807, 8402.327813774884, 8417.452865563719, 4245.681573881971, 4253.234417804763, 4253.404523366731, 4254.638355739797, 4254.829806807755, 3701.592824789271, 3773.6981041516615, 3781.716371272111, 3802.0304822270696, 3812.218495208476, 3276.819774912403, 3289.753268504872, 3343.114074770188, 3374.865005399806, 3378.493226016117, 1085.8045551800594, 1092.9125669946386, 1101.9338839669645, 1104.5305745058317, 1109.2346281066039, 936.8079543693526, 953.699584630839, 955.1117460761559, 999.8650182225452, 1168.456667649547, 6670.0, 6672.532922695462, 6678.766243181465, 6685.632290223987, 6703.22912865017, 442.72993473980847, 443.3748414735208, 1100.1089117814595, 1131.4399372310595, 1139.7777433400408, 5177.534021938043, 5218.66078704883, 5246.554042906396, 5247.501487358772, 5252.317198764213, 7274.381677557361, 7370.815729606696, 8310.168983101641, 8331.458455200514, 8459.365547583955, 8305.294050005818, 8457.873131903027, 8514.914850851535, 8529.786755331043, 8535.829283414298, 6620.801375958729, 6709.4296984755865, 6720.126383570105, 6797.388235058868, 6806.387425131663, 6774.491913106635, 6777.085093512313, 6790.049393085071, 6791.932080679328, 6814.965925170342, 7436.702531898663, 7672.232776722283, 7678.232176782277, 7693.538387696756, 7756.418268629988, 7774.883376749241, 7872.0, 7964.123946365779, 7987.440879138405, 8069.475484093515, 6143.938560614337, 6217.160683307696, 6224.097505861715, 6226.159468471879, 6234.9688251558455, 6629.270780214076, 6775.695093720696, 6794.8641027180165, 6843.589384636938, 6874.381305682513, 6441.645709486023, 6458.063580780855, 6530.869382612416, 6614.603123812394, 6625.834354141185, 6419.325970773001, 6469.288378278292, 6485.383888530582, 6515.54391192612, 6582.605043697394, 6601.33986601336, 6649.700763465752, 6661.900071498834, 6663.666816659244, 6674.766383176566, 6114.0828875669, 6174.104754810617, 6179.721912513858, 6181.041938499539, 6186.1648677427975, 6022.156898034191, 6052.061930400795, 6076.6961651916345, 6081.574289799849, 6099.329073801967], "ext.html": [563.9929933976247, 579.0619196901021, 585.8593937455007, 590.2002786224668, 598.7844376024631, 27860.721392786065, 37423.0, 37842.62157378429, 37843.432348514725, 37857.24285514288, 40978.59021409785, 41917.58082419175, 41934.16131677364, 41936.161276774445, 42087.15825683492, 7048.68280927357, 7155.998160257542, 7928.722494712686, 8113.229243221885, 8117.431779775418, 9927.90072099277, 10182.28723989321, 10211.387316761018, 10217.438040907748, 10219.131373833234, 9872.555734991942, 9978.0, 9983.500824958759, 9986.800263994715, 10000.699979000641, 7101.467389945749, 7303.269673032707, 10014.449205293706, 10037.247206459508, 10309.484525773756, 9883.703488895344, 9955.701328960144, 9973.35173213746, 10005.649802256887, 10017.69946901594, 36480.452793207856, 36600.0, 36682.816585917164, 36689.266214675554, 37125.814370928245, 2882.279430142464, 2944.07261712562, 2950.262434391402, 2975.8065725727756, 3016.230861130398, 28066.0, 28464.0, 28470.145895623165, 28727.856360718062, 28781.42437151266, 2808.592754050672, 2821.6755073166437, 2827.802053856231, 2839.3469502014445, 2882.8702708378173, 227639.0, 228419.0, 228534.99999999834, 229416.0, 230919.0, 50131.24278164663, 50334.49665503298, 53915.0, 54362.72818635961, 60527.0, 55205.0, 55217.0, 55360.72319638456, 55514.44485555174, 55540.0, 12659.620211393672, 12821.935890320488, 12910.612681619567, 12975.740485190243, 13053.216806991612, 9198.310126740522, 9230.400023998418, 9237.676681316256, 9238.538073096319, 9243.399179053475, 18593.814061859477, 18692.252309907723, 18892.244310227437, 18905.527361815788, 18930.242790288234, 7336.926630733731, 7468.589227592534, 7503.174650788409, 7571.280728330799, 7661.578613176217, 861.9224269815746, 916.7937214126902, 959.0122174160625, 993.7515621094726, 1000.4497526360473, 26410.0, 26473.338166545604, 26793.06224282141, 27091.593626095626, 29293.85353073221, 873.9257163141077, 925.3984909808544, 941.7410212191566, 961.2790407194605, 992.072412294507, 13167.407466664023, 13294.534691285759, 13401.0, 13409.731805364034, 13483.662908427172, 249777.0, 253798.0, 254191.0, 254547.0, 255681.0, 44272.77863610726, 44406.77796610996, 44538.0, 44547.77726111413, 44552.77723611361, 1184.988150118505, 1221.2367270455966, 1233.7532493501155, 1234.2964510229262, 1234.327291626066, 24417.877910610332, 24768.752312476645, 25178.62232066484, 25247.621285681096, 25339.08600510965, 35580.82209588936, 36320.45519317265, 42156.36765448582, 43028.13943721171, 43035.3544696836, 172337.0, 172505.0, 173514.0, 173619.0, 173859.13070434568, 23938.40153996164, 24301.392465187804, 25788.0, 26159.869200653873, 26207.0, 37230.627693722716, 38008.0, 38548.229035418575, 38599.42100868433, 38861.80569097136, 30938.0, 30982.535261971538, 31728.841355793073, 32155.51766723548, 32498.675013249565, 31236.37527249397, 31619.525707114874, 31731.0, 31781.0, 31804.681953181098, 32299.838500807346, 32338.191545210615, 32541.0, 32975.50536741903, 33021.50467742938, 28012.019579314627, 28049.298767530974, 29379.706202937698, 29454.263643409085, 29692.851535742182, 20089.598208036048, 20232.59534809325, 20358.28745993883, 20421.57049006555, 20479.59040819205], "prototype.html": [307.33002055518966, 309.58051839757127, 312.7404254468791, 314.9417357788809, 316.0676005782938, 5143.7428128593565, 5162.896742065162, 5192.169252919533, 5199.974000129994, 5206.193040078784, 5123.948760512394, 5138.049460849746, 5138.280640710294, 5140.0490909181735, 5143.254228136927, 3915.0212446888277, 3982.123932734794, 4102.994766282265, 4105.8973525661795, 4107.917841643173, 4014.1770936957855, 4047.8380864765372, 4082.3876418537307, 4085.060436099699, 4091.2022155679656, 3979.084810493588, 3988.302047141753, 3997.600239976008, 4001.519817621875, 4008.97995510022, 3846.326892793764, 3907.4920260366252, 3955.4857868476915, 4006.679465642756, 4045.9595404045876, 3575.410057340536, 3589.964100358989, 3592.2276710507103, 3596.2447885943984, 3603.297357015383, 4965.851024469272, 4981.128302547076, 4982.800687972477, 4983.576396006308, 4985.875353116201, 4609.7695115244105, 4614.146382919171, 4619.74591397473, 4621.3299071634765, 4622.2835460503675, 5131.948680513185, 5360.812371567015, 5370.5435038021815, 5393.05621516237, 5422.5119739223655, 3881.941770873439, 3908.1402091539817, 3913.9217215655526, 3923.0780766519847, 3926.4699265599065, 5663.518600918886, 5663.943360566424, 5671.262735844355, 5676.772929082832, 5680.11958146488, 4024.2756303865585, 4024.7182697210915, 4025.0742329264435, 4026.355783074694, 4039.7576145431367, 4002.399640054015, 4092.7135100543273, 4094.3449048152747, 4097.467329247238, 4098.1189044355015, 4604.148232576984, 4616.976915115403, 4618.076384723069, 4620.399348084795, 4621.445426548836, 5410.0, 5416.404195538487, 5419.268398766116, 5456.317960254968, 5459.563234941195, 1473.395907677847, 1491.2767307855681, 1492.9626759330886, 1493.133982290269, 1494.133402626474, 1026.5688410867454, 1031.1956673794302, 1031.2265800649513, 1032.5198782565992, 1060.2419270221828, 4753.287006948916, 4753.881152971203, 4759.690620109682, 4759.904801904012, 4791.616670666338, 5645.858853528694, 5651.463111004448, 5652.85867853307, 5657.915131273035, 5664.68844213564, 4756.857294281108, 4768.237082066922, 4783.473817880031, 4787.61699064074, 4793.736344501086, 2932.1057077591113, 3003.1140813460083, 3058.847057647153, 3065.7394121499924, 3083.429565530384, 4996.075725990703, 5285.894282114336, 5338.759755810997, 5348.0, 5349.652272602269, 5727.341355744059, 5742.856428589235, 5753.85615359611, 5754.597178197486, 5764.481196692318, 5299.12564426873, 5299.231611416323, 5304.098303288373, 5305.36335639718, 5307.150855863043, 5438.510534051954, 5582.441755824385, 5615.859603509945, 5704.3154821421695, 5705.543556515552, 5584.134459158674, 5586.32964044301, 5587.832365029056, 5593.105103183471, 5594.524465420485, 5380.650257733235, 5382.354117505768, 5387.0572649785345, 5387.676739395649, 5387.730613469389, 3986.0, 4066.8002939132434, 4067.796610169539, 4071.5521292658377, 4076.3477843544892, 5687.090065589486, 5692.943070569407, 5695.0, 5698.287714035746, 5700.914486282792, 5437.102878025082, 5486.204500347507, 5491.36849262324, 5497.175423686479, 5500.972495137498, 5420.864478388072, 5428.70142142186, 5431.131019036935, 5452.045891968969, 5452.754626041917, 5288.81489147878, 5376.193570964387, 5393.298871146726, 5400.567954563704, 5401.405845356929, 5519.668819870821, 5535.169724541351, 5537.833864984057, 5538.556915446835, 5539.390667026543, 5313.681179129265, 5363.222332761649, 5365.195220716923, 5374.381946076252, 5378.327709036371], "yui.html": [663.3068443476567, 683.8116536215679, 691.7959202035399, 705.178467085845, 710.8862581986883, 11220.607278745245, 11413.25813822101, 11445.771084578304, 11452.599159029436, 11465.254758440706, 11768.470418831152, 11923.7615247695, 12975.15661482003, 13602.523911663095, 13603.0, 602.2321540036467, 606.5056978562479, 750.3059669805408, 751.7857410637955, 755.2560727683227, 764.8852672099201, 771.4445599168617, 778.1362687416963, 778.2489897249153, 778.4861991085885, 805.9314958228557, 811.427943299975, 811.8498077855586, 818.7134502923959, 818.8075802186481, 621.3693101501957, 630.2437075509384, 778.2178910195217, 799.8120441696196, 800.4196957206008, 579.2383016333508, 582.8688545077366, 583.212662905079, 583.8686295583502, 584.4068270705237, 11629.825552616718, 11739.47172377245, 11785.410729463578, 11786.292822430596, 11794.174407791457, 8460.407771456, 8493.235608795238, 8900.465972041698, 9288.024757400512, 9294.117058879396, 7966.6415011324625, 7988.720394786154, 8670.566471676391, 8809.735707928772, 8812.955935220347, 2590.6632137822153, 2624.3439140214946, 2645.6692913385828, 2674.1442738323744, 2689.099151784155, 40036.59963400358, 40222.79888600538, 40305.79847100746, 40325.0, 40404.797976010224, 6290.21372328459, 6293.653849038255, 6326.841828954221, 6344.904826427607, 6375.0, 9971.850422243671, 9972.900270997197, 9985.550650220757, 9991.900080999243, 9993.450360230112, 5565.109582466866, 5672.517835983905, 5711.457411545896, 5717.971410143005, 5895.263092113486, 3430.622631510532, 3642.3261696586214, 3687.59436461989, 3689.7048236141045, 3691.2617476504806, 2357.0925193800167, 2389.6535002424553, 2394.150076722773, 2394.7485514021128, 2400.7239167495964, 371.4483991272958, 372.88254199926934, 378.03977896144033, 379.31722898782084, 382.65560995104073, 405.52350987589466, 432.9437173167531, 437.36363590975054, 445.8261278101543, 472.56996133518334, 6523.739050438025, 7722.065615066239, 7772.378209743207, 7909.24862138096, 8131.186881311822, 513.8543025415992, 540.4492484377602, 544.7633871112553, 548.0510985798248, 551.2300689037538, 3177.4280629486916, 3286.6220384655594, 3339.749518786101, 3434.8282585870606, 3438.054535002894, 55173.72413137909, 56459.71770141123, 56782.0, 56800.0, 57149.42850571441, 49079.75460122676, 49419.0, 49571.50428495741, 49790.253146202835, 50268.49731502638, 44460.3330950036, 44674.55325446769, 44781.77609111933, 45216.0, 45396.54603453989, 6521.347865213441, 6538.771143009972, 6545.083688283549, 6570.901436478553, 6763.5941843489545, 32463.35073298568, 32466.188345291557, 32877.342453150326, 33015.0, 33133.83433082819, 39249.80375098106, 39300.41049384204, 40332.39501407422, 42589.36115958325, 42679.78660106679, 5538.806141785019, 5745.052066409163, 5844.020590948193, 5864.648121112747, 5937.940620593911, 8974.102589740975, 9089.0, 9164.129407706258, 9377.531123443665, 9528.237740980843, 8567.571621419029, 8696.17386348296, 8730.781730456789, 8740.912590874264, 8743.956280218557, 8262.380321475794, 8368.330533557422, 8405.663773448994, 8412.537310447738, 8412.957935210285, 7849.646765895434, 7892.0529536456, 7909.24862138096, 7917.485363451357, 7947.920520794718, 7353.338199562065, 7477.663505142173, 7512.661930213044, 7534.4725869190825, 7692.92307076922, 7137.714491420285, 7743.380529557509, 7823.804404889924, 7834.569252973718, 8375.078741338326]}, "summary": {"lowerIsBetter": false, "suite": 6121.697132646282, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7946.410702473532, "unit": "ms", "value": 7946.410702473532}, "dojo.html": {"lowerIsBetter": false, "filtered": 4702.196288451252, "unit": "ms", "value": 4702.196288451252}, "mootools.html": {"lowerIsBetter": false, "filtered": 4038.7207450238097, "unit": "ms", "value": 4038.7207450238097}, "ext.html": {"lowerIsBetter": false, "filtered": 16617.6238096949, "unit": "ms", "value": 16617.6238096949}, "prototype.html": {"lowerIsBetter": false, "filtered": 4134.582205940709, "unit": "ms", "value": 4134.582205940709}, "yui.html": {"lowerIsBetter": false, "filtered": 5075.3883788996645, "unit": "ms", "value": 5075.3883788996645}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-029"}, "testrun": {"date": 1447298856, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111171445", "branch": "Fx-Team-Non-PGO", "revision": "eb938e57286dfc4021f6b83e10d51d9f94534134"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 160.0, 160.0, 160.0, 161.0, 159.0, 163.0, 161.0, 162.0, 162.0], "ai-astar": [109.0, 112.0, 105.0, 111.0, 113.0, 111.0, 104.0, 110.0, 104.0, 112.0], "imaging-gaussian-blur": [109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0], "audio-beat-detection": [163.0, 133.0, 153.0, 165.0, 132.0, 152.0, 152.0, 129.0, 164.0, 131.0], "json-stringify-tinderbox": [66.0, 68.0, 68.0, 67.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [134.0, 137.0, 148.0, 146.0, 144.0, 135.0, 144.0, 144.0, 149.0, 137.0], "json-parse-financial": [72.0, 71.0, 71.0, 70.0, 71.0, 71.0, 71.0, 79.0, 69.0, 69.0], "stanford-crypto-sha256-iterative": [68.0, 68.0, 69.0, 69.0, 71.0, 69.0, 67.0, 69.0, 70.0, 67.0], "audio-fft": [71.0, 72.0, 78.0, 98.0, 71.0, 73.0, 70.0, 96.0, 88.0, 72.0], "imaging-darkroom": [147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 147.0, 147.0, 147.0], "stanford-crypto-ccm": [119.0, 119.0, 123.0, 127.0, 128.0, 125.0, 125.0, 127.0, 117.0, 118.0], "audio-oscillator": [93.0, 91.0, 128.0, 91.0, 92.0, 91.0, 126.0, 92.0, 92.0, 131.0], "stanford-crypto-aes": [91.0, 84.0, 87.0, 91.0, 83.0, 85.0, 83.0, 83.0, 83.0, 91.0], "imaging-desaturate": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1508.5999999999997, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.9, "unit": "ms", "value": 78.9}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 141.8, "unit": "ms", "value": 141.8}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 147.4, "unit": "ms", "value": 147.4}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 122.8, "unit": "ms", "value": 122.8}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.7, "unit": "ms", "value": 146.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 71.4, "unit": "ms", "value": 71.4}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.7, "unit": "ms", "value": 102.7}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.1, "unit": "ms", "value": 109.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.0, "unit": "ms", "value": 161.0}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 68.7, "unit": "ms", "value": 68.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.9, "unit": "ms", "value": 66.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.8, "unit": "ms", "value": 109.8}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.1, "unit": "ms", "value": 86.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.3, "unit": "ms", "value": 95.3}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-029"}, "testrun": {"date": 1447298856, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111171445", "branch": "Fx-Team-Non-PGO", "revision": "eb938e57286dfc4021f6b83e10d51d9f94534134"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.0949742021785], "Encrypt": [280.42624789680315], "NavierStokes": [4830.917874396136], "Decrypt": [5030.150753768844], "Splay": [609.4602789569436], "Richards": [165.31658125309968], "RegExp": [26025.641025641027], "Earley": [805.8017727639001], "Boyer": [11847.058823529413], "RayTrace": [2000.0]}, "summary": {"lowerIsBetter": false, "suite": 19858.112951589825, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 345.99549399999995, "unit": "score", "value": 345.99549399999995}, "Encrypt": {"lowerIsBetter": false, "filtered": 949.2014460000001, "unit": "score", "value": 949.2014460000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.91710189810189, "unit": "score", "value": 52.91710189810189}, "Splay": {"lowerIsBetter": false, "filtered": 133.7101084577115, "unit": "score", "value": 133.7101084577115}, "RegExp": {"lowerIsBetter": false, "filtered": 35.003364532019674, "unit": "score", "value": 35.003364532019674}, "Richards": {"lowerIsBetter": false, "filtered": 213.54179800000009, "unit": "score", "value": 213.54179800000009}, "Earley": {"lowerIsBetter": false, "filtered": 827.0805830000004, "unit": "score", "value": 827.0805830000004}, "Boyer": {"lowerIsBetter": false, "filtered": 56.255566037735804, "unit": "score", "value": 56.255566037735804}, "RayTrace": {"lowerIsBetter": false, "filtered": 369.9945, "unit": "score", "value": 369.9945}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-029"}, "testrun": {"date": 1447298856, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111171445", "branch": "Fx-Team-Non-PGO", "revision": "eb938e57286dfc4021f6b83e10d51d9f94534134"}}] 19:47:55 INFO - RETURN: dromaeo_css: 6121.70 19:47:55 INFO - RETURN: kraken: 1508.60 19:47:55 INFO - RETURN: v8_7: 19858.11 19:47:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19858.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1508.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6121.70"}}} 19:47:55 INFO - Return code: 0 19:47:55 INFO - # TBPL SUCCESS # 19:47:55 INFO - Running post-action listener: _resource_record_post_action 19:47:55 INFO - Running post-run listener: _resource_record_post_run 19:47:56 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 10530816; Write bytes: 400826368; Read time: 2952; Write time: 290852 19:47:56 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 3694592; Read time: 0; Write time: 304 19:47:56 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8265728; Write bytes: 397131776; Read time: 2712; Write time: 290548 19:47:56 INFO - Running post-run listener: _upload_blobber_files 19:47:56 INFO - Blob upload gear active. 19:47:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:47:56 INFO - Copying logs to upload dir... 19:47:56 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.219149 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-11 19:47:56.998913) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 19:47:57.002268) ========= 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=1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009767 build_url: 'https://queue.taskcluster.net/v1/task/CNjmsuoTQ12Z4UaN6l5gTA/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-11-11 19:47:57.054155) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:47:57.054487) ========= 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=1d09c2d9237d126f9c84bbb400000198-1447298099.269099-1640802866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:47:57.103655) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 19:47:57.103968) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 19:47:57.104249) ========= ========= Total master_lag: 0.25 =========