builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-033 starttime: 1452925400.76 results: success (0) buildid: 20160115220505 builduid: 86c33c6eac714f19908b3aed969e6a89 revision: dc5742de08235de4bc270189dc248d72db476068 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:20.762145) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:20.762568) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:20.763037) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006319 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:20.788581) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:20.788862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:20.802515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:20.802796) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:20.851036) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:20.851317) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:20.854667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:20.854939) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 22:23:20-- 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% 35.6M=0s 2016-01-15 22:23:21 (35.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158930 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:21.025493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:21.025787) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020479 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:21.078349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:21.078719) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dc5742de08235de4bc270189dc248d72db476068 --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 dc5742de08235de4bc270189dc248d72db476068 --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=edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 22:23:21,129 truncating revision to first 12 chars 2016-01-15 22:23:21,129 Setting DEBUG logging. 2016-01-15 22:23:21,129 attempt 1/10 2016-01-15 22:23:21,129 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dc5742de0823?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 22:23:21,391 unpacking tar archive at: fx-team-dc5742de0823/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571039 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:21.665255) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:21.668578) ========= echo '%(revision)s' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004700 script_repo_revision: '%(revision)s' ========= master_lag: 0.08 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:21.755181) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:21.755520) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:21.765961) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:21.766507) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 22:23:21.766933) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-01-15 22:23:21.767208) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:23:21 INFO - MultiFileLogger online at 20160115 22:23:21 in /builds/slave/test 22:23:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:23:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:23:21 INFO - {'append_to_log': False, 22:23:21 INFO - 'base_work_dir': '/builds/slave/test', 22:23:21 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:23:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:23:21 INFO - 'branch': 'Fx-Team-Non-PGO', 22:23:21 INFO - 'buildbot_json_path': 'buildprops.json', 22:23:21 INFO - 'config_files': ('talos/linux_config.py',), 22:23:21 INFO - 'default_actions': ('clobber', 22:23:21 INFO - 'read-buildbot-config', 22:23:21 INFO - 'download-and-extract', 22:23:21 INFO - 'populate-webroot', 22:23:21 INFO - 'create-virtualenv', 22:23:21 INFO - 'install', 22:23:21 INFO - 'run-tests'), 22:23:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:23:21 INFO - 'download_minidump_stackwalk': True, 22:23:21 INFO - 'download_symbols': 'ondemand', 22:23:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:23:21 INFO - 'tooltool.py': '/tools/tooltool.py', 22:23:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:23:21 INFO - '/tools/misc-python/virtualenv.py')}, 22:23:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:23:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:23:21 INFO - 'installer_path': 'installer.exe', 22:23:21 INFO - 'log_level': 'info', 22:23:21 INFO - 'log_name': 'talos', 22:23:21 INFO - 'log_to_console': True, 22:23:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:23:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:23:21 INFO - 'opt_config_files': (), 22:23:21 INFO - 'pip_index': False, 22:23:21 INFO - 'sps_profile': False, 22:23:21 INFO - 'sps_profile_interval': 0, 22:23:21 INFO - 'suite': 'dromaeojs-e10s', 22:23:21 INFO - 'system_bits': '32', 22:23:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:23:21 INFO - 'title': 'talos-linux64-ix-033', 22:23:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:23:21 INFO - 'use_talos_json': True, 22:23:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:23:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:23:21 INFO - 'work_dir': 'build'} 22:23:21 INFO - ##### 22:23:21 INFO - ##### Running clobber step. 22:23:21 INFO - ##### 22:23:21 INFO - Running pre-action listener: _resource_record_pre_action 22:23:21 INFO - Running main action method: clobber 22:23:21 INFO - rmtree: /builds/slave/test/build 22:23:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:23:22 INFO - Running post-action listener: _resource_record_post_action 22:23:22 INFO - ##### 22:23:22 INFO - ##### Running read-buildbot-config step. 22:23:22 INFO - ##### 22:23:22 INFO - Running pre-action listener: _resource_record_pre_action 22:23:22 INFO - Running main action method: read_buildbot_config 22:23:22 INFO - Using buildbot properties: 22:23:22 INFO - { 22:23:22 INFO - "project": "", 22:23:22 INFO - "product": "firefox", 22:23:22 INFO - "script_repo_revision": "production", 22:23:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:23:22 INFO - "repository": "", 22:23:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:23:22 INFO - "buildid": "20160115220505", 22:23:22 INFO - "pgo_build": "False", 22:23:22 INFO - "basedir": "/builds/slave/test", 22:23:22 INFO - "buildnumber": 705, 22:23:22 INFO - "slavename": "talos-linux64-ix-033", 22:23:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:23:22 INFO - "platform": "ubuntu64_hw", 22:23:22 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:23:22 INFO - "branch": "fx-team", 22:23:22 INFO - "repo_path": "integration/fx-team", 22:23:22 INFO - "revision": "dc5742de08235de4bc270189dc248d72db476068", 22:23:22 INFO - "stage_platform": "linux64", 22:23:22 INFO - "builduid": "86c33c6eac714f19908b3aed969e6a89", 22:23:22 INFO - "slavebuilddir": "test" 22:23:22 INFO - } 22:23:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:23:22 INFO - Running post-action listener: _resource_record_post_action 22:23:22 INFO - ##### 22:23:22 INFO - ##### Running download-and-extract step. 22:23:22 INFO - ##### 22:23:22 INFO - Running pre-action listener: _resource_record_pre_action 22:23:22 INFO - Running main action method: download_and_extract 22:23:22 INFO - mkdir: /builds/slave/test/build/tests 22:23:22 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')]} 22:23:22 INFO - https://queue.taskcluster.net/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:23:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/test_packages.json 22:23:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/test_packages.json 22:23:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:23:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:23:26 INFO - Downloaded 1448 bytes. 22:23:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:23:26 INFO - Using the following test package requirements: 22:23:26 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:23:26 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:23:26 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:23:26 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:26 INFO - u'jsshell-linux-x86_64.zip'], 22:23:26 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:23:26 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:23:26 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:23:26 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:23:26 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:23:26 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:23:26 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:23:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:23:26 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:26 INFO - https://queue.taskcluster.net/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:23:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:23:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:23:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:23:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:23:39 INFO - Downloaded 21173191 bytes. 22:23:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:23:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:23:40 INFO - Return code: 0 22:23:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:23:40 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')]} 22:23:40 INFO - https://queue.taskcluster.net/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:23:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:23:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:23:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:23:44 INFO - Downloaded 21173191 bytes. 22:23:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:23:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:23:46 INFO - Return code: 0 22:23: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')]} 22:23:46 INFO - https://queue.taskcluster.net/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:23:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:23:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:23:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:23:48 INFO - Downloaded 11132144 bytes. 22:23:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:23:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:23:48 INFO - Return code: 0 22:23: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')]} 22:23:48 INFO - https://queue.taskcluster.net/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:23:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:23:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:23:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:23:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:23:51 INFO - Downloaded 54130203 bytes. 22:23:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:23:51 INFO - mkdir: /builds/slave/test/properties 22:23:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:23:51 INFO - Writing to file /builds/slave/test/properties/build_url 22:23:51 INFO - Contents: 22:23:51 INFO - build_url:https://queue.taskcluster.net/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:23:51 INFO - Running post-action listener: _resource_record_post_action 22:23:51 INFO - Running post-action listener: set_extra_try_arguments 22:23:51 INFO - ##### 22:23:51 INFO - ##### Running populate-webroot step. 22:23:51 INFO - ##### 22:23:51 INFO - Running pre-action listener: _resource_record_pre_action 22:23:51 INFO - Running main action method: populate_webroot 22:23:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:23:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:23:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:23:51 INFO - '--tppagecycles', 22:23:51 INFO - '7'], 22:23:51 INFO - 'tests': ['tsvgm']}}, 22:23:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:23:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:23:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:23:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:23:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:23:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:23:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:23:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:51 INFO - 'talos_options': ['--e10s'], 22:23:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:23:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:51 INFO - 'tests': ['damp', 'tps']}, 22:23:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:51 INFO - 'talos_options': ['--e10s'], 22:23:51 INFO - 'tests': ['damp', 'tps']}, 22:23:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:23:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:23:51 INFO - 'other': {'tests': ['a11yr', 22:23:51 INFO - 'ts_paint', 22:23:51 INFO - 'tpaint', 22:23:51 INFO - 'sessionrestore', 22:23:51 INFO - 'sessionrestore_no_auto_restore']}, 22:23:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:23:51 INFO - 'tests': ['a11yr', 22:23:51 INFO - 'ts_paint', 22:23:51 INFO - 'tpaint', 22:23:51 INFO - 'sessionrestore', 22:23:51 INFO - 'sessionrestore_no_auto_restore']}, 22:23:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:23:51 INFO - 'tests': ['a11yr', 22:23:51 INFO - 'ts_paint', 22:23:51 INFO - 'tpaint', 22:23:51 INFO - 'sessionrestore', 22:23:51 INFO - 'sessionrestore_no_auto_restore']}, 22:23:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:23:51 INFO - 'tests': ['a11yr', 22:23:51 INFO - 'ts_paint', 22:23:51 INFO - 'tpaint', 22:23:51 INFO - 'sessionrestore', 22:23:51 INFO - 'sessionrestore_no_auto_restore']}, 22:23:51 INFO - 'other_l64': {'tests': ['a11yr', 22:23:51 INFO - 'ts_paint', 22:23:51 INFO - 'tpaint', 22:23:51 INFO - 'sessionrestore', 22:23:51 INFO - 'sessionrestore_no_auto_restore']}, 22:23:51 INFO - 'other_nol64': {'tests': ['a11yr', 22:23:51 INFO - 'ts_paint', 22:23:51 INFO - 'tpaint', 22:23:51 INFO - 'sessionrestore', 22:23:51 INFO - 'sessionrestore_no_auto_restore']}, 22:23:51 INFO - 'svgr': {'tests': ['tsvgx', 22:23:51 INFO - 'tsvgr_opacity', 22:23:51 INFO - 'tart', 22:23:51 INFO - 'tscrollx', 22:23:51 INFO - 'cart']}, 22:23:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:23:51 INFO - 'tests': ['tsvgx', 22:23:51 INFO - 'tsvgr_opacity', 22:23:51 INFO - 'tart', 22:23:51 INFO - 'tscrollx', 22:23:51 INFO - 'cart']}, 22:23:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:51 INFO - 'tests': ['tp5o']}, 22:23:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:51 INFO - 'talos_options': ['--e10s'], 22:23:51 INFO - 'tests': ['tp5o']}, 22:23:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:51 INFO - 'talos_options': ['--xperf_path', 22:23:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:23:51 INFO - 'tests': ['tp5n']}, 22:23:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:51 INFO - 'talos_options': ['--e10s', 22:23:51 INFO - '--xperf_path', 22:23:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:23:51 INFO - 'tests': ['tp5n']}}, 22:23:51 INFO - 'talos.zip': {'path': '', 22:23:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:23:51 INFO - Running post-action listener: _resource_record_post_action 22:23:51 INFO - ##### 22:23:51 INFO - ##### Running create-virtualenv step. 22:23:51 INFO - ##### 22:23:51 INFO - Running pre-action listener: _resource_record_pre_action 22:23:51 INFO - Running main action method: create_virtualenv 22:23:51 INFO - Creating virtualenv /builds/slave/test/build/venv 22:23:51 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 22:23:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:23:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:23:51 INFO - Using real prefix '/usr' 22:23:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:23:51 INFO - Installing distribute.............................................................................................................................................................................................done. 22:23:53 INFO - Installing pip.................done. 22:23:53 INFO - Return code: 0 22:23:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:53 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 0x7f5144f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a3d0>, '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 0x1785ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1786360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', '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 22:23:53 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 22:23:53 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 22:23:53 INFO - Using env: {'DISPLAY': ':0', 22:23:53 INFO - 'HOME': '/home/cltbld', 22:23:53 INFO - 'LANG': 'en_US.UTF-8', 22:23:53 INFO - 'LANGUAGE': 'en_US:en', 22:23:53 INFO - 'LOGNAME': 'cltbld', 22:23:53 INFO - 'MAIL': '/var/mail/cltbld', 22:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:53 INFO - 'MOZ_NO_REMOTE': '1', 22:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:53 INFO - 'NO_EM_RESTART': '1', 22:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:53 INFO - 'PWD': '/builds/slave/test', 22:23:53 INFO - 'SHELL': '/bin/bash', 22:23:53 INFO - 'SHLVL': '1', 22:23:53 INFO - 'TERM': 'linux', 22:23:53 INFO - 'TMOUT': '86400', 22:23:53 INFO - 'USER': 'cltbld', 22:23:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', 22:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:53 INFO - '_': '/tools/buildbot/bin/python'} 22:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:54 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 22:23:54 INFO - Cleaning up... 22:23:54 INFO - Return code: 0 22:23:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:54 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 0x7f5144f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a3d0>, '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 0x1785ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1786360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', '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 22:23:54 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 22:23:54 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 22:23:54 INFO - Using env: {'DISPLAY': ':0', 22:23:54 INFO - 'HOME': '/home/cltbld', 22:23:54 INFO - 'LANG': 'en_US.UTF-8', 22:23:54 INFO - 'LANGUAGE': 'en_US:en', 22:23:54 INFO - 'LOGNAME': 'cltbld', 22:23:54 INFO - 'MAIL': '/var/mail/cltbld', 22:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:54 INFO - 'MOZ_NO_REMOTE': '1', 22:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:54 INFO - 'NO_EM_RESTART': '1', 22:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:54 INFO - 'PWD': '/builds/slave/test', 22:23:54 INFO - 'SHELL': '/bin/bash', 22:23:54 INFO - 'SHLVL': '1', 22:23:54 INFO - 'TERM': 'linux', 22:23:54 INFO - 'TMOUT': '86400', 22:23:54 INFO - 'USER': 'cltbld', 22:23:54 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', 22:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:54 INFO - '_': '/tools/buildbot/bin/python'} 22:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:54 INFO - Downloading/unpacking psutil>=0.7.1 22:23:54 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 22:23:54 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 22:23:54 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 22:23:54 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 22:23:54 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 22:23:54 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 22:23:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:23:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:23:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:23:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:23:56 INFO - Installing collected packages: psutil 22:23:56 INFO - Running setup.py install for psutil 22:23:56 INFO - building 'psutil._psutil_linux' extension 22:23:56 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 22:23:56 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 22:23:56 INFO - building 'psutil._psutil_posix' extension 22:23:56 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 22:23:56 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 22:23:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:23:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:23:56 INFO - Successfully installed psutil 22:23:56 INFO - Cleaning up... 22:23:56 INFO - Return code: 0 22:23:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:56 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 0x7f5144f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a3d0>, '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 0x1785ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1786360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', '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 22:23:56 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 22:23:56 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 22:23:56 INFO - Using env: {'DISPLAY': ':0', 22:23:56 INFO - 'HOME': '/home/cltbld', 22:23:56 INFO - 'LANG': 'en_US.UTF-8', 22:23:56 INFO - 'LANGUAGE': 'en_US:en', 22:23:56 INFO - 'LOGNAME': 'cltbld', 22:23:56 INFO - 'MAIL': '/var/mail/cltbld', 22:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:56 INFO - 'MOZ_NO_REMOTE': '1', 22:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:56 INFO - 'NO_EM_RESTART': '1', 22:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:56 INFO - 'PWD': '/builds/slave/test', 22:23:56 INFO - 'SHELL': '/bin/bash', 22:23:56 INFO - 'SHLVL': '1', 22:23:56 INFO - 'TERM': 'linux', 22:23:56 INFO - 'TMOUT': '86400', 22:23:56 INFO - 'USER': 'cltbld', 22:23:56 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', 22:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:56 INFO - '_': '/tools/buildbot/bin/python'} 22:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:23:56 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 22:23:56 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 22:23:56 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 22:23:56 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 22:23:56 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 22:23:56 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 22:23:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:23:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:23:58 INFO - Installing collected packages: mozsystemmonitor 22:23:58 INFO - Running setup.py install for mozsystemmonitor 22:23:58 INFO - Successfully installed mozsystemmonitor 22:23:58 INFO - Cleaning up... 22:23:58 INFO - Return code: 0 22:23:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:23:58 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')]} 22:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:58 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')]} 22:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:58 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 0x7f5144f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a3d0>, '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 0x1785ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1786360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', '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 22:23:58 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 22:23:58 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 22:23:58 INFO - Using env: {'DISPLAY': ':0', 22:23:58 INFO - 'HOME': '/home/cltbld', 22:23:58 INFO - 'LANG': 'en_US.UTF-8', 22:23:58 INFO - 'LANGUAGE': 'en_US:en', 22:23:58 INFO - 'LOGNAME': 'cltbld', 22:23:58 INFO - 'MAIL': '/var/mail/cltbld', 22:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:58 INFO - 'MOZ_NO_REMOTE': '1', 22:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:58 INFO - 'NO_EM_RESTART': '1', 22:23:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:58 INFO - 'PWD': '/builds/slave/test', 22:23:58 INFO - 'SHELL': '/bin/bash', 22:23:58 INFO - 'SHLVL': '1', 22:23:58 INFO - 'TERM': 'linux', 22:23:58 INFO - 'TMOUT': '86400', 22:23:58 INFO - 'USER': 'cltbld', 22:23:58 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', 22:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:58 INFO - '_': '/tools/buildbot/bin/python'} 22:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:58 INFO - Downloading/unpacking blobuploader==1.2.4 22:23:58 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 22:23:58 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 22:23:58 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 22:23:58 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 22:23:58 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 22:23:58 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 22:24:00 INFO - Downloading blobuploader-1.2.4.tar.gz 22:24:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:24:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:24:00 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 22:24:00 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 22:24:00 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 22:24:00 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 22:24:00 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 22:24:00 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 22:24:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:24:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:24:01 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 22:24:01 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 22:24:01 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 22:24:01 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 22:24:01 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 22:24:01 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 22:24:01 INFO - Downloading docopt-0.6.1.tar.gz 22:24:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:24:01 INFO - Installing collected packages: blobuploader, requests, docopt 22:24:01 INFO - Running setup.py install for blobuploader 22:24:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:24:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:24:01 INFO - Running setup.py install for requests 22:24:01 INFO - Running setup.py install for docopt 22:24:01 INFO - Successfully installed blobuploader requests docopt 22:24:01 INFO - Cleaning up... 22:24:01 INFO - Return code: 0 22:24:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:01 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 0x7f5144f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a3d0>, '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 0x1785ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1786360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', '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 22:24:01 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 22:24:01 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 22:24:01 INFO - Using env: {'DISPLAY': ':0', 22:24:01 INFO - 'HOME': '/home/cltbld', 22:24:01 INFO - 'LANG': 'en_US.UTF-8', 22:24:01 INFO - 'LANGUAGE': 'en_US:en', 22:24:01 INFO - 'LOGNAME': 'cltbld', 22:24:01 INFO - 'MAIL': '/var/mail/cltbld', 22:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:01 INFO - 'MOZ_NO_REMOTE': '1', 22:24:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:01 INFO - 'NO_EM_RESTART': '1', 22:24:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:01 INFO - 'PWD': '/builds/slave/test', 22:24:01 INFO - 'SHELL': '/bin/bash', 22:24:01 INFO - 'SHLVL': '1', 22:24:01 INFO - 'TERM': 'linux', 22:24:01 INFO - 'TMOUT': '86400', 22:24:01 INFO - 'USER': 'cltbld', 22:24:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', 22:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:01 INFO - '_': '/tools/buildbot/bin/python'} 22:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:24:02 INFO - Running setup.py (path:/tmp/pip-N4HO_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:24:02 INFO - Running setup.py (path:/tmp/pip-wlBPdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:24:02 INFO - Running setup.py (path:/tmp/pip-J1KZwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:24:02 INFO - Running setup.py (path:/tmp/pip-GfQq4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:24:02 INFO - Running setup.py (path:/tmp/pip-lNFguY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:24:02 INFO - Running setup.py (path:/tmp/pip-0_dimV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:24:02 INFO - Running setup.py (path:/tmp/pip-ZkYjbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:24:02 INFO - Running setup.py (path:/tmp/pip-IuZKTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:24:02 INFO - Running setup.py (path:/tmp/pip-kVL8eK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:24:02 INFO - Running setup.py (path:/tmp/pip-Bt56UR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:24:02 INFO - Running setup.py (path:/tmp/pip-6FiR3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:24:02 INFO - Running setup.py (path:/tmp/pip-iXA1PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:24:03 INFO - Running setup.py (path:/tmp/pip-BJHydC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:24:03 INFO - Running setup.py (path:/tmp/pip-jqz9F_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:03 INFO - Running setup.py (path:/tmp/pip-HleRjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:24:03 INFO - Running setup.py (path:/tmp/pip-d8Fp7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:24:03 INFO - Running setup.py (path:/tmp/pip-ii9uZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:24:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:24:03 INFO - Running setup.py install for manifestparser 22:24:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:24:03 INFO - Running setup.py install for mozcrash 22:24:03 INFO - Running setup.py install for mozdebug 22:24:03 INFO - Running setup.py install for mozdevice 22:24:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:24:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:24:03 INFO - Running setup.py install for mozfile 22:24:03 INFO - Running setup.py install for mozhttpd 22:24:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:24:04 INFO - Running setup.py install for mozinfo 22:24:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:24:04 INFO - Running setup.py install for mozInstall 22:24:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:24:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:24:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:24:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:24:04 INFO - Running setup.py install for mozleak 22:24:04 INFO - Running setup.py install for mozlog 22:24:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:24:04 INFO - Running setup.py install for moznetwork 22:24:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:24:04 INFO - Running setup.py install for mozprocess 22:24:04 INFO - Running setup.py install for mozprofile 22:24:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:24:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:24:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:24:04 INFO - Running setup.py install for mozrunner 22:24:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:24:04 INFO - Running setup.py install for mozscreenshot 22:24:04 INFO - Running setup.py install for moztest 22:24:05 INFO - Running setup.py install for mozversion 22:24:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:24:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:24:05 INFO - Cleaning up... 22:24:05 INFO - Return code: 0 22:24:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24: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')]} 22:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24: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')]} 22:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24: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', '-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 0x7f5144f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a3d0>, '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 0x1785ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1786360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', '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 22:24:05 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 22:24:05 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 22:24:05 INFO - Using env: {'DISPLAY': ':0', 22:24:05 INFO - 'HOME': '/home/cltbld', 22:24:05 INFO - 'LANG': 'en_US.UTF-8', 22:24:05 INFO - 'LANGUAGE': 'en_US:en', 22:24:05 INFO - 'LOGNAME': 'cltbld', 22:24:05 INFO - 'MAIL': '/var/mail/cltbld', 22:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:05 INFO - 'MOZ_NO_REMOTE': '1', 22:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:05 INFO - 'NO_EM_RESTART': '1', 22:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:05 INFO - 'PWD': '/builds/slave/test', 22:24:05 INFO - 'SHELL': '/bin/bash', 22:24:05 INFO - 'SHLVL': '1', 22:24:05 INFO - 'TERM': 'linux', 22:24:05 INFO - 'TMOUT': '86400', 22:24:05 INFO - 'USER': 'cltbld', 22:24:05 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', 22:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:05 INFO - '_': '/tools/buildbot/bin/python'} 22:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:24:05 INFO - Running setup.py (path:/tmp/pip-pOvxiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:24:05 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)) 22:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:24:05 INFO - Running setup.py (path:/tmp/pip-M79UsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:24:05 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)) 22:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:24:05 INFO - Running setup.py (path:/tmp/pip-lQSwL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:24:05 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)) 22:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:24:05 INFO - Running setup.py (path:/tmp/pip-wTclty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:24:05 INFO - Running setup.py (path:/tmp/pip-hUwOYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:24:05 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)) 22:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:24:05 INFO - Running setup.py (path:/tmp/pip-2nXngL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:24:05 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)) 22:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:24:05 INFO - Running setup.py (path:/tmp/pip-LNri2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:24:05 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)) 22:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:24:05 INFO - Running setup.py (path:/tmp/pip-dTcyOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:24:05 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)) 22:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:24:05 INFO - Running setup.py (path:/tmp/pip-ejGbEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:24:06 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)) 22:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:24:06 INFO - Running setup.py (path:/tmp/pip-4g90U9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:24:06 INFO - Running setup.py (path:/tmp/pip-yCrBAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:24:06 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)) 22:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:24:06 INFO - Running setup.py (path:/tmp/pip-Eg2yuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:24:06 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)) 22:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:24:06 INFO - Running setup.py (path:/tmp/pip-jzHOx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:24:06 INFO - Running setup.py (path:/tmp/pip-VnR1j_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:24:06 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)) 22:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:06 INFO - Running setup.py (path:/tmp/pip-9It6d0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:06 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)) 22:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:24:06 INFO - Running setup.py (path:/tmp/pip-aPRGyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:24:06 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)) 22:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:24:06 INFO - Running setup.py (path:/tmp/pip-AFOo87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:24:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:24: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 22:24: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 22:24: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 22:24: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 22:24: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 22:24: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 22:24:09 INFO - Downloading blessings-1.5.1.tar.gz 22:24:09 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 22:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:24:09 INFO - Installing collected packages: blessings 22:24:09 INFO - Running setup.py install for blessings 22:24:09 INFO - Successfully installed blessings 22:24:09 INFO - Cleaning up... 22:24:09 INFO - Return code: 0 22:24:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:24:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:24:09 INFO - Reading from file tmpfile_stdout 22:24:09 INFO - Current package versions: 22:24:09 INFO - argparse == 1.2.1 22:24:09 INFO - blessings == 1.5.1 22:24:09 INFO - blobuploader == 1.2.4 22:24:09 INFO - docopt == 0.6.1 22:24:09 INFO - manifestparser == 1.1 22:24:09 INFO - mozInstall == 1.12 22:24:09 INFO - mozcrash == 0.16 22:24:09 INFO - mozdebug == 0.1 22:24:09 INFO - mozdevice == 0.48 22:24:09 INFO - mozfile == 1.2 22:24:09 INFO - mozhttpd == 0.7 22:24:09 INFO - mozinfo == 0.9 22:24:09 INFO - mozleak == 0.1 22:24:09 INFO - mozlog == 3.1 22:24:09 INFO - moznetwork == 0.27 22:24:09 INFO - mozprocess == 0.22 22:24:09 INFO - mozprofile == 0.28 22:24:09 INFO - mozrunner == 6.11 22:24:09 INFO - mozscreenshot == 0.1 22:24:09 INFO - mozsystemmonitor == 0.0 22:24:09 INFO - moztest == 0.7 22:24:09 INFO - mozversion == 1.4 22:24:09 INFO - psutil == 3.1.1 22:24:09 INFO - requests == 1.2.3 22:24:09 INFO - wsgiref == 0.1.2 22:24:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24: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')]} 22:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24: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')]} 22:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24: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', '-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 0x7f5144f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a3d0>, '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 0x1785ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1786360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', '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 22:24:09 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 22:24:09 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 22:24:09 INFO - Using env: {'DISPLAY': ':0', 22:24:09 INFO - 'HOME': '/home/cltbld', 22:24:09 INFO - 'LANG': 'en_US.UTF-8', 22:24:09 INFO - 'LANGUAGE': 'en_US:en', 22:24:09 INFO - 'LOGNAME': 'cltbld', 22:24:09 INFO - 'MAIL': '/var/mail/cltbld', 22:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:09 INFO - 'MOZ_NO_REMOTE': '1', 22:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:09 INFO - 'NO_EM_RESTART': '1', 22:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:09 INFO - 'PWD': '/builds/slave/test', 22:24:09 INFO - 'SHELL': '/bin/bash', 22:24:09 INFO - 'SHLVL': '1', 22:24:09 INFO - 'TERM': 'linux', 22:24:09 INFO - 'TMOUT': '86400', 22:24:09 INFO - 'USER': 'cltbld', 22:24:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', 22:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:09 INFO - '_': '/tools/buildbot/bin/python'} 22:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:24:10 INFO - Cleaning up... 22:24:10 INFO - Return code: 0 22:24:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5144f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a3d0>, '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 0x1785ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1786360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', '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 22:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:24:10 INFO - Using env: {'DISPLAY': ':0', 22:24:10 INFO - 'HOME': '/home/cltbld', 22:24:10 INFO - 'LANG': 'en_US.UTF-8', 22:24:10 INFO - 'LANGUAGE': 'en_US:en', 22:24:10 INFO - 'LOGNAME': 'cltbld', 22:24:10 INFO - 'MAIL': '/var/mail/cltbld', 22:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:10 INFO - 'MOZ_NO_REMOTE': '1', 22:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:10 INFO - 'NO_EM_RESTART': '1', 22:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:10 INFO - 'PWD': '/builds/slave/test', 22:24:10 INFO - 'SHELL': '/bin/bash', 22:24:10 INFO - 'SHLVL': '1', 22:24:10 INFO - 'TERM': 'linux', 22:24:10 INFO - 'TMOUT': '86400', 22:24:10 INFO - 'USER': 'cltbld', 22:24:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', 22:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:10 INFO - '_': '/tools/buildbot/bin/python'} 22:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:10 INFO - Downloading/unpacking jsonschema 22:24:10 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 22:24:10 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 22:24:10 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 22:24:10 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 22:24:10 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 22:24:10 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 22:24:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:24:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 22:24:11 INFO - Downloading/unpacking functools32 (from jsonschema) 22:24: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 22:24: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 22:24: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 22:24: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 22:24: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 22:24: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 22:24:12 INFO - Downloading functools32-3.2.3-2.tar.gz 22:24:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:24:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:24:12 INFO - warning: no files found matching '*.txt' 22:24:12 INFO - no previously-included directories found matching 'build' 22:24:12 INFO - no previously-included directories found matching 'dist' 22:24:12 INFO - no previously-included directories found matching '.git*' 22:24:12 INFO - Installing collected packages: jsonschema, functools32 22:24:12 INFO - Running setup.py install for functools32 22:24:12 INFO - warning: no files found matching '*.txt' 22:24:12 INFO - no previously-included directories found matching 'build' 22:24:12 INFO - no previously-included directories found matching 'dist' 22:24:12 INFO - no previously-included directories found matching '.git*' 22:24:12 INFO - Successfully installed jsonschema functools32 22:24:12 INFO - Cleaning up... 22:24:12 INFO - Return code: 0 22:24:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5144f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a3d0>, '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 0x1785ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1786360>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', '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 22:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:24:12 INFO - Using env: {'DISPLAY': ':0', 22:24:12 INFO - 'HOME': '/home/cltbld', 22:24:12 INFO - 'LANG': 'en_US.UTF-8', 22:24:12 INFO - 'LANGUAGE': 'en_US:en', 22:24:12 INFO - 'LOGNAME': 'cltbld', 22:24:12 INFO - 'MAIL': '/var/mail/cltbld', 22:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:12 INFO - 'MOZ_NO_REMOTE': '1', 22:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:12 INFO - 'NO_EM_RESTART': '1', 22:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:12 INFO - 'PWD': '/builds/slave/test', 22:24:12 INFO - 'SHELL': '/bin/bash', 22:24:12 INFO - 'SHLVL': '1', 22:24:12 INFO - 'TERM': 'linux', 22:24:12 INFO - 'TMOUT': '86400', 22:24:12 INFO - 'USER': 'cltbld', 22:24:12 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', 22:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:12 INFO - '_': '/tools/buildbot/bin/python'} 22:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:12 INFO - Downloading/unpacking flake8 22:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:24:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 22:24:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:24:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 22:24:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 22:24:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:24:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:24:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:24:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:24:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:24:15 INFO - no previously-included directories found matching 'docs/_build' 22:24:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:24:15 INFO - Running setup.py install for pep8 22:24:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:24:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:24:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:24:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:24:15 INFO - no previously-included directories found matching 'docs/_build' 22:24:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:24:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:24:15 INFO - Cleaning up... 22:24:15 INFO - Return code: 0 22:24:15 INFO - Running post-action listener: _resource_record_post_action 22:24:15 INFO - Running post-action listener: _start_resource_monitoring 22:24:15 INFO - Starting resource monitoring. 22:24:15 INFO - ##### 22:24:15 INFO - ##### Running install step. 22:24:15 INFO - ##### 22:24:15 INFO - Running pre-action listener: _resource_record_pre_action 22:24:15 INFO - Running main action method: install 22:24:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:24:15 INFO - Reading from file tmpfile_stdout 22:24:15 INFO - Detecting whether we're running mozinstall >=1.0... 22:24:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:24:15 INFO - Reading from file tmpfile_stdout 22:24:15 INFO - Output received: 22:24:15 INFO - Usage: mozinstall [options] installer 22:24:15 INFO - Options: 22:24:15 INFO - -h, --help show this help message and exit 22:24:15 INFO - -d DEST, --destination=DEST 22:24:15 INFO - Directory to install application into. [default: 22:24:15 INFO - "/builds/slave/test"] 22:24:15 INFO - --app=APP Application being installed. [default: firefox] 22:24:15 INFO - mkdir: /builds/slave/test/build/application 22:24:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:24:31 INFO - Reading from file tmpfile_stdout 22:24:31 INFO - Output received: 22:24:31 INFO - /builds/slave/test/build/application/firefox/firefox 22:24:31 INFO - Running post-action listener: _resource_record_post_action 22:24:31 INFO - ##### 22:24:31 INFO - ##### Running run-tests step. 22:24:31 INFO - ##### 22:24:31 INFO - Running pre-action listener: _resource_record_pre_action 22:24:31 INFO - Running main action method: run_tests 22:24:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:24:31 INFO - Python 2.7.3 22:24:31 INFO - Return code: 0 22:24:31 INFO - grabbing minidump binary from tooltool 22:24:31 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')]} 22:24:31 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 0x181a3d0>, '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 0x1785ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1786360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:24:31 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 22:24:31 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 22:24:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:24:31 INFO - Return code: 0 22:24:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:24:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:24:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:24:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:24:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:24:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:24:32 INFO - Return code: 0 22:24:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:24:32 INFO - Using env: {'DISPLAY': ':0', 22:24:32 INFO - 'HOME': '/home/cltbld', 22:24:32 INFO - 'LANG': 'en_US.UTF-8', 22:24:32 INFO - 'LANGUAGE': 'en_US:en', 22:24:32 INFO - 'LOGNAME': 'cltbld', 22:24:32 INFO - 'MAIL': '/var/mail/cltbld', 22:24:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:24:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:32 INFO - 'MOZ_NO_REMOTE': '1', 22:24:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:24:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:32 INFO - 'NO_EM_RESTART': '1', 22:24:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:32 INFO - 'PWD': '/builds/slave/test', 22:24:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:24:32 INFO - 'SHELL': '/bin/bash', 22:24:32 INFO - 'SHLVL': '1', 22:24:32 INFO - 'TERM': 'linux', 22:24:32 INFO - 'TMOUT': '86400', 22:24:32 INFO - 'USER': 'cltbld', 22:24:32 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681', 22:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:32 INFO - '_': '/tools/buildbot/bin/python'} 22:24:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:24:32 INFO - mozversion application_buildid: 20160115220505 22:24:32 INFO - mozversion application_changeset: dc5742de08235de4bc270189dc248d72db476068 22:24:32 INFO - mozversion application_display_name: Nightly 22:24:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:24:32 INFO - mozversion application_name: Firefox 22:24:32 INFO - mozversion application_remotingname: firefox 22:24:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:24:32 INFO - mozversion application_vendor: Mozilla 22:24:32 INFO - mozversion application_version: 46.0a1 22:24:32 INFO - mozversion platform_buildid: 20160115220505 22:24:32 INFO - mozversion platform_changeset: dc5742de08235de4bc270189dc248d72db476068 22:24:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:24:32 INFO - mozversion platform_version: 46.0a1 22:24:32 INFO - using testdate: 1452925472 22:24:32 INFO - actual date: 1452925472 22:24:32 INFO - starting webserver on 'localhost:49315' 22:24:32 INFO - SUITE-START | Running 3 tests 22:24:32 INFO - TEST-START | dromaeo_css 22:24:32 INFO - operating with platform_type : linux_ 22:24:32 INFO - Initialising browser for dromaeo_css test... 22:24:32 INFO - TEST-INFO | started process 14613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSYdNak/profile http://localhost:49315/getInfo.html) 22:24:36 INFO - PROCESS | 14613 | 22:24:36 INFO - PROCESS | 14613 | (process:14699): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:24:37 INFO - PROCESS | 14613 | __metrics Screen width/height:1600/1200 22:24:37 INFO - PROCESS | 14613 | colorDepth:24 22:24:37 INFO - PROCESS | 14613 | Browser inner width/height: 1024/697 22:24:37 INFO - PROCESS | 14613 | __metrics 22:24:38 INFO - PROCESS | 14613 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:24:39 INFO - TEST-INFO | 14613: exit 0 22:24:39 INFO - Browser initialized. 22:24:39 INFO - Running cycle 1/1 for dromaeo_css test... 22:24:39 INFO - TEST-INFO | started process 14748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSYdNak/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:24:40 INFO - PROCESS | 14748 | 22:24:40 INFO - PROCESS | 14748 | (process:14803): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:24:51 INFO - PROCESS | 14748 | RSS: Main: 151408640 22:24:51 INFO - PROCESS | 14748 | 22:25:40 INFO - PROCESS | 14748 | 1452925540673 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] 22:27:52 INFO - PROCESS | 14748 | Cycle 1(1): loaded http://localhost:49315/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49315/tests/dromaeo/cssquery-ext.html) 22:27:53 INFO - PROCESS | 14748 | RSS: Main: 155021312 22:27:53 INFO - PROCESS | 14748 | 22:30:55 INFO - PROCESS | 14748 | Cycle 1(1): loaded http://localhost:49315/tests/dromaeo/cssquery-ext.html (next: http://localhost:49315/tests/dromaeo/cssquery-jquery.html) 22:30:56 INFO - PROCESS | 14748 | RSS: Main: 152825856 22:30:56 INFO - PROCESS | 14748 | 22:33:57 INFO - PROCESS | 14748 | Cycle 1(1): loaded http://localhost:49315/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49315/tests/dromaeo/cssquery-mootools.html) 22:33:58 INFO - PROCESS | 14748 | RSS: Main: 151060480 22:33:58 INFO - PROCESS | 14748 | 22:37:00 INFO - PROCESS | 14748 | Cycle 1(1): loaded http://localhost:49315/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49315/tests/dromaeo/cssquery-prototype.html) 22:37:00 INFO - PROCESS | 14748 | RSS: Main: 150712320 22:37:00 INFO - PROCESS | 14748 | 22:40:03 INFO - PROCESS | 14748 | Cycle 1(1): loaded http://localhost:49315/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49315/tests/dromaeo/cssquery-yui.html) 22:40:04 INFO - PROCESS | 14748 | RSS: Main: 150777856 22:40:04 INFO - PROCESS | 14748 | 22:43:06 INFO - PROCESS | 14748 | Cycle 1(1): loaded http://localhost:49315/tests/dromaeo/cssquery-yui.html (next: http://localhost:49315/tests/dromaeo/cssquery-dojo.html) 22:43:07 INFO - PROCESS | 14748 | RSS: Main: 153653248 22:43:07 INFO - PROCESS | 14748 | 22:43:07 INFO - PROCESS | 14748 | __start_tp_report 22:43:07 INFO - PROCESS | 14748 | _x_x_mozilla_page_load 22:43:07 INFO - PROCESS | 14748 | _x_x_mozilla_page_load_details 22:43:07 INFO - PROCESS | 14748 | |i|pagename|runs| 22:43:07 INFO - PROCESS | 14748 | |0;dojo.html;2619.842809431434;2655.0972669292437;2683.8255513391628;2693.0305090167535;2701.1896431070672;4494.438195225597;4609.308603709441;4625.398698169233;4637.721736695797;4667.533246675331;4536.9092618147615;4584.977075114628;4641.071785642876;4647;4648.395708557883;4248.320268756999;4274.209271284807;4301.419308393374;4332.155229730204;4366.170427618758;4243.9814444533395;4256.744595324275;4298.9785051074705;4320.265554855682;4342.283523218665;4171.249175148502;4216.304309788881;4237.724547904377;4262.7655478948645;4279.293916503773;4268.807903644343;4285.442892423996;4286.6570674346285;4296.119295544406;4324.632406245473;4293.527711951683;4294.398784170218;4295.957040429587;4312.266914624522;4332.523422423531;4369.169857727022;4476.239039363316;4544.727316361029;4593.265077587604;4625.583697467244;4855.4901735317635;4880.316755654211;4885.926711099336;4907.828226012072;4936.605071594264;4738.384010078667;4922.507749225085;4933.901321973576;4936.086823937547;4987.226979818134;4554.43069616298;4569.1547063793305;4575.130725162208;4589.954100459019;4626.930596041062;4979.526944940225;5023.522765337287;5040.521150490697;5074.264231686385;5087.26234695967;4636.11913736389;4720.221163508051;4835.95164048362;4837.637177211653;4910.53349931763;4832.178529649968;4844.709317440965;4878.243872199815;4904.485029071896;4936.062148191832;4855.077535268288;4868.196747536687;4875.926861097087;4882.316475693406;4887.437944636341;4730.550597693214;4819.132556139858;4832;4868.586170175504;4925.852224433273;4092.4066010428323;4106.240345536085;4112;4120.876373708794;4125.319322311785;3614.566252049771;3631.3645112105805;3633.65480279373;3665.5051568038507;3667.669909708139;4152.501699796044;4229;4249.1501699659575;4253.957460425418;4281.464816897887;4909.631777616693;4939.431965323962;4956.430010548761;4966.428860681068;5015;4304.80628371724;4308.590683885089;4319.049809042006;4321.805518751664;4358.6730995175485;4226.535081141072;4322.805473753689;4331.956680433218;4399.274119770202;4414.624756895636;4543.750093744809;4548.6361091113295;4635.351050852951;4720.787564559534;4744.620430365493;4906.092372911023;4907.460179380194;4917.532834380728;4919.0407870464915;4968.701877887338;4500.797464114057;4656.9301460477445;4660.813567457264;4672.57946784791;4708.3643708100335;4807.567318941312;4811.158047341632;4856.295837103671;4860.684055536379;4917.360743103373;4908.803647854046;4910.189818679878;4911.754412279301;4911.975440122919;4977.676451030671;4637.814487420465;4724.078804633064;4752.42970843501;4758;4819.927701084416;4731.432228132646;4746.833860814855;4780.713157210439;4782.952170478251;4814;4677.602403795579;4679.485256621837;4700.694454860423;4706.694064885772;4714.151452738402;4700.45944716362;4743.478217396015;4789.473157952552;4812.374391329105;4826.855194344175;4654.9767251164885;4682.15721170179;4691.835785747482;4703.082898834831;4739.502352253102 22:43:07 INFO - PROCESS | 14748 | |1;ext.html;495.5317225222165;497.1225786486849;502.4799332690666;513.4352212566178;532.6590981771669;32013.19967000823;32607.836960815162;32703.50944735828;32791.04880560749;32833.34333313332;36363.45454818173;36656.81671591645;36996.81501592488;37051.629483705154;37089.44365834508;7655.961720191419;7868.6852525899185;7916.287534121928;7925.643346049413;7939.523628582275;7647.311741943224;7760.650770715303;7764.223577642247;7771.689132434696;7780.02749656293;7905.288524032836;7906.841863162734;7961.60191990401;7965.44241903067;8015.639296231654;7836.72571459999;7880.4877682951;7896.486728362638;7916.762497125095;7917.287444129998;7775.300222979959;7848.175941526115;7899.973003509507;7900.525968441912;7938.563379014152;35945;36191.276174476625;36379.27241455156;36579.26841463183;36659.63340366589;2876.956845647317;3053.3740583180393;3227.983860080708;3466.532018177539;3566.8751593694096;26762.73237267622;26964.59553106705;27038.459230815275;27113.593296100575;27719.584206236923;3481.56480439945;3489.7208223342072;3491.214476742738;3570.696490798285;3590.6588874056924;209038;210051;210243;211033;211092.99999999846;46767.532324676315;48160;52597.2110418344;52614.21078683823;52686.47313526893;59004.704976474844;59645.701771490865;59727.402725972184;59827.70086149542;59895.700521497114;13404.865951340362;13533.458661653423;13695.383707733175;13741.931290343484;13789.793153102712;10563.683089507327;10571.10145637614;10693.946530267454;10707.464626768786;10713.089387402159;17996.190171442315;18134.183961721756;18168.818311816976;19092.8090719091;19096.427107186806;6880.449564034865;7080.999235431965;7107.466939979522;7108.147022357351;7185.3533182012825;797.3262593108814;867.8915135608049;878.2008372381102;940.9623615055458;956.9760356418566;25332.240032799047;25346.239612811645;25465.61801572978;25475.74524254734;25530;928.9396189247677;970.7573106723319;972.3922548407245;1030.2736570717775;1033.390299723167;13303.534376296977;13404;13447.125936814271;14195.290235488184;14307.92846035763;266567;272064;273909;276790;276992;38782.41826372607;38830;39129;39209.41185882214;39258.214835703126;1203;1209.0629761934395;1210.8607510136446;1213.344793811332;1334.873187047229;24654.506909862062;25293.74706252914;25320.493590127724;25551.361215969748;25551.361215969748;37495.2500949974;37726.43410348792;37773;37786;37823;201253;203447;203538;203694;204493;27250.591241131002;28314;28794.568081478377;28896.42207155887;29002;32795.34409311753;32948;33224.50163247505;33629;33669;28582.428351432438;28949.42101157923;28988.7101128986;29723;30909;30937.690623094382;30968.535471967487;30995.0701478956;31451.68548314579;31692.207694807814;28180.29549261203;28388.574171387034;28390.716092839633;28605.570916435852;28608.284792879513;26441.888179184953;28379.858100709363;28521.572176416954;28771;28776.568351474325;22772.31683049511;22868.428289292235;23050.193243236405;23056.4235894104;23198 22:43:07 INFO - PROCESS | 14748 | |2;jquery.html;337.35901786605444;338.4567768731187;340.3261542146548;342.2060818900151;344.5090745687395;13967.16197028179;14156.787648185273;14993.700125997473;15619.609509762247;15660.686786264268;9782.119609235167;10019.098281154695;11557.479913403897;13768.793468097962;13781.655458613539;4490.708103973239;4697.248440249561;4698.412698412699;4700.929486057712;5152.175651895697;5013.3232013678235;5072.873178170538;5092.821751238707;5094.363204599425;5105.540501354877;4698.201305778009;4818.68678535894;4906.582940450066;4909.975450122763;5069.391672999227;4815.614750819926;4847.733374664392;4853.3690620219495;4897.04507621014;5660.490555849952;5019.472955339674;5033.245013248005;5039.218921067204;5042.319286896295;5051.722155281458;10969.561217551289;15689.68620627581;17442.040687762168;17876.731849022275;17995.550111247194;1721.1050253868043;1734.7918249809977;1741.582020315128;1837.5406148462885;1850.8334249917573;7827.96086019572;8312.127226641236;9506.382085164441;11795.705107372385;11877.346745928971;1727.4385824607052;1777.6977913754563;1821.7703050441032;1825.6713791517523;1835.715464103053;47566.28650570244;48244.7587762059;48941.51058489405;49311.2603310947;49370.0125997478;9408.388454750419;9431.292653051049;9573.569189386495;9627.374220675634;9633.036696330451;12081.637550873487;12115.878841211475;12200.206986545845;12239.69400764988;12263.141580089308;6770.830729231809;6994.8950765738555;7039.612821294878;7062.71749130029;7098.29017098286;6726.293739157318;6770.830729231809;6800.761973331008;6852.897206541906;6875.243723190445;3849.6920246380223;3951;4090.1206240658403;4144.274751918402;4176.83292668296;1657.892237004591;1675.0954484578192;1700.3028758209075;1739.365131726936;1758.68343698133;841.2260720137489;858.9441686290371;876.9605367758467;902.9503377314179;904.8280826642916;14290.285485725672;14583.781243281359;14742.484013059491;14956.326965286587;14956.626084347761;825.4923222218413;834.7996480844554;838.4633834346023;909.6361455417754;938.9342746007713;8434.536100514408;8512.106228845882;8900.643974240958;9153.81692366149;9193.034731353111;425375;429636;429956;441418;449231;61239;64415;64563;64566.35433645697;64934;1083.0415082651753;1084.2301965604508;1138.1009002887793;1140.560884059643;1157.6816375496805;13713.862861371657;13748.65628359259;13804.723905521632;13854.445822167001;14125.011249212457;30209;30733;30938.535921960738;31262.218444538157;31323.216919577193;39473.80263098666;39959;40002.799986001046;40147.79926100351;40746;5964.165016897551;6137.508999280136;6151.169592105009;6304.873902522016;6425;7061.646917653994;9253.491057991874;9304.16262536375;9371.484568348806;9531;7458.291462311072;8153.714619988272;8294.958525207336;8510.48937063778;8540.103289154798;8275.172482751677;8287.254147126787;8395.514943537748;8566.957165214384;8576.313894888519;8282.461639993382;8428.11504791988;8538.402311838112;8546.359023073419;8671.696490622799;5814.622049566765;5957.7319020645045;5966.19456373384;6118.776244751157;6198.411150940653;6394.648294343856;8027.959860200662;8052.194780521901;8068.636911339121;8142.918570814216 22:43:07 INFO - PROCESS | 14748 | |3;mootools.html;1371.4788380415441;1382.5575815738964;1494.4097081652747;1684.7725557049794;1685.2332188854066;6568.146141001669;6608.702608382622;6755.560888542247;6757.864842703143;6793.150856142982;6545.8363540911505;6595.505337099713;6605.141331626882;6625.3705897939735;6669.133012708353;1970.2020681623965;1987.473319570315;1994.9999999999927;1995.1520603743425;1999.590084032777;2014.9798502015012;2039.2556716798335;2041.7958204179538;2048.2523878784286;2050.7026481160224;1715.2624371520242;1752.921118549662;1969.832564232042;2000.4998750312423;2051;1978.4064780565845;1983.3554094919066;1985.0570978785033;1985.1265443205016;1986.910589023483;1956.9804301957083;1974.6149500847341;1999.150361096528;2008.1164287713505;2019.3336199054277;6720.83197920051;6736.6631668416385;6755.763548275787;6774.390304872536;6778.966105169492;3847.153626202259;3978.562358140602;4012.8194231259663;4012.8996775080564;4017.5982401759884;2525.154073385418;2538.5684433646325;2571.7556832100922;2577.832440891355;2593.974060259411;803.5419810707899;809.9230573095547;815.2988429950238;830.2942498875907;868.0754995929378;8929.330300227444;8970.50662213578;8979.281657467387;8995.955020224923;9026.729198124067;3365.495175723612;3446.052335607728;3458.8097654629237;3472.8784492543145;3477.878274260389;7405;7434.36807871337;7440.14438339587;7441.925580744231;7460.253974602605;3809.238152369537;3829;3840.8655697050467;3845.673117784964;3853.5953724858487;3521.5774107107313;3524.3656141894194;3528.2414280929725;3530.046887340404;3550.5029295898594;2954.512505436579;2964.881404743786;2979.3743313903888;2980.6423229212633;2986.566947792558;851.1445996773327;857.0315543435878;861.1474640106375;861.1775754154767;864.628209869762;836.1346006882846;849.2908421468144;894.0612357025097;1068.369661899483;1082.4046774274275;6092.482139018233;6125.9693701531205;6151.446369826737;6175.073738939105;6222.253329600387;536.9704666243395;540.8323419739893;548.4488089470057;548.7146683724441;672.2806596941226;4695.107929493385;4814.831480898151;4820.758962051884;4833.975830120898;4839.201531747292;7692.499987500794;7712.691492340356;7828.060632723996;7936.246056624612;7962.800929976797;7776.805579860549;7794.10367807698;7807;7855.175206603224;7901.525908445396;6190.3190649028575;6251.218597675291;6342.4926005919415;6360.236771587439;6369.172007638977;6319.304876463493;6406.199225096863;6406.743730250924;6415.807525774234;6427.357264273723;7143.464240182111;7295.1610564783605;7425.146108197627;7458.291462311072;7475.36459400957;7472.065991751031;7571.962140189264;7664.501807382502;7666.846663066819;7737.883931741141;6024.156618073385;6051.606645568024;6051.818445446644;6063.302720187235;6099.664518451527;6051.727672254847;6195.380461953769;6205;6259.092431597302;6355.650439225887;5928.3775203603;5995.490383317467;6031.065184896348;6047.637141771508;6056.939430605637;5798.710064496674;5904.763809447746;5910.7931222407005;5991.281046274475;6039.365866584121;5851.590388672752;5886.882262354643;5887.587868849139;5894.911576326444;5919.852003699942;5491.341039075177;5512.889742205053;5521.475459831309;5556.277683901067;5558.221848941233;5493.395726470165;5526.115821468546;5532.3637781655625;5551.750171242385;5587.636803607753 22:43:07 INFO - PROCESS | 14748 | |4;prototype.html;274.8670318329761;281.9295176205947;284.7266624040921;288.2749884041636;291.8015749290482;5357.973210133953;5549.112142057272;5563.109902415615;5620.831375058745;5682.403347648499;5492.47821456961;5639.379668236501;5639.915401268984;5649.067903795879;5653.547716182706;4201.159768046396;4206.915861682764;4235.428217190671;4244.087521182945;4244.617984381405;4218.093109981353;4234.491860976687;4240.363945408182;4259.914801703964;4260.97869510652;3997.5802540733093;4186.832526698943;4194.97902510487;4197.370394440828;4199.433076534675;4103.815328310233;4104.774237416941;4124.278251306009;4125.030617804813;4132.070284186064;3515.1036485695986;3520.700740437066;3521.47177923311;3528.7706299090733;3529.770564913272;5199.454057324002;5302.787888484456;5327.786888524454;5370.3287089113865;5408.080626293539;4768.213244814636;4779.545943135397;4780.1873681474235;4786.664933454659;4792.544708252745;5898.262717160355;5898.616589921641;5909.7636094556165;5910.527157827363;5915.674637894914;3864.207837393356;3866.903327416809;3867.9613203867884;3873.32216862048;3875.5736868944678;5981.5214782817275;6177.227846519185;6186.103015062836;6199.070139479069;6206.379362063803;3984.5218573770753;3984.7808370539897;3985.960140398559;3995.5604883462797;4006.2187873364414;4042.7574345538774;4043.534993475729;4047.8785636430953;4054.614811592953;4064.4716186896108;4765.761711914391;4768.904621907543;4769;4785.114753770564;4805.087033463631;5756.200907401095;5885.793997210077;5893.705314734246;5903.1145328200255;5925.762969481172;1384.5846246126123;1385.801281891177;1386.9861301386857;1391.7613324141523;1391.9234442105578;902.8149229408087;902.9006809250977;904.791897863482;914.2229105260475;920.581135583308;5088.92366614501;5122.743862806845;5123.974380128076;5131.179011358165;5132.820351287687;6093.11649810775;6093.421124993119;6093.451589356979;6103.572749907553;6107.572469927062;5077.213031980049;5115.514026167508;5124.564412024945;5131.5638170755155;5144.768485418165;3240.368128215023;3302.653221411765;3318.0875259303884;3321.153105957965;3324.335132973415;5713.22871412354;5730.169125476783;5733.254676892061;5743.253377060955;5770.913436298459;6006.579539432285;6186;6247.9062814057825;6281.246250449975;6302.936970630327;5715.799947001919;5817.621854579439;5822.970885145547;5838.386969368155;5857.355690874086;6084.908726369196;6116.113163591343;6116.5718399711595;6133.877322453437;6147.66187859672;5810.186573879745;5974.2233509643465;6011.188489554029;6073.696315184135;6084.60450070744;5781.94218057814;5806;5815.41845815415;5820.970895145667;5840.707964601838;4022.4368588398233;4090.570490098497;4091.529474110396;4111.280525908014;4111.650509706708;5966.49284810796;6124.38756124384;6126.050462178369;6131.570790044654;6144.631322120508;5877.324107727666;5880.529557635294;5883.94116058834;5888.617239879394;5896.086106653475;5845.532357411482;5849.298084229919;5892.6759028253855;5926.881462370642;5927.940720592911;5719.942800571941;5729.54163666914;5741.885162296814;5746.798862039808;5760.567957403127;5751.568632352507;5962.4633782959745;5963.761449541969;5987.64074155552;6005.849853753516;5720.799772007959;5732.512736417451;5737.799177028784;5748.425157484218;5755.798547050833 22:43:07 INFO - PROCESS | 14748 | |5;yui.html;635.3551145587227;666.3669513961737;697.1355519156248;760.8440269744701;768.5811232878083;11172.329660220392;11394;11416.714582135452;11426.143039272047;11430.314181149126;11449.771004579903;11691.298522088659;11693.473793679284;11705.23915945463;11707.239029463079;590.4213870407003;600.1118344849604;739.7226040234912;748.3788455581881;755.165542076005;735.3161559749431;745.083547236899;749.0412272291476;749.5727435361846;757.8976838126865;782.284209947897;783.8510682970245;787.2678409079554;788.9368850491976;795.932345750612;778.01581000035;778.3539662080516;780.7228433905967;783.0485959559135;790.6165509727778;579.8753268047348;585.2216551985848;585.645684360964;587.9882402351972;589.1369144203762;11597.826032609517;11652.708682282926;11667.708307292301;11722.824157637642;11724.472398742077;11390.202685811997;11747.6265783317;11782.941085294518;11995.700107497383;12112.031037516977;9505.667301644478;9723.173530249936;9723.416595004323;9941.65204217849;9948.900510994943;3239.0282915125604;3286.556314897482;3327.96672033279;3350.0619826448633;3378.847951842173;39472.40791388132;39977.200455991006;40275.59724402777;40651;40713.98215044648;8924.419912705653;9003.954980225188;9066.138716822023;9150.63397464094;9339.579718912666;15469.381224751109;15646.295916683548;15685.13731744765;15697.372105115895;15710.371585136696;6211.223597050369;6236.251649802053;6262.812115636538;6384.808455746335;6403.391677790602;3621.0766254604905;3668.798216098087;3711.3319602471274;3711.5917249102577;3738.1962877981364;2420.6248031554783;2448.522538105088;2458.029078513977;2472.9752702473106;2475.55440020798;441.22124450345166;448.60746846509306;453.7164272329794;455.8131166221833;461.7183518053984;430.01741021765116;555.7332480409426;568.0882184094552;570.7460180219763;578.6528083150076;7329.486935914541;7354.3748781353115;7430.294122058396;7558.093028836574;7653.3494652954005;447.4988013424985;469.40151307083744;471.32129733184104;561.800560800918;572;3520.3663340598937;3585.608001942973;3727.6086010968456;3777.0557360659836;3888.2612303662213;41300.793496032325;41302;41351.586484135376;41367.58632413697;41468.585314146476;39479.605203948166;41092.38361424521;41148.79425602853;41534.37698434526;41624.583754162675;35574.82212588921;40844.1831163381;41309.380359294635;41730;42219.788901055916;7812.414068944739;7836.490628109154;7855.214478552099;7884.172161923145;7984.361251099782;29668.109956701333;29891;29996.85001574978;30091.247718807204;30531.389372212874;34640.133996649274;35125.29749404947;37884.43173352457;37890;38128.42807357836;10109.191264698953;10194.694159175237;10350.741231469274;10468.476576171313;10832.512536936014;10907.29102608328;11153.330800152016;11449;11489.885101149215;11939.283642981449;10481.737956550842;10997.450127493754;11023.944880275869;11032.944835276094;11371.829422558834;10129.797404052026;10450.477476126316;10723.892761072602;10808.675739727822;11069.612563560237;10778.461076945965;10828;11016.283941543774;11038.503267352828;11372.829407558727;8301.6679332826;8429.704960326359;8555.401121921655;8571.785705357166;8965.775855603662;8874.467531947845;9390.036548942317;9403.670871519464;9500.762480938032;9550.249861188251 22:43:07 INFO - PROCESS | 14748 | __end_tp_report 22:43:07 INFO - PROCESS | 14748 | __start_cc_report 22:43:07 INFO - PROCESS | 14748 | _x_x_mozilla_cycle_collect,341 22:43:07 INFO - PROCESS | 14748 | __end_cc_report 22:43:07 INFO - PROCESS | 14748 | __startTimestamp1452926587047__endTimestamp 22:43:07 INFO - PROCESS | 14748 | 22:43:07 INFO - PROCESS | 14748 | ------- Summary: start ------- 22:43:07 INFO - PROCESS | 14748 | Number of tests: 6 22:43:07 INFO - PROCESS | 14748 | 22:43:07 INFO - PROCESS | 14748 | [#0] dojo.html Cycles:165 Average:4542.24 Median:4660.81 stddev:453.46 (9.7%) stddev-sans-first:429.04 22:43:07 INFO - PROCESS | 14748 | Values: 2619.8 2655.1 2683.8 2693.0 2701.2 4494.4 4609.3 4625.4 4637.7 4667.5 4536.9 4585.0 4641.1 4647.0 4648.4 4248.3 4274.2 4301.4 4332.2 4366.2 4244.0 4256.7 4299.0 4320.3 4342.3 4171.2 4216.3 4237.7 4262.8 4279.3 4268.8 4285.4 4286.7 4296.1 4324.6 4293.5 4294.4 4296.0 4312.3 4332.5 4369.2 4476.2 4544.7 4593.3 4625.6 4855.5 4880.3 4885.9 4907.8 4936.6 4738.4 4922.5 4933.9 4936.1 4987.2 4554.4 4569.2 4575.1 4590.0 4626.9 4979.5 5023.5 5040.5 5074.3 5087.3 4636.1 4720.2 4836.0 4837.6 4910.5 4832.2 4844.7 4878.2 4904.5 4936.1 4855.1 4868.2 4875.9 4882.3 4887.4 4730.6 4819.1 4832.0 4868.6 4925.9 4092.4 4106.2 4112.0 4120.9 4125.3 3614.6 3631.4 3633.7 3665.5 3667.7 4152.5 4229.0 4249.2 4254.0 4281.5 4909.6 4939.4 4956.4 4966.4 5015.0 4304.8 4308.6 4319.0 4321.8 4358.7 4226.5 4322.8 4332.0 4399.3 4414.6 4543.8 4548.6 4635.4 4720.8 4744.6 4906.1 4907.5 4917.5 4919.0 4968.7 4500.8 4656.9 4660.8 4672.6 4708.4 4807.6 4811.2 4856.3 4860.7 4917.4 4908.8 4910.2 4911.8 4912.0 4977.7 4637.8 4724.1 4752.4 4758.0 4819.9 4731.4 4746.8 4780.7 4783.0 4814.0 4677.6 4679.5 4700.7 4706.7 4714.2 4700.5 4743.5 4789.5 4812.4 4826.9 4655.0 4682.2 4691.8 4703.1 4739.5 22:43:07 INFO - PROCESS | 14748 | 22:43:07 INFO - PROCESS | 14748 | [#1] ext.html Cycles:180 Average:38128.23 Median:17917.91 stddev:60221.49 (336.1%) stddev-sans-first:60324.14 22:43:07 INFO - PROCESS | 14748 | Values: 495.5 497.1 502.5 513.4 532.7 32013.2 32607.8 32703.5 32791.0 32833.3 36363.5 36656.8 36996.8 37051.6 37089.4 7656.0 7868.7 7916.3 7925.6 7939.5 7647.3 7760.7 7764.2 7771.7 7780.0 7905.3 7906.8 7961.6 7965.4 8015.6 7836.7 7880.5 7896.5 7916.8 7917.3 7775.3 7848.2 7900.0 7900.5 7938.6 35945.0 36191.3 36379.3 36579.3 36659.6 2877.0 3053.4 3228.0 3466.5 3566.9 26762.7 26964.6 27038.5 27113.6 27719.6 3481.6 3489.7 3491.2 3570.7 3590.7 209038.0 210051.0 210243.0 211033.0 211093.0 46767.5 48160.0 52597.2 52614.2 52686.5 59004.7 59645.7 59727.4 59827.7 59895.7 13404.9 13533.5 13695.4 13741.9 13789.8 10563.7 10571.1 10693.9 10707.5 10713.1 17996.2 18134.2 18168.8 19092.8 19096.4 6880.4 7081.0 7107.5 7108.1 7185.4 797.3 867.9 878.2 941.0 957.0 25332.2 25346.2 25465.6 25475.7 25530.0 928.9 970.8 972.4 1030.3 1033.4 13303.5 13404.0 13447.1 14195.3 14307.9 266567.0 272064.0 273909.0 276790.0 276992.0 38782.4 38830.0 39129.0 39209.4 39258.2 1203.0 1209.1 1210.9 1213.3 1334.9 24654.5 25293.7 25320.5 25551.4 25551.4 37495.3 37726.4 37773.0 37786.0 37823.0 201253.0 203447.0 203538.0 203694.0 204493.0 27250.6 28314.0 28794.6 28896.4 29002.0 32795.3 32948.0 33224.5 33629.0 33669.0 28582.4 28949.4 28988.7 29723.0 30909.0 30937.7 30968.5 30995.1 31451.7 31692.2 28180.3 28388.6 28390.7 28605.6 28608.3 26441.9 28379.9 28521.6 28771.0 28776.6 22772.3 22868.4 23050.2 23056.4 23198.0 22:43:07 INFO - PROCESS | 14748 | 22:43:07 INFO - PROCESS | 14748 | [#2] jquery.html Cycles:180 Average:23205.05 Median:27110.62 stddev:71138.21 (262.4%) stddev-sans-first:71317.05 22:43:07 INFO - PROCESS | 14748 | Values: 337.4 338.5 340.3 342.2 344.5 13967.2 14156.8 14993.7 15619.6 15660.7 9782.1 10019.1 11557.5 13768.8 13781.7 4490.7 4697.2 4698.4 4700.9 5152.2 5013.3 5072.9 5092.8 5094.4 5105.5 4698.2 4818.7 4906.6 4910.0 5069.4 4815.6 4847.7 4853.4 4897.0 5660.5 5019.5 5033.2 5039.2 5042.3 5051.7 10969.6 15689.7 17442.0 17876.7 17995.6 1721.1 1734.8 1741.6 1837.5 1850.8 7828.0 8312.1 9506.4 11795.7 11877.3 1727.4 1777.7 1821.8 1825.7 1835.7 47566.3 48244.8 48941.5 49311.3 49370.0 9408.4 9431.3 9573.6 9627.4 9633.0 12081.6 12115.9 12200.2 12239.7 12263.1 6770.8 6994.9 7039.6 7062.7 7098.3 6726.3 6770.8 6800.8 6852.9 6875.2 3849.7 3951.0 4090.1 4144.3 4176.8 1657.9 1675.1 1700.3 1739.4 1758.7 841.2 858.9 877.0 903.0 904.8 14290.3 14583.8 14742.5 14956.3 14956.6 825.5 834.8 838.5 909.6 938.9 8434.5 8512.1 8900.6 9153.8 9193.0 425375.0 429636.0 429956.0 441418.0 449231.0 61239.0 64415.0 64563.0 64566.4 64934.0 1083.0 1084.2 1138.1 1140.6 1157.7 13713.9 13748.7 13804.7 13854.4 14125.0 30209.0 30733.0 30938.5 31262.2 31323.2 39473.8 39959.0 40002.8 40147.8 40746.0 5964.2 6137.5 6151.2 6304.9 6425.0 7061.6 9253.5 9304.2 9371.5 9531.0 7458.3 8153.7 8295.0 8510.5 8540.1 8275.2 8287.3 8395.5 8567.0 8576.3 8282.5 8428.1 8538.4 8546.4 8671.7 5814.6 5957.7 5966.2 6118.8 6198.4 6394.6 8028.0 8052.2 8068.6 8142.9 22:43:07 INFO - PROCESS | 14748 | 22:43:07 INFO - PROCESS | 14748 | [#3] mootools.html Cycles:180 Average:4635.39 Median:5993.39 stddev:2423.80 (40.4%) stddev-sans-first:2418.19 22:43:07 INFO - PROCESS | 14748 | Values: 1371.5 1382.6 1494.4 1684.8 1685.2 6568.1 6608.7 6755.6 6757.9 6793.2 6545.8 6595.5 6605.1 6625.4 6669.1 1970.2 1987.5 1995.0 1995.2 1999.6 2015.0 2039.3 2041.8 2048.3 2050.7 1715.3 1752.9 1969.8 2000.5 2051.0 1978.4 1983.4 1985.1 1985.1 1986.9 1957.0 1974.6 1999.2 2008.1 2019.3 6720.8 6736.7 6755.8 6774.4 6779.0 3847.2 3978.6 4012.8 4012.9 4017.6 2525.2 2538.6 2571.8 2577.8 2594.0 803.5 809.9 815.3 830.3 868.1 8929.3 8970.5 8979.3 8996.0 9026.7 3365.5 3446.1 3458.8 3472.9 3477.9 7405.0 7434.4 7440.1 7441.9 7460.3 3809.2 3829.0 3840.9 3845.7 3853.6 3521.6 3524.4 3528.2 3530.0 3550.5 2954.5 2964.9 2979.4 2980.6 2986.6 851.1 857.0 861.1 861.2 864.6 836.1 849.3 894.1 1068.4 1082.4 6092.5 6126.0 6151.4 6175.1 6222.3 537.0 540.8 548.4 548.7 672.3 4695.1 4814.8 4820.8 4834.0 4839.2 7692.5 7712.7 7828.1 7936.2 7962.8 7776.8 7794.1 7807.0 7855.2 7901.5 6190.3 6251.2 6342.5 6360.2 6369.2 6319.3 6406.2 6406.7 6415.8 6427.4 7143.5 7295.2 7425.1 7458.3 7475.4 7472.1 7572.0 7664.5 7666.8 7737.9 6024.2 6051.6 6051.8 6063.3 6099.7 6051.7 6195.4 6205.0 6259.1 6355.7 5928.4 5995.5 6031.1 6047.6 6056.9 5798.7 5904.8 5910.8 5991.3 6039.4 5851.6 5886.9 5887.6 5894.9 5919.9 5491.3 5512.9 5521.5 5556.3 5558.2 5493.4 5526.1 5532.4 5551.8 5587.6 22:43:07 INFO - PROCESS | 14748 | 22:43:07 INFO - PROCESS | 14748 | [#4] prototype.html Cycles:180 Average:4817.39 Median:5639.65 stddev:1475.93 (26.2%) stddev-sans-first:1440.15 22:43:07 INFO - PROCESS | 14748 | Values: 274.9 281.9 284.7 288.3 291.8 5358.0 5549.1 5563.1 5620.8 5682.4 5492.5 5639.4 5639.9 5649.1 5653.5 4201.2 4206.9 4235.4 4244.1 4244.6 4218.1 4234.5 4240.4 4259.9 4261.0 3997.6 4186.8 4195.0 4197.4 4199.4 4103.8 4104.8 4124.3 4125.0 4132.1 3515.1 3520.7 3521.5 3528.8 3529.8 5199.5 5302.8 5327.8 5370.3 5408.1 4768.2 4779.5 4780.2 4786.7 4792.5 5898.3 5898.6 5909.8 5910.5 5915.7 3864.2 3866.9 3868.0 3873.3 3875.6 5981.5 6177.2 6186.1 6199.1 6206.4 3984.5 3984.8 3986.0 3995.6 4006.2 4042.8 4043.5 4047.9 4054.6 4064.5 4765.8 4768.9 4769.0 4785.1 4805.1 5756.2 5885.8 5893.7 5903.1 5925.8 1384.6 1385.8 1387.0 1391.8 1391.9 902.8 902.9 904.8 914.2 920.6 5088.9 5122.7 5124.0 5131.2 5132.8 6093.1 6093.4 6093.5 6103.6 6107.6 5077.2 5115.5 5124.6 5131.6 5144.8 3240.4 3302.7 3318.1 3321.2 3324.3 5713.2 5730.2 5733.3 5743.3 5770.9 6006.6 6186.0 6247.9 6281.2 6302.9 5715.8 5817.6 5823.0 5838.4 5857.4 6084.9 6116.1 6116.6 6133.9 6147.7 5810.2 5974.2 6011.2 6073.7 6084.6 5781.9 5806.0 5815.4 5821.0 5840.7 4022.4 4090.6 4091.5 4111.3 4111.7 5966.5 6124.4 6126.1 6131.6 6144.6 5877.3 5880.5 5883.9 5888.6 5896.1 5845.5 5849.3 5892.7 5926.9 5927.9 5719.9 5729.5 5741.9 5746.8 5760.6 5751.6 5962.5 5963.8 5987.6 6005.8 5720.8 5732.5 5737.8 5748.4 5755.8 22:43:07 INFO - PROCESS | 14748 | 22:43:07 INFO - PROCESS | 14748 | [#5] yui.html Cycles:180 Average:11765.73 Median:41301.40 stddev:12765.56 (30.9%) stddev-sans-first:12774.00 22:43:07 INFO - PROCESS | 14748 | Values: 635.4 666.4 697.1 760.8 768.6 11172.3 11394.0 11416.7 11426.1 11430.3 11449.8 11691.3 11693.5 11705.2 11707.2 590.4 600.1 739.7 748.4 755.2 735.3 745.1 749.0 749.6 757.9 782.3 783.9 787.3 788.9 795.9 778.0 778.4 780.7 783.0 790.6 579.9 585.2 585.6 588.0 589.1 11597.8 11652.7 11667.7 11722.8 11724.5 11390.2 11747.6 11782.9 11995.7 12112.0 9505.7 9723.2 9723.4 9941.7 9948.9 3239.0 3286.6 3328.0 3350.1 3378.8 39472.4 39977.2 40275.6 40651.0 40714.0 8924.4 9004.0 9066.1 9150.6 9339.6 15469.4 15646.3 15685.1 15697.4 15710.4 6211.2 6236.3 6262.8 6384.8 6403.4 3621.1 3668.8 3711.3 3711.6 3738.2 2420.6 2448.5 2458.0 2473.0 2475.6 441.2 448.6 453.7 455.8 461.7 430.0 555.7 568.1 570.7 578.7 7329.5 7354.4 7430.3 7558.1 7653.3 447.5 469.4 471.3 561.8 572.0 3520.4 3585.6 3727.6 3777.1 3888.3 41300.8 41302.0 41351.6 41367.6 41468.6 39479.6 41092.4 41148.8 41534.4 41624.6 35574.8 40844.2 41309.4 41730.0 42219.8 7812.4 7836.5 7855.2 7884.2 7984.4 29668.1 29891.0 29996.9 30091.2 30531.4 34640.1 35125.3 37884.4 37890.0 38128.4 10109.2 10194.7 10350.7 10468.5 10832.5 10907.3 11153.3 11449.0 11489.9 11939.3 10481.7 10997.5 11023.9 11032.9 11371.8 10129.8 10450.5 10723.9 10808.7 11069.6 10778.5 10828.0 11016.3 11038.5 11372.8 8301.7 8429.7 8555.4 8571.8 8965.8 8874.5 9390.0 9403.7 9500.8 9550.2 22:43:07 INFO - PROCESS | 14748 | -------- Summary: end -------- 22:43:07 INFO - PROCESS | 14748 | 22:43:07 INFO - TEST-INFO | 14748: exit 0 22:43:07 INFO - TEST-OK | dromaeo_css | took 1115256ms 22:43:07 INFO - TEST-START | kraken 22:43:07 INFO - operating with platform_type : linux_ 22:43:07 INFO - Initialising browser for kraken test... 22:43:07 INFO - TEST-INFO | started process 14988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA63l8R/profile http://localhost:49315/getInfo.html) 22:43:11 INFO - PROCESS | 14988 | 22:43:11 INFO - PROCESS | 14988 | (process:15060): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:43:13 INFO - PROCESS | 14988 | __metrics Screen width/height:1600/1200 22:43:13 INFO - PROCESS | 14988 | colorDepth:24 22:43:13 INFO - PROCESS | 14988 | Browser inner width/height: 1024/697 22:43:13 INFO - PROCESS | 14988 | __metrics 22:43:13 INFO - PROCESS | 14988 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:43:14 INFO - TEST-INFO | 14988: exit 0 22:43:14 INFO - Browser initialized. 22:43:14 INFO - Running cycle 1/1 for kraken test... 22:43:14 INFO - TEST-INFO | started process 15109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA63l8R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:43:15 INFO - PROCESS | 15109 | 22:43:15 INFO - PROCESS | 15109 | (process:15166): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:43:26 INFO - PROCESS | 15109 | RSS: Main: 150937600 22:43:26 INFO - PROCESS | 15109 | 22:43:28 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49315/tests/kraken/driver.html?testName=audio-beat-detection) 22:43:29 INFO - PROCESS | 15109 | RSS: Main: 152363008 22:43:29 INFO - PROCESS | 15109 | 22:43:32 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49315/tests/kraken/driver.html?testName=audio-dft) 22:43:32 INFO - PROCESS | 15109 | RSS: Main: 154443776 22:43:32 INFO - PROCESS | 15109 | 22:43:35 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49315/tests/kraken/driver.html?testName=audio-fft) 22:43:36 INFO - PROCESS | 15109 | RSS: Main: 148439040 22:43:36 INFO - PROCESS | 15109 | 22:43:38 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49315/tests/kraken/driver.html?testName=audio-oscillator) 22:43:39 INFO - PROCESS | 15109 | RSS: Main: 147939328 22:43:39 INFO - PROCESS | 15109 | 22:43:41 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49315/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:43:41 INFO - PROCESS | 15109 | RSS: Main: 147714048 22:43:41 INFO - PROCESS | 15109 | 22:43:45 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49315/tests/kraken/driver.html?testName=imaging-darkroom) 22:43:45 INFO - PROCESS | 15109 | RSS: Main: 149540864 22:43:45 INFO - PROCESS | 15109 | 22:43:49 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49315/tests/kraken/driver.html?testName=imaging-desaturate) 22:43:49 INFO - PROCESS | 15109 | RSS: Main: 149098496 22:43:49 INFO - PROCESS | 15109 | 22:43:52 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49315/tests/kraken/driver.html?testName=json-parse-financial) 22:43:53 INFO - PROCESS | 15109 | RSS: Main: 148054016 22:43:53 INFO - PROCESS | 15109 | 22:43:55 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49315/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:43:55 INFO - PROCESS | 15109 | RSS: Main: 149360640 22:43:55 INFO - PROCESS | 15109 | 22:43:57 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:43:58 INFO - PROCESS | 15109 | RSS: Main: 149258240 22:43:58 INFO - PROCESS | 15109 | 22:44:00 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:44:00 INFO - PROCESS | 15109 | RSS: Main: 148692992 22:44:00 INFO - PROCESS | 15109 | 22:44:03 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:44:04 INFO - PROCESS | 15109 | RSS: Main: 150740992 22:44:04 INFO - PROCESS | 15109 | 22:44:06 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:44:07 INFO - PROCESS | 15109 | RSS: Main: 149925888 22:44:07 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49315/tests/kraken/driver.html?testName=ai-astar) 22:44:09 INFO - PROCESS | 15109 | RSS: Main: 150003712 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | __start_tp_report 22:44:09 INFO - PROCESS | 15109 | _x_x_mozilla_page_load 22:44:09 INFO - PROCESS | 15109 | _x_x_mozilla_page_load_details 22:44:09 INFO - PROCESS | 15109 | |i|pagename|runs| 22:44:09 INFO - PROCESS | 15109 | |0;ai-astar;114;110;114;115;115;123;114;113;116;116 22:44:09 INFO - PROCESS | 15109 | |1;audio-beat-detection;157;135;151;166;132;155;158;143;183;135 22:44:09 INFO - PROCESS | 15109 | |2;audio-dft;161;165;164;163;164;167;173;163;168;166 22:44:09 INFO - PROCESS | 15109 | |3;audio-fft;73;75;73;73;74;73;136;72;72;73 22:44:09 INFO - PROCESS | 15109 | |4;audio-oscillator;98;98;135;97;99;98;140;99;98;139 22:44:09 INFO - PROCESS | 15109 | |5;imaging-gaussian-blur;110;110;109;110;111;111;110;111;111;111 22:44:09 INFO - PROCESS | 15109 | |6;imaging-darkroom;148;148;148;148;148;148;147;149;149;148 22:44:09 INFO - PROCESS | 15109 | |7;imaging-desaturate;96;97;96;96;96;96;97;95;96;95 22:44:09 INFO - PROCESS | 15109 | |8;json-parse-financial;72;70;70;71;71;72;70;71;71;69 22:44:09 INFO - PROCESS | 15109 | |9;json-stringify-tinderbox;68;69;70;69;71;69;69;70;70;70 22:44:09 INFO - PROCESS | 15109 | |10;stanford-crypto-aes;84;85;86;92;87;83;85;85;86;83 22:44:09 INFO - PROCESS | 15109 | |11;stanford-crypto-ccm;126;125;129;120;128;128;127;122;129;120 22:44:09 INFO - PROCESS | 15109 | |12;stanford-crypto-pbkdf2;140;152;150;147;151;138;148;149;148;148 22:44:09 INFO - PROCESS | 15109 | |13;stanford-crypto-sha256-iterative;73;73;71;71;72;70;69;68;72;69 22:44:09 INFO - PROCESS | 15109 | __end_tp_report 22:44:09 INFO - PROCESS | 15109 | __start_cc_report 22:44:09 INFO - PROCESS | 15109 | _x_x_mozilla_cycle_collect,808 22:44:09 INFO - PROCESS | 15109 | __end_cc_report 22:44:09 INFO - PROCESS | 15109 | __startTimestamp1452926649286__endTimestamp 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | ------- Summary: start ------- 22:44:09 INFO - PROCESS | 15109 | Number of tests: 14 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:3.30 (2.9%) stddev-sans-first:3.48 22:44:09 INFO - PROCESS | 15109 | Values: 114.0 110.0 114.0 115.0 115.0 123.0 114.0 113.0 116.0 116.0 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:156.00 stddev:15.93 (10.2%) stddev-sans-first:16.77 22:44:09 INFO - PROCESS | 15109 | Values: 157.0 135.0 151.0 166.0 132.0 155.0 158.0 143.0 183.0 135.0 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.50 stddev:3.37 (2.0%) stddev-sans-first:3.18 22:44:09 INFO - PROCESS | 15109 | Values: 161.0 165.0 164.0 163.0 164.0 167.0 173.0 163.0 168.0 166.0 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | [#3] audio-fft Cycles:10 Average:79.40 Median:73.00 stddev:19.91 (27.3%) stddev-sans-first:20.98 22:44:09 INFO - PROCESS | 15109 | Values: 73.0 75.0 73.0 73.0 74.0 73.0 136.0 72.0 72.0 73.0 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:98.00 stddev:19.30 (19.7%) stddev-sans-first:19.97 22:44:09 INFO - PROCESS | 15109 | Values: 98.0 98.0 135.0 97.0 99.0 98.0 140.0 99.0 98.0 139.0 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:111.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 22:44:09 INFO - PROCESS | 15109 | Values: 110.0 110.0 109.0 110.0 111.0 111.0 110.0 111.0 111.0 111.0 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 22:44:09 INFO - PROCESS | 15109 | Values: 148.0 148.0 148.0 148.0 148.0 148.0 147.0 149.0 149.0 148.0 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 22:44:09 INFO - PROCESS | 15109 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 97.0 95.0 96.0 95.0 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | [#8] json-parse-financial Cycles:10 Average:70.70 Median:71.00 stddev:0.95 (1.3%) stddev-sans-first:0.88 22:44:09 INFO - PROCESS | 15109 | Values: 72.0 70.0 70.0 71.0 71.0 72.0 70.0 71.0 71.0 69.0 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:0.85 (1.2%) stddev-sans-first:0.71 22:44:09 INFO - PROCESS | 15109 | Values: 68.0 69.0 70.0 69.0 71.0 69.0 69.0 70.0 70.0 70.0 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.50 stddev:2.59 (3.0%) stddev-sans-first:2.68 22:44:09 INFO - PROCESS | 15109 | Values: 84.0 85.0 86.0 92.0 87.0 83.0 85.0 85.0 86.0 83.0 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:127.50 stddev:3.53 (2.8%) stddev-sans-first:3.74 22:44:09 INFO - PROCESS | 15109 | Values: 126.0 125.0 129.0 120.0 128.0 128.0 127.0 122.0 129.0 120.0 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.10 Median:148.50 stddev:4.56 (3.1%) stddev-sans-first:4.04 22:44:09 INFO - PROCESS | 15109 | Values: 140.0 152.0 150.0 147.0 151.0 138.0 148.0 149.0 148.0 148.0 22:44:09 INFO - PROCESS | 15109 | 22:44:09 INFO - PROCESS | 15109 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.50 stddev:1.75 (2.4%) stddev-sans-first:1.67 22:44:09 INFO - PROCESS | 15109 | Values: 73.0 73.0 71.0 71.0 72.0 70.0 69.0 68.0 72.0 69.0 22:44:09 INFO - PROCESS | 15109 | -------- Summary: end -------- 22:44:09 INFO - PROCESS | 15109 | 22:44:10 INFO - TEST-INFO | 15109: exit 0 22:44:10 INFO - TEST-OK | kraken | took 62493ms 22:44:10 INFO - TEST-START | v8_7 22:44:10 INFO - operating with platform_type : linux_ 22:44:10 INFO - Initialising browser for v8_7 test... 22:44:10 INFO - TEST-INFO | started process 15395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKqUiD5/profile http://localhost:49315/getInfo.html) 22:44:14 INFO - PROCESS | 15395 | 22:44:14 INFO - PROCESS | 15395 | (process:15469): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:44:15 INFO - PROCESS | 15395 | __metrics Screen width/height:1600/1200 22:44:15 INFO - PROCESS | 15395 | colorDepth:24 22:44:15 INFO - PROCESS | 15395 | Browser inner width/height: 1024/697 22:44:15 INFO - PROCESS | 15395 | __metrics 22:44:15 INFO - PROCESS | 15395 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:44:15 INFO - PROCESS | 15395 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 22:44:16 INFO - TEST-INFO | 15395: exit 0 22:44:16 INFO - Browser initialized. 22:44:16 INFO - Running cycle 1/1 for v8_7 test... 22:44:16 INFO - TEST-INFO | started process 15518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKqUiD5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:44:18 INFO - PROCESS | 15518 | 22:44:18 INFO - PROCESS | 15518 | (process:15574): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:44:28 INFO - PROCESS | 15518 | RSS: Main: 150507520 22:44:28 INFO - PROCESS | 15518 | 22:44:51 INFO - PROCESS | 15518 | Cycle 1(1): loaded http://localhost:49315/tests/v8_7/run.html (next: http://localhost:49315/tests/v8_7/run.html) 22:44:51 INFO - PROCESS | 15518 | RSS: Main: 145518592 22:44:51 INFO - PROCESS | 15518 | 22:44:51 INFO - PROCESS | 15518 | __start_tp_report 22:44:51 INFO - PROCESS | 15518 | _x_x_mozilla_page_load 22:44:51 INFO - PROCESS | 15518 | _x_x_mozilla_page_load_details 22:44:51 INFO - PROCESS | 15518 | |i|pagename|runs| 22:44:51 INFO - PROCESS | 15518 | |0;Richards;167.53224995811695 22:44:51 INFO - PROCESS | 15518 | |1;DeltaBlue;189.10741301059002 22:44:51 INFO - PROCESS | 15518 | |2;Encrypt;277.4694783573807 22:44:51 INFO - PROCESS | 15518 | |3;Decrypt;5229.166666666667 22:44:51 INFO - PROCESS | 15518 | |4;RayTrace;1078.7486515641856 22:44:51 INFO - PROCESS | 15518 | |5;Earley;719.1091954022988 22:44:51 INFO - PROCESS | 15518 | |6;Boyer;12256.09756097561 22:44:51 INFO - PROCESS | 15518 | |7;RegExp;43680.85106382979 22:44:51 INFO - PROCESS | 15518 | |8;Splay;598.813056379822 22:44:51 INFO - PROCESS | 15518 | |9;NavierStokes;4835.748792270531 22:44:51 INFO - PROCESS | 15518 | __end_tp_report 22:44:51 INFO - PROCESS | 15518 | __startTimestamp1452926691681__endTimestamp 22:44:51 INFO - PROCESS | 15518 | 22:44:51 INFO - PROCESS | 15518 | ------- Summary: start ------- 22:44:51 INFO - PROCESS | 15518 | Number of tests: 10 22:44:51 INFO - PROCESS | 15518 | 22:44:51 INFO - PROCESS | 15518 | [#0] Richards Cycles:1 Average:167.53 Median:167.53 stddev:0.00 (0.0%) 22:44:51 INFO - PROCESS | 15518 | Values: 167.5 22:44:51 INFO - PROCESS | 15518 | 22:44:51 INFO - PROCESS | 15518 | [#1] DeltaBlue Cycles:1 Average:189.11 Median:189.11 stddev:0.00 (0.0%) 22:44:51 INFO - PROCESS | 15518 | Values: 189.1 22:44:51 INFO - PROCESS | 15518 | 22:44:51 INFO - PROCESS | 15518 | [#2] Encrypt Cycles:1 Average:277.47 Median:277.47 stddev:0.00 (0.0%) 22:44:51 INFO - PROCESS | 15518 | Values: 277.5 22:44:51 INFO - PROCESS | 15518 | 22:44:51 INFO - PROCESS | 15518 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 22:44:51 INFO - PROCESS | 15518 | Values: 5229.2 22:44:51 INFO - PROCESS | 15518 | 22:44:51 INFO - PROCESS | 15518 | [#4] RayTrace Cycles:1 Average:1078.75 Median:1078.75 stddev:0.00 (0.0%) 22:44:51 INFO - PROCESS | 15518 | Values: 1078.7 22:44:51 INFO - PROCESS | 15518 | 22:44:51 INFO - PROCESS | 15518 | [#5] Earley Cycles:1 Average:719.11 Median:719.11 stddev:0.00 (0.0%) 22:44:51 INFO - PROCESS | 15518 | Values: 719.1 22:44:51 INFO - PROCESS | 15518 | 22:44:51 INFO - PROCESS | 15518 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 22:44:51 INFO - PROCESS | 15518 | Values: 12256.1 22:44:51 INFO - PROCESS | 15518 | 22:44:51 INFO - PROCESS | 15518 | [#7] RegExp Cycles:1 Average:43680.85 Median:43680.85 stddev:0.00 (0.0%) 22:44:51 INFO - PROCESS | 15518 | Values: 43680.9 22:44:51 INFO - PROCESS | 15518 | 22:44:51 INFO - PROCESS | 15518 | [#8] Splay Cycles:1 Average:598.81 Median:598.81 stddev:0.00 (0.0%) 22:44:51 INFO - PROCESS | 15518 | Values: 598.8 22:44:51 INFO - PROCESS | 15518 | 22:44:51 INFO - PROCESS | 15518 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 22:44:51 INFO - PROCESS | 15518 | Values: 4835.7 22:44:51 INFO - PROCESS | 15518 | -------- Summary: end -------- 22:44:51 INFO - PROCESS | 15518 | 22:44:52 INFO - TEST-INFO | 15518: exit 0 22:44:52 INFO - TEST-OK | v8_7 | took 42443ms 22:44:52 INFO - SUITE-END | took 1220s 22:44:53 INFO - Completed test suite (00:20:20) 22:44:53 INFO - Working with test: dromaeo_css 22:44:53 INFO - Generating results file: dromaeo_css 22:44:53 INFO - Working with test: kraken 22:44:53 INFO - Generating results file: kraken 22:44:53 INFO - javascript benchmark 22:44:53 INFO - Working with test: v8_7 22:44:53 INFO - Generating results file: v8_7 22:44:53 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:44:53 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 22:44:53 INFO - process_Request line: dromaeo_css 6031.39 graph.html#tests=[[72,132,43]] 22:44:53 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:44:53 INFO - process_Request line: kraken 1545.00 graph.html#tests=[[232,132,43]] 22:44:53 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:44:53 INFO - process_Request line: v8_7 20227.70 graph.html#tests=[[230,132,43]] 22:44:53 INFO - RETURN: dromaeo_css: 6031.39 22:44:53 INFO - RETURN: kraken: 1545.00 22:44:53 INFO - RETURN: v8_7: 20227.70 22:44:53 INFO - javascript benchmark 22:44:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2619.842809431434, 2655.0972669292437, 2683.8255513391628, 2693.0305090167535, 2701.1896431070672, 4494.438195225597, 4609.308603709441, 4625.398698169233, 4637.721736695797, 4667.533246675331, 4536.9092618147615, 4584.977075114628, 4641.071785642876, 4647.0, 4648.395708557883, 4248.320268756999, 4274.209271284807, 4301.419308393374, 4332.155229730204, 4366.170427618758, 4243.9814444533395, 4256.744595324275, 4298.9785051074705, 4320.265554855682, 4342.283523218665, 4171.249175148502, 4216.304309788881, 4237.724547904377, 4262.7655478948645, 4279.293916503773, 4268.807903644343, 4285.442892423996, 4286.6570674346285, 4296.119295544406, 4324.632406245473, 4293.527711951683, 4294.398784170218, 4295.957040429587, 4312.266914624522, 4332.523422423531, 4369.169857727022, 4476.239039363316, 4544.727316361029, 4593.265077587604, 4625.583697467244, 4855.4901735317635, 4880.316755654211, 4885.926711099336, 4907.828226012072, 4936.605071594264, 4738.384010078667, 4922.507749225085, 4933.901321973576, 4936.086823937547, 4987.226979818134, 4554.43069616298, 4569.1547063793305, 4575.130725162208, 4589.954100459019, 4626.930596041062, 4979.526944940225, 5023.522765337287, 5040.521150490697, 5074.264231686385, 5087.26234695967, 4636.11913736389, 4720.221163508051, 4835.95164048362, 4837.637177211653, 4910.53349931763, 4832.178529649968, 4844.709317440965, 4878.243872199815, 4904.485029071896, 4936.062148191832, 4855.077535268288, 4868.196747536687, 4875.926861097087, 4882.316475693406, 4887.437944636341, 4730.550597693214, 4819.132556139858, 4832.0, 4868.586170175504, 4925.852224433273, 4092.4066010428323, 4106.240345536085, 4112.0, 4120.876373708794, 4125.319322311785, 3614.566252049771, 3631.3645112105805, 3633.65480279373, 3665.5051568038507, 3667.669909708139, 4152.501699796044, 4229.0, 4249.1501699659575, 4253.957460425418, 4281.464816897887, 4909.631777616693, 4939.431965323962, 4956.430010548761, 4966.428860681068, 5015.0, 4304.80628371724, 4308.590683885089, 4319.049809042006, 4321.805518751664, 4358.6730995175485, 4226.535081141072, 4322.805473753689, 4331.956680433218, 4399.274119770202, 4414.624756895636, 4543.750093744809, 4548.6361091113295, 4635.351050852951, 4720.787564559534, 4744.620430365493, 4906.092372911023, 4907.460179380194, 4917.532834380728, 4919.0407870464915, 4968.701877887338, 4500.797464114057, 4656.9301460477445, 4660.813567457264, 4672.57946784791, 4708.3643708100335, 4807.567318941312, 4811.158047341632, 4856.295837103671, 4860.684055536379, 4917.360743103373, 4908.803647854046, 4910.189818679878, 4911.754412279301, 4911.975440122919, 4977.676451030671, 4637.814487420465, 4724.078804633064, 4752.42970843501, 4758.0, 4819.927701084416, 4731.432228132646, 4746.833860814855, 4780.713157210439, 4782.952170478251, 4814.0, 4677.602403795579, 4679.485256621837, 4700.694454860423, 4706.694064885772, 4714.151452738402, 4700.45944716362, 4743.478217396015, 4789.473157952552, 4812.374391329105, 4826.855194344175, 4654.9767251164885, 4682.15721170179, 4691.835785747482, 4703.082898834831, 4739.502352253102], "unit": "score", "name": "dojo.html", "value": 4515.120166464463}, {"lowerIsBetter": false, "replicates": [495.5317225222165, 497.1225786486849, 502.4799332690666, 513.4352212566178, 532.6590981771669, 32013.19967000823, 32607.836960815162, 32703.50944735828, 32791.04880560749, 32833.34333313332, 36363.45454818173, 36656.81671591645, 36996.81501592488, 37051.629483705154, 37089.44365834508, 7655.961720191419, 7868.6852525899185, 7916.287534121928, 7925.643346049413, 7939.523628582275, 7647.311741943224, 7760.650770715303, 7764.223577642247, 7771.689132434696, 7780.02749656293, 7905.288524032836, 7906.841863162734, 7961.60191990401, 7965.44241903067, 8015.639296231654, 7836.72571459999, 7880.4877682951, 7896.486728362638, 7916.762497125095, 7917.287444129998, 7775.300222979959, 7848.175941526115, 7899.973003509507, 7900.525968441912, 7938.563379014152, 35945.0, 36191.276174476625, 36379.27241455156, 36579.26841463183, 36659.63340366589, 2876.956845647317, 3053.3740583180393, 3227.983860080708, 3466.532018177539, 3566.8751593694096, 26762.73237267622, 26964.59553106705, 27038.459230815275, 27113.593296100575, 27719.584206236923, 3481.56480439945, 3489.7208223342072, 3491.214476742738, 3570.696490798285, 3590.6588874056924, 209038.0, 210051.0, 210243.0, 211033.0, 211092.99999999846, 46767.532324676315, 48160.0, 52597.2110418344, 52614.21078683823, 52686.47313526893, 59004.704976474844, 59645.701771490865, 59727.402725972184, 59827.70086149542, 59895.700521497114, 13404.865951340362, 13533.458661653423, 13695.383707733175, 13741.931290343484, 13789.793153102712, 10563.683089507327, 10571.10145637614, 10693.946530267454, 10707.464626768786, 10713.089387402159, 17996.190171442315, 18134.183961721756, 18168.818311816976, 19092.8090719091, 19096.427107186806, 6880.449564034865, 7080.999235431965, 7107.466939979522, 7108.147022357351, 7185.3533182012825, 797.3262593108814, 867.8915135608049, 878.2008372381102, 940.9623615055458, 956.9760356418566, 25332.240032799047, 25346.239612811645, 25465.61801572978, 25475.74524254734, 25530.0, 928.9396189247677, 970.7573106723319, 972.3922548407245, 1030.2736570717775, 1033.390299723167, 13303.534376296977, 13404.0, 13447.125936814271, 14195.290235488184, 14307.92846035763, 266567.0, 272064.0, 273909.0, 276790.0, 276992.0, 38782.41826372607, 38830.0, 39129.0, 39209.41185882214, 39258.214835703126, 1203.0, 1209.0629761934395, 1210.8607510136446, 1213.344793811332, 1334.873187047229, 24654.506909862062, 25293.74706252914, 25320.493590127724, 25551.361215969748, 25551.361215969748, 37495.2500949974, 37726.43410348792, 37773.0, 37786.0, 37823.0, 201253.0, 203447.0, 203538.0, 203694.0, 204493.0, 27250.591241131002, 28314.0, 28794.568081478377, 28896.42207155887, 29002.0, 32795.34409311753, 32948.0, 33224.50163247505, 33629.0, 33669.0, 28582.428351432438, 28949.42101157923, 28988.7101128986, 29723.0, 30909.0, 30937.690623094382, 30968.535471967487, 30995.0701478956, 31451.68548314579, 31692.207694807814, 28180.29549261203, 28388.574171387034, 28390.716092839633, 28605.570916435852, 28608.284792879513, 26441.888179184953, 28379.858100709363, 28521.572176416954, 28771.0, 28776.568351474325, 22772.31683049511, 22868.428289292235, 23050.193243236405, 23056.4235894104, 23198.0], "unit": "score", "name": "ext.html", "value": 16150.509033604225}, {"lowerIsBetter": false, "replicates": [337.35901786605444, 338.4567768731187, 340.3261542146548, 342.2060818900151, 344.5090745687395, 13967.16197028179, 14156.787648185273, 14993.700125997473, 15619.609509762247, 15660.686786264268, 9782.119609235167, 10019.098281154695, 11557.479913403897, 13768.793468097962, 13781.655458613539, 4490.708103973239, 4697.248440249561, 4698.412698412699, 4700.929486057712, 5152.175651895697, 5013.3232013678235, 5072.873178170538, 5092.821751238707, 5094.363204599425, 5105.540501354877, 4698.201305778009, 4818.68678535894, 4906.582940450066, 4909.975450122763, 5069.391672999227, 4815.614750819926, 4847.733374664392, 4853.3690620219495, 4897.04507621014, 5660.490555849952, 5019.472955339674, 5033.245013248005, 5039.218921067204, 5042.319286896295, 5051.722155281458, 10969.561217551289, 15689.68620627581, 17442.040687762168, 17876.731849022275, 17995.550111247194, 1721.1050253868043, 1734.7918249809977, 1741.582020315128, 1837.5406148462885, 1850.8334249917573, 7827.96086019572, 8312.127226641236, 9506.382085164441, 11795.705107372385, 11877.346745928971, 1727.4385824607052, 1777.6977913754563, 1821.7703050441032, 1825.6713791517523, 1835.715464103053, 47566.28650570244, 48244.7587762059, 48941.51058489405, 49311.2603310947, 49370.0125997478, 9408.388454750419, 9431.292653051049, 9573.569189386495, 9627.374220675634, 9633.036696330451, 12081.637550873487, 12115.878841211475, 12200.206986545845, 12239.69400764988, 12263.141580089308, 6770.830729231809, 6994.8950765738555, 7039.612821294878, 7062.71749130029, 7098.29017098286, 6726.293739157318, 6770.830729231809, 6800.761973331008, 6852.897206541906, 6875.243723190445, 3849.6920246380223, 3951.0, 4090.1206240658403, 4144.274751918402, 4176.83292668296, 1657.892237004591, 1675.0954484578192, 1700.3028758209075, 1739.365131726936, 1758.68343698133, 841.2260720137489, 858.9441686290371, 876.9605367758467, 902.9503377314179, 904.8280826642916, 14290.285485725672, 14583.781243281359, 14742.484013059491, 14956.326965286587, 14956.626084347761, 825.4923222218413, 834.7996480844554, 838.4633834346023, 909.6361455417754, 938.9342746007713, 8434.536100514408, 8512.106228845882, 8900.643974240958, 9153.81692366149, 9193.034731353111, 425375.0, 429636.0, 429956.0, 441418.0, 449231.0, 61239.0, 64415.0, 64563.0, 64566.35433645697, 64934.0, 1083.0415082651753, 1084.2301965604508, 1138.1009002887793, 1140.560884059643, 1157.6816375496805, 13713.862861371657, 13748.65628359259, 13804.723905521632, 13854.445822167001, 14125.011249212457, 30209.0, 30733.0, 30938.535921960738, 31262.218444538157, 31323.216919577193, 39473.80263098666, 39959.0, 40002.799986001046, 40147.79926100351, 40746.0, 5964.165016897551, 6137.508999280136, 6151.169592105009, 6304.873902522016, 6425.0, 7061.646917653994, 9253.491057991874, 9304.16262536375, 9371.484568348806, 9531.0, 7458.291462311072, 8153.714619988272, 8294.958525207336, 8510.48937063778, 8540.103289154798, 8275.172482751677, 8287.254147126787, 8395.514943537748, 8566.957165214384, 8576.313894888519, 8282.461639993382, 8428.11504791988, 8538.402311838112, 8546.359023073419, 8671.696490622799, 5814.622049566765, 5957.7319020645045, 5966.19456373384, 6118.776244751157, 6198.411150940653, 6394.648294343856, 8027.959860200662, 8052.194780521901, 8068.636911339121, 8142.918570814216], "unit": "score", "name": "jquery.html", "value": 7320.677949775821}, {"lowerIsBetter": false, "replicates": [1371.4788380415441, 1382.5575815738964, 1494.4097081652747, 1684.7725557049794, 1685.2332188854066, 6568.146141001669, 6608.702608382622, 6755.560888542247, 6757.864842703143, 6793.150856142982, 6545.8363540911505, 6595.505337099713, 6605.141331626882, 6625.3705897939735, 6669.133012708353, 1970.2020681623965, 1987.473319570315, 1994.9999999999927, 1995.1520603743425, 1999.590084032777, 2014.9798502015012, 2039.2556716798335, 2041.7958204179538, 2048.2523878784286, 2050.7026481160224, 1715.2624371520242, 1752.921118549662, 1969.832564232042, 2000.4998750312423, 2051.0, 1978.4064780565845, 1983.3554094919066, 1985.0570978785033, 1985.1265443205016, 1986.910589023483, 1956.9804301957083, 1974.6149500847341, 1999.150361096528, 2008.1164287713505, 2019.3336199054277, 6720.83197920051, 6736.6631668416385, 6755.763548275787, 6774.390304872536, 6778.966105169492, 3847.153626202259, 3978.562358140602, 4012.8194231259663, 4012.8996775080564, 4017.5982401759884, 2525.154073385418, 2538.5684433646325, 2571.7556832100922, 2577.832440891355, 2593.974060259411, 803.5419810707899, 809.9230573095547, 815.2988429950238, 830.2942498875907, 868.0754995929378, 8929.330300227444, 8970.50662213578, 8979.281657467387, 8995.955020224923, 9026.729198124067, 3365.495175723612, 3446.052335607728, 3458.8097654629237, 3472.8784492543145, 3477.878274260389, 7405.0, 7434.36807871337, 7440.14438339587, 7441.925580744231, 7460.253974602605, 3809.238152369537, 3829.0, 3840.8655697050467, 3845.673117784964, 3853.5953724858487, 3521.5774107107313, 3524.3656141894194, 3528.2414280929725, 3530.046887340404, 3550.5029295898594, 2954.512505436579, 2964.881404743786, 2979.3743313903888, 2980.6423229212633, 2986.566947792558, 851.1445996773327, 857.0315543435878, 861.1474640106375, 861.1775754154767, 864.628209869762, 836.1346006882846, 849.2908421468144, 894.0612357025097, 1068.369661899483, 1082.4046774274275, 6092.482139018233, 6125.9693701531205, 6151.446369826737, 6175.073738939105, 6222.253329600387, 536.9704666243395, 540.8323419739893, 548.4488089470057, 548.7146683724441, 672.2806596941226, 4695.107929493385, 4814.831480898151, 4820.758962051884, 4833.975830120898, 4839.201531747292, 7692.499987500794, 7712.691492340356, 7828.060632723996, 7936.246056624612, 7962.800929976797, 7776.805579860549, 7794.10367807698, 7807.0, 7855.175206603224, 7901.525908445396, 6190.3190649028575, 6251.218597675291, 6342.4926005919415, 6360.236771587439, 6369.172007638977, 6319.304876463493, 6406.199225096863, 6406.743730250924, 6415.807525774234, 6427.357264273723, 7143.464240182111, 7295.1610564783605, 7425.146108197627, 7458.291462311072, 7475.36459400957, 7472.065991751031, 7571.962140189264, 7664.501807382502, 7666.846663066819, 7737.883931741141, 6024.156618073385, 6051.606645568024, 6051.818445446644, 6063.302720187235, 6099.664518451527, 6051.727672254847, 6195.380461953769, 6205.0, 6259.092431597302, 6355.650439225887, 5928.3775203603, 5995.490383317467, 6031.065184896348, 6047.637141771508, 6056.939430605637, 5798.710064496674, 5904.763809447746, 5910.7931222407005, 5991.281046274475, 6039.365866584121, 5851.590388672752, 5886.882262354643, 5887.587868849139, 5894.911576326444, 5919.852003699942, 5491.341039075177, 5512.889742205053, 5521.475459831309, 5556.277683901067, 5558.221848941233, 5493.395726470165, 5526.115821468546, 5532.3637781655625, 5551.750171242385, 5587.636803607753], "unit": "score", "name": "mootools.html", "value": 3757.1809377455097}, {"lowerIsBetter": false, "replicates": [274.8670318329761, 281.9295176205947, 284.7266624040921, 288.2749884041636, 291.8015749290482, 5357.973210133953, 5549.112142057272, 5563.109902415615, 5620.831375058745, 5682.403347648499, 5492.47821456961, 5639.379668236501, 5639.915401268984, 5649.067903795879, 5653.547716182706, 4201.159768046396, 4206.915861682764, 4235.428217190671, 4244.087521182945, 4244.617984381405, 4218.093109981353, 4234.491860976687, 4240.363945408182, 4259.914801703964, 4260.97869510652, 3997.5802540733093, 4186.832526698943, 4194.97902510487, 4197.370394440828, 4199.433076534675, 4103.815328310233, 4104.774237416941, 4124.278251306009, 4125.030617804813, 4132.070284186064, 3515.1036485695986, 3520.700740437066, 3521.47177923311, 3528.7706299090733, 3529.770564913272, 5199.454057324002, 5302.787888484456, 5327.786888524454, 5370.3287089113865, 5408.080626293539, 4768.213244814636, 4779.545943135397, 4780.1873681474235, 4786.664933454659, 4792.544708252745, 5898.262717160355, 5898.616589921641, 5909.7636094556165, 5910.527157827363, 5915.674637894914, 3864.207837393356, 3866.903327416809, 3867.9613203867884, 3873.32216862048, 3875.5736868944678, 5981.5214782817275, 6177.227846519185, 6186.103015062836, 6199.070139479069, 6206.379362063803, 3984.5218573770753, 3984.7808370539897, 3985.960140398559, 3995.5604883462797, 4006.2187873364414, 4042.7574345538774, 4043.534993475729, 4047.8785636430953, 4054.614811592953, 4064.4716186896108, 4765.761711914391, 4768.904621907543, 4769.0, 4785.114753770564, 4805.087033463631, 5756.200907401095, 5885.793997210077, 5893.705314734246, 5903.1145328200255, 5925.762969481172, 1384.5846246126123, 1385.801281891177, 1386.9861301386857, 1391.7613324141523, 1391.9234442105578, 902.8149229408087, 902.9006809250977, 904.791897863482, 914.2229105260475, 920.581135583308, 5088.92366614501, 5122.743862806845, 5123.974380128076, 5131.179011358165, 5132.820351287687, 6093.11649810775, 6093.421124993119, 6093.451589356979, 6103.572749907553, 6107.572469927062, 5077.213031980049, 5115.514026167508, 5124.564412024945, 5131.5638170755155, 5144.768485418165, 3240.368128215023, 3302.653221411765, 3318.0875259303884, 3321.153105957965, 3324.335132973415, 5713.22871412354, 5730.169125476783, 5733.254676892061, 5743.253377060955, 5770.913436298459, 6006.579539432285, 6186.0, 6247.9062814057825, 6281.246250449975, 6302.936970630327, 5715.799947001919, 5817.621854579439, 5822.970885145547, 5838.386969368155, 5857.355690874086, 6084.908726369196, 6116.113163591343, 6116.5718399711595, 6133.877322453437, 6147.66187859672, 5810.186573879745, 5974.2233509643465, 6011.188489554029, 6073.696315184135, 6084.60450070744, 5781.94218057814, 5806.0, 5815.41845815415, 5820.970895145667, 5840.707964601838, 4022.4368588398233, 4090.570490098497, 4091.529474110396, 4111.280525908014, 4111.650509706708, 5966.49284810796, 6124.38756124384, 6126.050462178369, 6131.570790044654, 6144.631322120508, 5877.324107727666, 5880.529557635294, 5883.94116058834, 5888.617239879394, 5896.086106653475, 5845.532357411482, 5849.298084229919, 5892.6759028253855, 5926.881462370642, 5927.940720592911, 5719.942800571941, 5729.54163666914, 5741.885162296814, 5746.798862039808, 5760.567957403127, 5751.568632352507, 5962.4633782959745, 5963.761449541969, 5987.64074155552, 6005.849853753516, 5720.799772007959, 5732.512736417451, 5737.799177028784, 5748.425157484218, 5755.798547050833], "unit": "score", "name": "prototype.html", "value": 4323.084066859921}, {"lowerIsBetter": false, "replicates": [635.3551145587227, 666.3669513961737, 697.1355519156248, 760.8440269744701, 768.5811232878083, 11172.329660220392, 11394.0, 11416.714582135452, 11426.143039272047, 11430.314181149126, 11449.771004579903, 11691.298522088659, 11693.473793679284, 11705.23915945463, 11707.239029463079, 590.4213870407003, 600.1118344849604, 739.7226040234912, 748.3788455581881, 755.165542076005, 735.3161559749431, 745.083547236899, 749.0412272291476, 749.5727435361846, 757.8976838126865, 782.284209947897, 783.8510682970245, 787.2678409079554, 788.9368850491976, 795.932345750612, 778.01581000035, 778.3539662080516, 780.7228433905967, 783.0485959559135, 790.6165509727778, 579.8753268047348, 585.2216551985848, 585.645684360964, 587.9882402351972, 589.1369144203762, 11597.826032609517, 11652.708682282926, 11667.708307292301, 11722.824157637642, 11724.472398742077, 11390.202685811997, 11747.6265783317, 11782.941085294518, 11995.700107497383, 12112.031037516977, 9505.667301644478, 9723.173530249936, 9723.416595004323, 9941.65204217849, 9948.900510994943, 3239.0282915125604, 3286.556314897482, 3327.96672033279, 3350.0619826448633, 3378.847951842173, 39472.40791388132, 39977.200455991006, 40275.59724402777, 40651.0, 40713.98215044648, 8924.419912705653, 9003.954980225188, 9066.138716822023, 9150.63397464094, 9339.579718912666, 15469.381224751109, 15646.295916683548, 15685.13731744765, 15697.372105115895, 15710.371585136696, 6211.223597050369, 6236.251649802053, 6262.812115636538, 6384.808455746335, 6403.391677790602, 3621.0766254604905, 3668.798216098087, 3711.3319602471274, 3711.5917249102577, 3738.1962877981364, 2420.6248031554783, 2448.522538105088, 2458.029078513977, 2472.9752702473106, 2475.55440020798, 441.22124450345166, 448.60746846509306, 453.7164272329794, 455.8131166221833, 461.7183518053984, 430.01741021765116, 555.7332480409426, 568.0882184094552, 570.7460180219763, 578.6528083150076, 7329.486935914541, 7354.3748781353115, 7430.294122058396, 7558.093028836574, 7653.3494652954005, 447.4988013424985, 469.40151307083744, 471.32129733184104, 561.800560800918, 572.0, 3520.3663340598937, 3585.608001942973, 3727.6086010968456, 3777.0557360659836, 3888.2612303662213, 41300.793496032325, 41302.0, 41351.586484135376, 41367.58632413697, 41468.585314146476, 39479.605203948166, 41092.38361424521, 41148.79425602853, 41534.37698434526, 41624.583754162675, 35574.82212588921, 40844.1831163381, 41309.380359294635, 41730.0, 42219.788901055916, 7812.414068944739, 7836.490628109154, 7855.214478552099, 7884.172161923145, 7984.361251099782, 29668.109956701333, 29891.0, 29996.85001574978, 30091.247718807204, 30531.389372212874, 34640.133996649274, 35125.29749404947, 37884.43173352457, 37890.0, 38128.42807357836, 10109.191264698953, 10194.694159175237, 10350.741231469274, 10468.476576171313, 10832.512536936014, 10907.29102608328, 11153.330800152016, 11449.0, 11489.885101149215, 11939.283642981449, 10481.737956550842, 10997.450127493754, 11023.944880275869, 11032.944835276094, 11371.829422558834, 10129.797404052026, 10450.477476126316, 10723.892761072602, 10808.675739727822, 11069.612563560237, 10778.461076945965, 10828.0, 11016.283941543774, 11038.503267352828, 11372.829407558727, 8301.6679332826, 8429.704960326359, 8555.401121921655, 8571.785705357166, 8965.775855603662, 8874.467531947845, 9390.036548942317, 9403.670871519464, 9500.762480938032, 9550.249861188251], "unit": "score", "name": "yui.html", "value": 5551.309852326664}], "name": "dromaeo_css", "value": 6031.3859637911055}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 114.0, 115.0, 115.0, 123.0, 114.0, 113.0, 116.0, 116.0], "unit": "score", "name": "ai-astar", "value": 115.0}, {"lowerIsBetter": true, "replicates": [157.0, 135.0, 151.0, 166.0, 132.0, 155.0, 158.0, 143.0, 183.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [161.0, 165.0, 164.0, 163.0, 164.0, 167.0, 173.0, 163.0, 168.0, 166.0], "unit": "score", "name": "audio-dft", "value": 165.4}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 73.0, 73.0, 74.0, 73.0, 136.0, 72.0, 72.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 135.0, 97.0, 99.0, 98.0, 140.0, 99.0, 98.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 111.0, 111.0, 110.0, 111.0, 111.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 149.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 70.0, 71.0, 71.0, 72.0, 70.0, 71.0, 71.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 70.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 69.0, 71.0, 69.0, 69.0, 70.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 92.0, 87.0, 83.0, 85.0, 85.0, 86.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [126.0, 125.0, 129.0, 120.0, 128.0, 128.0, 127.0, 122.0, 129.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [140.0, 152.0, 150.0, 147.0, 151.0, 138.0, 148.0, 149.0, 148.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 71.0, 71.0, 72.0, 70.0, 69.0, 68.0, 72.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1544.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.53224995811695], "unit": "score", "name": "Richards", "value": 210.71763800000005}, {"lowerIsBetter": false, "replicates": [189.10741301059002], "unit": "score", "name": "DeltaBlue", "value": 349.631984}, {"lowerIsBetter": false, "replicates": [277.4694783573807], "unit": "score", "name": "Encrypt", "value": 959.316324}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1078.7486515641856], "unit": "score", "name": "RayTrace", "value": 685.9698030000003}, {"lowerIsBetter": false, "replicates": [719.1091954022988], "unit": "score", "name": "Earley", "value": 926.7897062937063}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [43680.85106382979], "unit": "score", "name": "RegExp", "value": 20.855477350219186}, {"lowerIsBetter": false, "replicates": [598.813056379822], "unit": "score", "name": "Splay", "value": 136.0875470763132}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20227.702324548864}]} 22:44:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20227.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1545.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6031.39"}}} 22:44:53 INFO - Return code: 0 22:44:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:44:53 INFO - # TBPL SUCCESS # 22:44:53 INFO - Running post-action listener: _resource_record_post_action 22:44:53 INFO - Running post-run listener: _resource_record_post_run 22:44:54 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 0; Write bytes: 537956352; Read time: 0; Write time: 680128 22:44:54 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 175824896; Read time: 0; Write time: 277456 22:44:54 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 0; Write bytes: 307929088; Read time: 0; Write time: 365964 22:44:54 INFO - Running post-run listener: _upload_blobber_files 22:44:54 INFO - Blob upload gear active. 22:44:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:44:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:44:54 INFO - (blobuploader) - INFO - Open directory for files ... 22:44:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:44:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:44:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:44:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:44:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:44:55 INFO - (blobuploader) - INFO - Done attempting. 22:44:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:44:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:44:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:44:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:44:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:44:56 INFO - (blobuploader) - INFO - Done attempting. 22:44:56 INFO - (blobuploader) - INFO - Iteration through files over. 22:44:56 INFO - Return code: 0 22:44:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:44:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:44:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1a97cf3e572c0338261dd15eca4794096420024aa4eb8de744d7fbb06da7b498e1984ece31e79f3c10e93dcee1ea760495efad0f3ed5885c4edd003197740a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/190096370d9c1a7a1d4f0687dccb4f953a56226ab9ae5572e3cdb245e7b36d72a88d20d5d985b8ecaa7eca7129107173f76bae8c004140a43881dab1892c3bd7"} 22:44:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:44:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:44:56 INFO - Contents: 22:44:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1a97cf3e572c0338261dd15eca4794096420024aa4eb8de744d7fbb06da7b498e1984ece31e79f3c10e93dcee1ea760495efad0f3ed5885c4edd003197740a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/190096370d9c1a7a1d4f0687dccb4f953a56226ab9ae5572e3cdb245e7b36d72a88d20d5d985b8ecaa7eca7129107173f76bae8c004140a43881dab1892c3bd7"} 22:44:56 INFO - Running post-run listener: copy_logs_to_upload_dir 22:44:56 INFO - Copying logs to upload dir... 22:44:56 INFO - mkdir: /builds/slave/test/build/upload/logs 22:44:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1294.945750 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-01-15 22:44:56.736307) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 22:44:56.739972) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1a97cf3e572c0338261dd15eca4794096420024aa4eb8de744d7fbb06da7b498e1984ece31e79f3c10e93dcee1ea760495efad0f3ed5885c4edd003197740a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/190096370d9c1a7a1d4f0687dccb4f953a56226ab9ae5572e3cdb245e7b36d72a88d20d5d985b8ecaa7eca7129107173f76bae8c004140a43881dab1892c3bd7"} build_url:https://queue.taskcluster.net/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/TMPvD1VIRX2mYI5lsoCdFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1a97cf3e572c0338261dd15eca4794096420024aa4eb8de744d7fbb06da7b498e1984ece31e79f3c10e93dcee1ea760495efad0f3ed5885c4edd003197740a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/190096370d9c1a7a1d4f0687dccb4f953a56226ab9ae5572e3cdb245e7b36d72a88d20d5d985b8ecaa7eca7129107173f76bae8c004140a43881dab1892c3bd7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 22:44:56.764679) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 22:44:56.765019) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452925145.875853-1795463681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 22:44:56.850177) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 22:44:56.850844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 22:44:56.851215) ========= ========= Total master_lag: 0.32 =========