builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1452517509.52 results: success (0) buildid: 20160111032031 builduid: 55322e2d299c4d649c9d86fa41d42c73 revision: 121a7977bd8169f013f2a3025b01d1e1b3b60a2d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:09.520361) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:09.520878) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:09.521205) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006285 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:09.544316) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:09.544630) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:09.558076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:09.558471) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:09.607965) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:09.608430) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:09.608872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:09.609190) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 05:05:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-01-11 05:05:10 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151424 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:09.773814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:09.774130) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020864 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:09.824524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-11 05:05:09.824960) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 121a7977bd8169f013f2a3025b01d1e1b3b60a2d --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 121a7977bd8169f013f2a3025b01d1e1b3b60a2d --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=74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 05:05:10,247 truncating revision to first 12 chars 2016-01-11 05:05:10,247 Setting DEBUG logging. 2016-01-11 05:05:10,247 attempt 1/10 2016-01-11 05:05:10,247 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/121a7977bd81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 05:05:10,924 unpacking tar archive at: fx-team-121a7977bd81/testing/mozharness/ program finished with exit code 0 elapsedTime=1.001555 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-11 05:05:10.840444) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:10.840832) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:10.851725) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:10.852337) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 05:05:10.853106) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-11 05:05:10.853633) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:05:11 INFO - MultiFileLogger online at 20160111 05:05:11 in /builds/slave/test 05:05:11 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 05:05:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:05:11 INFO - {'append_to_log': False, 05:05:11 INFO - 'base_work_dir': '/builds/slave/test', 05:05:11 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:05:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:05:11 INFO - 'branch': 'Fx-Team-Non-PGO', 05:05:11 INFO - 'buildbot_json_path': 'buildprops.json', 05:05:11 INFO - 'config_files': ('talos/linux_config.py',), 05:05:11 INFO - 'default_actions': ('clobber', 05:05:11 INFO - 'read-buildbot-config', 05:05:11 INFO - 'download-and-extract', 05:05:11 INFO - 'populate-webroot', 05:05:11 INFO - 'create-virtualenv', 05:05:11 INFO - 'install', 05:05:11 INFO - 'run-tests'), 05:05:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:05:11 INFO - 'download_minidump_stackwalk': True, 05:05:11 INFO - 'download_symbols': 'ondemand', 05:05:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:05:11 INFO - 'tooltool.py': '/tools/tooltool.py', 05:05:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:05:11 INFO - '/tools/misc-python/virtualenv.py')}, 05:05:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:05:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:05:11 INFO - 'installer_path': 'installer.exe', 05:05:11 INFO - 'log_level': 'info', 05:05:11 INFO - 'log_name': 'talos', 05:05:11 INFO - 'log_to_console': True, 05:05:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:05:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:05:11 INFO - 'opt_config_files': (), 05:05:11 INFO - 'pip_index': False, 05:05:11 INFO - 'sps_profile': False, 05:05:11 INFO - 'sps_profile_interval': 0, 05:05:11 INFO - 'suite': 'dromaeojs-e10s', 05:05:11 INFO - 'system_bits': '32', 05:05:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:05:11 INFO - 'title': 'talos-linux64-ix-042', 05:05:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:05:11 INFO - 'use_talos_json': True, 05:05:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:05:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:05:11 INFO - 'work_dir': 'build'} 05:05:11 INFO - ##### 05:05:11 INFO - ##### Running clobber step. 05:05:11 INFO - ##### 05:05:11 INFO - Running pre-action listener: _resource_record_pre_action 05:05:11 INFO - Running main action method: clobber 05:05:11 INFO - rmtree: /builds/slave/test/build 05:05:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:05:11 INFO - Running post-action listener: _resource_record_post_action 05:05:11 INFO - ##### 05:05:11 INFO - ##### Running read-buildbot-config step. 05:05:11 INFO - ##### 05:05:11 INFO - Running pre-action listener: _resource_record_pre_action 05:05:11 INFO - Running main action method: read_buildbot_config 05:05:11 INFO - Using buildbot properties: 05:05:11 INFO - { 05:05:11 INFO - "project": "", 05:05:11 INFO - "product": "firefox", 05:05:11 INFO - "script_repo_revision": "production", 05:05:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:05:11 INFO - "repository": "", 05:05:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:05:11 INFO - "buildid": "20160111032031", 05:05:11 INFO - "pgo_build": "False", 05:05:11 INFO - "basedir": "/builds/slave/test", 05:05:11 INFO - "buildnumber": 943, 05:05:11 INFO - "slavename": "talos-linux64-ix-042", 05:05:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:05:11 INFO - "platform": "ubuntu64_hw", 05:05:11 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:05:11 INFO - "branch": "fx-team", 05:05:11 INFO - "repo_path": "integration/fx-team", 05:05:11 INFO - "revision": "121a7977bd8169f013f2a3025b01d1e1b3b60a2d", 05:05:11 INFO - "stage_platform": "linux64", 05:05:11 INFO - "builduid": "55322e2d299c4d649c9d86fa41d42c73", 05:05:11 INFO - "slavebuilddir": "test" 05:05:11 INFO - } 05:05:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:05:11 INFO - Running post-action listener: _resource_record_post_action 05:05:11 INFO - ##### 05:05:11 INFO - ##### Running download-and-extract step. 05:05:11 INFO - ##### 05:05:11 INFO - Running pre-action listener: _resource_record_pre_action 05:05:11 INFO - Running main action method: download_and_extract 05:05:11 INFO - mkdir: /builds/slave/test/build/tests 05:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:11 INFO - https://queue.taskcluster.net/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:05:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/test_packages.json 05:05:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/test_packages.json 05:05:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:05:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:05:12 INFO - Downloaded 1302 bytes. 05:05:12 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:05:12 INFO - Using the following test package requirements: 05:05:12 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:05:12 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:05:12 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:12 INFO - u'jsshell-linux-x86_64.zip'], 05:05:12 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:05:12 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:05:12 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:05:12 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:05:12 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:05:12 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:05:12 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:05:12 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:12 INFO - https://queue.taskcluster.net/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:05:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:05:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:05:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/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 05:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/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 05:05:14 INFO - Downloaded 22761567 bytes. 05:05:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:05:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:05:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:05:15 INFO - Return code: 0 05:05:15 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 05:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:15 INFO - https://queue.taskcluster.net/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:05:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:05:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:05:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/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 05:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/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 05:05:18 INFO - Downloaded 22761567 bytes. 05:05:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:05:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:05:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:05:19 INFO - Return code: 0 05:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:19 INFO - https://queue.taskcluster.net/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:05:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:05:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:05:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/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 05:05:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/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 05:05:21 INFO - Downloaded 11132285 bytes. 05:05:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 05:05:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:05:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:05:21 INFO - Return code: 0 05:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:21 INFO - https://queue.taskcluster.net/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:05:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:05:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:05:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/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 05:05:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeCfVW7tQz6RQWVb2PoM3w/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 05:05:26 INFO - Downloaded 54054865 bytes. 05:05:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:05:26 INFO - mkdir: /builds/slave/test/properties 05:05:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:05:26 INFO - Writing to file /builds/slave/test/properties/build_url 05:05:26 INFO - Contents: 05:05:26 INFO - build_url:https://queue.taskcluster.net/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:05:26 INFO - Running post-action listener: _resource_record_post_action 05:05:26 INFO - Running post-action listener: set_extra_try_arguments 05:05:26 INFO - ##### 05:05:26 INFO - ##### Running populate-webroot step. 05:05:26 INFO - ##### 05:05:26 INFO - Running pre-action listener: _resource_record_pre_action 05:05:26 INFO - Running main action method: populate_webroot 05:05:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:05:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:05:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:05:27 INFO - '--tppagecycles', 05:05:27 INFO - '7'], 05:05:27 INFO - 'tests': ['tsvgm']}}, 05:05:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:05:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:05:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:05:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:05:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:05:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:05:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:27 INFO - 'talos_options': ['--e10s'], 05:05:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:27 INFO - 'tests': ['damp', 'tps']}, 05:05:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:27 INFO - 'talos_options': ['--e10s'], 05:05:27 INFO - 'tests': ['damp', 'tps']}, 05:05:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:05:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:05:27 INFO - 'other': {'tests': ['a11yr', 05:05:27 INFO - 'ts_paint', 05:05:27 INFO - 'tpaint', 05:05:27 INFO - 'sessionrestore', 05:05:27 INFO - 'sessionrestore_no_auto_restore']}, 05:05:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:05:27 INFO - 'tests': ['a11yr', 05:05:27 INFO - 'ts_paint', 05:05:27 INFO - 'tpaint', 05:05:27 INFO - 'sessionrestore', 05:05:27 INFO - 'sessionrestore_no_auto_restore']}, 05:05:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:05:27 INFO - 'tests': ['a11yr', 05:05:27 INFO - 'ts_paint', 05:05:27 INFO - 'tpaint', 05:05:27 INFO - 'sessionrestore', 05:05:27 INFO - 'sessionrestore_no_auto_restore']}, 05:05:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:05:27 INFO - 'tests': ['a11yr', 05:05:27 INFO - 'ts_paint', 05:05:27 INFO - 'tpaint', 05:05:27 INFO - 'sessionrestore', 05:05:27 INFO - 'sessionrestore_no_auto_restore']}, 05:05:27 INFO - 'other_l64': {'tests': ['a11yr', 05:05:27 INFO - 'ts_paint', 05:05:27 INFO - 'tpaint', 05:05:27 INFO - 'sessionrestore', 05:05:27 INFO - 'sessionrestore_no_auto_restore']}, 05:05:27 INFO - 'other_nol64': {'tests': ['a11yr', 05:05:27 INFO - 'ts_paint', 05:05:27 INFO - 'tpaint', 05:05:27 INFO - 'sessionrestore', 05:05:27 INFO - 'sessionrestore_no_auto_restore']}, 05:05:27 INFO - 'svgr': {'tests': ['tsvgx', 05:05:27 INFO - 'tsvgr_opacity', 05:05:27 INFO - 'tart', 05:05:27 INFO - 'tscrollx', 05:05:27 INFO - 'cart']}, 05:05:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:05:27 INFO - 'tests': ['tsvgx', 05:05:27 INFO - 'tsvgr_opacity', 05:05:27 INFO - 'tart', 05:05:27 INFO - 'tscrollx', 05:05:27 INFO - 'cart']}, 05:05:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:27 INFO - 'tests': ['tp5o']}, 05:05:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:27 INFO - 'talos_options': ['--e10s'], 05:05:27 INFO - 'tests': ['tp5o']}, 05:05:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:27 INFO - 'talos_options': ['--xperf_path', 05:05:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:27 INFO - 'tests': ['tp5n']}, 05:05:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:27 INFO - 'talos_options': ['--e10s', 05:05:27 INFO - '--xperf_path', 05:05:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:27 INFO - 'tests': ['tp5n']}}, 05:05:27 INFO - 'talos.zip': {'path': '', 05:05:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:05:27 INFO - Running post-action listener: _resource_record_post_action 05:05:27 INFO - ##### 05:05:27 INFO - ##### Running create-virtualenv step. 05:05:27 INFO - ##### 05:05:27 INFO - Running pre-action listener: _resource_record_pre_action 05:05:27 INFO - Running main action method: create_virtualenv 05:05:27 INFO - Creating virtualenv /builds/slave/test/build/venv 05:05:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:05:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:05:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:05:27 INFO - Using real prefix '/usr' 05:05:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:05:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:05:29 INFO - Installing pip.................done. 05:05:29 INFO - Return code: 0 05:05:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:29 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 0x7f81f445af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24613d0>, '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 0x23cced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:05:29 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 05:05:29 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 05:05:29 INFO - Using env: {'DISPLAY': ':0', 05:05:29 INFO - 'HOME': '/home/cltbld', 05:05:29 INFO - 'LANG': 'en_US.UTF-8', 05:05:29 INFO - 'LANGUAGE': 'en_US:en', 05:05:29 INFO - 'LOGNAME': 'cltbld', 05:05:29 INFO - 'MAIL': '/var/mail/cltbld', 05:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:29 INFO - 'MOZ_NO_REMOTE': '1', 05:05:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:29 INFO - 'NO_EM_RESTART': '1', 05:05:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:29 INFO - 'PWD': '/builds/slave/test', 05:05:29 INFO - 'SHELL': '/bin/bash', 05:05:29 INFO - 'SHLVL': '1', 05:05:29 INFO - 'TERM': 'linux', 05:05:29 INFO - 'TMOUT': '86400', 05:05:29 INFO - 'USER': 'cltbld', 05:05:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 05:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:29 INFO - '_': '/tools/buildbot/bin/python'} 05:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:05:29 INFO - Cleaning up... 05:05:29 INFO - Return code: 0 05:05:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:29 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 0x7f81f445af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24613d0>, '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 0x23cced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:05:29 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 05:05:29 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 05:05:29 INFO - Using env: {'DISPLAY': ':0', 05:05:29 INFO - 'HOME': '/home/cltbld', 05:05:29 INFO - 'LANG': 'en_US.UTF-8', 05:05:29 INFO - 'LANGUAGE': 'en_US:en', 05:05:29 INFO - 'LOGNAME': 'cltbld', 05:05:29 INFO - 'MAIL': '/var/mail/cltbld', 05:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:29 INFO - 'MOZ_NO_REMOTE': '1', 05:05:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:29 INFO - 'NO_EM_RESTART': '1', 05:05:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:29 INFO - 'PWD': '/builds/slave/test', 05:05:29 INFO - 'SHELL': '/bin/bash', 05:05:29 INFO - 'SHLVL': '1', 05:05:29 INFO - 'TERM': 'linux', 05:05:29 INFO - 'TMOUT': '86400', 05:05:29 INFO - 'USER': 'cltbld', 05:05:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 05:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:29 INFO - '_': '/tools/buildbot/bin/python'} 05:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:30 INFO - Downloading/unpacking psutil>=0.7.1 05:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:31 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:05:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:05:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:05:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:32 INFO - Installing collected packages: psutil 05:05:32 INFO - Running setup.py install for psutil 05:05:32 INFO - building 'psutil._psutil_linux' extension 05:05:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:05:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:05:32 INFO - building 'psutil._psutil_posix' extension 05:05:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:05:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:05:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:32 INFO - Successfully installed psutil 05:05:32 INFO - Cleaning up... 05:05:32 INFO - Return code: 0 05:05:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:32 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 0x7f81f445af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24613d0>, '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 0x23cced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:05:32 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 05:05:32 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 05:05:32 INFO - Using env: {'DISPLAY': ':0', 05:05:32 INFO - 'HOME': '/home/cltbld', 05:05:32 INFO - 'LANG': 'en_US.UTF-8', 05:05:32 INFO - 'LANGUAGE': 'en_US:en', 05:05:32 INFO - 'LOGNAME': 'cltbld', 05:05:32 INFO - 'MAIL': '/var/mail/cltbld', 05:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:32 INFO - 'MOZ_NO_REMOTE': '1', 05:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:32 INFO - 'NO_EM_RESTART': '1', 05:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:32 INFO - 'PWD': '/builds/slave/test', 05:05:32 INFO - 'SHELL': '/bin/bash', 05:05:32 INFO - 'SHLVL': '1', 05:05:32 INFO - 'TERM': 'linux', 05:05:32 INFO - 'TMOUT': '86400', 05:05:32 INFO - 'USER': 'cltbld', 05:05:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 05:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:32 INFO - '_': '/tools/buildbot/bin/python'} 05:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:05:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:05:34 INFO - Installing collected packages: mozsystemmonitor 05:05:34 INFO - Running setup.py install for mozsystemmonitor 05:05:34 INFO - Successfully installed mozsystemmonitor 05:05:34 INFO - Cleaning up... 05:05:34 INFO - Return code: 0 05:05:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:34 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 0x7f81f445af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24613d0>, '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 0x23cced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:05:34 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 05:05:34 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 05:05:34 INFO - Using env: {'DISPLAY': ':0', 05:05:34 INFO - 'HOME': '/home/cltbld', 05:05:34 INFO - 'LANG': 'en_US.UTF-8', 05:05:34 INFO - 'LANGUAGE': 'en_US:en', 05:05:34 INFO - 'LOGNAME': 'cltbld', 05:05:34 INFO - 'MAIL': '/var/mail/cltbld', 05:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:34 INFO - 'MOZ_NO_REMOTE': '1', 05:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:34 INFO - 'NO_EM_RESTART': '1', 05:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:34 INFO - 'PWD': '/builds/slave/test', 05:05:34 INFO - 'SHELL': '/bin/bash', 05:05:34 INFO - 'SHLVL': '1', 05:05:34 INFO - 'TERM': 'linux', 05:05:34 INFO - 'TMOUT': '86400', 05:05:34 INFO - 'USER': 'cltbld', 05:05:34 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 05:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:34 INFO - '_': '/tools/buildbot/bin/python'} 05:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:34 INFO - Downloading/unpacking blobuploader==1.2.4 05:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:05:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:05:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:05:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:37 INFO - Downloading docopt-0.6.1.tar.gz 05:05:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:05:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:05:37 INFO - Running setup.py install for blobuploader 05:05:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:05:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:05:37 INFO - Running setup.py install for requests 05:05:37 INFO - Running setup.py install for docopt 05:05:37 INFO - Successfully installed blobuploader requests docopt 05:05:37 INFO - Cleaning up... 05:05:37 INFO - Return code: 0 05:05:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:37 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 0x7f81f445af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24613d0>, '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 0x23cced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:05:37 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 05:05:37 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 05:05:37 INFO - Using env: {'DISPLAY': ':0', 05:05:37 INFO - 'HOME': '/home/cltbld', 05:05:37 INFO - 'LANG': 'en_US.UTF-8', 05:05:37 INFO - 'LANGUAGE': 'en_US:en', 05:05:37 INFO - 'LOGNAME': 'cltbld', 05:05:37 INFO - 'MAIL': '/var/mail/cltbld', 05:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:37 INFO - 'MOZ_NO_REMOTE': '1', 05:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:37 INFO - 'NO_EM_RESTART': '1', 05:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:37 INFO - 'PWD': '/builds/slave/test', 05:05:37 INFO - 'SHELL': '/bin/bash', 05:05:37 INFO - 'SHLVL': '1', 05:05:37 INFO - 'TERM': 'linux', 05:05:37 INFO - 'TMOUT': '86400', 05:05:37 INFO - 'USER': 'cltbld', 05:05:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 05:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:37 INFO - '_': '/tools/buildbot/bin/python'} 05:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:38 INFO - Running setup.py (path:/tmp/pip-RIpGmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:38 INFO - Running setup.py (path:/tmp/pip-pX0LL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:38 INFO - Running setup.py (path:/tmp/pip-FLn3Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:38 INFO - Running setup.py (path:/tmp/pip-pswWTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:38 INFO - Running setup.py (path:/tmp/pip-kZEWve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:38 INFO - Running setup.py (path:/tmp/pip-J01GT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:38 INFO - Running setup.py (path:/tmp/pip-krP7Kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:38 INFO - Running setup.py (path:/tmp/pip-Ix0DnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:38 INFO - Running setup.py (path:/tmp/pip-mH0jVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:38 INFO - Running setup.py (path:/tmp/pip-G1r6e1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:38 INFO - Running setup.py (path:/tmp/pip-2IbWsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:38 INFO - Running setup.py (path:/tmp/pip-peA72l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:38 INFO - Running setup.py (path:/tmp/pip-RQKwxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:39 INFO - Running setup.py (path:/tmp/pip-fmIZB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:39 INFO - Running setup.py (path:/tmp/pip-lwJkf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:39 INFO - Running setup.py (path:/tmp/pip-TnnENZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:39 INFO - Running setup.py (path:/tmp/pip-BbsDNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:05:39 INFO - Running setup.py install for manifestparser 05:05:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:05:39 INFO - Running setup.py install for mozcrash 05:05:39 INFO - Running setup.py install for mozdebug 05:05:39 INFO - Running setup.py install for mozdevice 05:05:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:05:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:05:39 INFO - Running setup.py install for mozfile 05:05:39 INFO - Running setup.py install for mozhttpd 05:05:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:05:39 INFO - Running setup.py install for mozinfo 05:05:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:05:40 INFO - Running setup.py install for mozInstall 05:05:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:05:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:05:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:05:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:05:40 INFO - Running setup.py install for mozleak 05:05:40 INFO - Running setup.py install for mozlog 05:05:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:05:40 INFO - Running setup.py install for moznetwork 05:05:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:05:40 INFO - Running setup.py install for mozprocess 05:05:40 INFO - Running setup.py install for mozprofile 05:05:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:05:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:05:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:05:40 INFO - Running setup.py install for mozrunner 05:05:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:05:40 INFO - Running setup.py install for mozscreenshot 05:05:40 INFO - Running setup.py install for moztest 05:05:40 INFO - Running setup.py install for mozversion 05:05:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:05:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:05:41 INFO - Cleaning up... 05:05:41 INFO - Return code: 0 05:05:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:41 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 0x7f81f445af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24613d0>, '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 0x23cced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:05:41 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 05:05:41 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 05:05:41 INFO - Using env: {'DISPLAY': ':0', 05:05:41 INFO - 'HOME': '/home/cltbld', 05:05:41 INFO - 'LANG': 'en_US.UTF-8', 05:05:41 INFO - 'LANGUAGE': 'en_US:en', 05:05:41 INFO - 'LOGNAME': 'cltbld', 05:05:41 INFO - 'MAIL': '/var/mail/cltbld', 05:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:41 INFO - 'MOZ_NO_REMOTE': '1', 05:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:41 INFO - 'NO_EM_RESTART': '1', 05:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:41 INFO - 'PWD': '/builds/slave/test', 05:05:41 INFO - 'SHELL': '/bin/bash', 05:05:41 INFO - 'SHLVL': '1', 05:05:41 INFO - 'TERM': 'linux', 05:05:41 INFO - 'TMOUT': '86400', 05:05:41 INFO - 'USER': 'cltbld', 05:05:41 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 05:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:41 INFO - '_': '/tools/buildbot/bin/python'} 05:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:41 INFO - Running setup.py (path:/tmp/pip-vm_irk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:41 INFO - Running setup.py (path:/tmp/pip-i7DU13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:41 INFO - Running setup.py (path:/tmp/pip-3lKNm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:41 INFO - Running setup.py (path:/tmp/pip-qLcS1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:41 INFO - Running setup.py (path:/tmp/pip-k3uYGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:41 INFO - Running setup.py (path:/tmp/pip-2TRMp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:41 INFO - Running setup.py (path:/tmp/pip-P_xzPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:41 INFO - Running setup.py (path:/tmp/pip-THc3QX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:41 INFO - Running setup.py (path:/tmp/pip-m98mDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:41 INFO - Running setup.py (path:/tmp/pip-WlwyQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:42 INFO - Running setup.py (path:/tmp/pip-j7WRvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:42 INFO - Running setup.py (path:/tmp/pip-o0ZJYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:42 INFO - Running setup.py (path:/tmp/pip-PjEA80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:42 INFO - Running setup.py (path:/tmp/pip-v8aQyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:42 INFO - Running setup.py (path:/tmp/pip-b2IpPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:42 INFO - Running setup.py (path:/tmp/pip-oOFZwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:42 INFO - Running setup.py (path:/tmp/pip-4mnz_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:05:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:44 INFO - Downloading blessings-1.5.1.tar.gz 05:05:44 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 05:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:05:44 INFO - Installing collected packages: blessings 05:05:44 INFO - Running setup.py install for blessings 05:05:44 INFO - Successfully installed blessings 05:05:44 INFO - Cleaning up... 05:05:44 INFO - Return code: 0 05:05:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:05:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:44 INFO - Reading from file tmpfile_stdout 05:05:44 INFO - Current package versions: 05:05:44 INFO - argparse == 1.2.1 05:05:44 INFO - blessings == 1.5.1 05:05:44 INFO - blobuploader == 1.2.4 05:05:44 INFO - docopt == 0.6.1 05:05:44 INFO - manifestparser == 1.1 05:05:44 INFO - mozInstall == 1.12 05:05:44 INFO - mozcrash == 0.16 05:05:44 INFO - mozdebug == 0.1 05:05:44 INFO - mozdevice == 0.47 05:05:44 INFO - mozfile == 1.2 05:05:44 INFO - mozhttpd == 0.7 05:05:44 INFO - mozinfo == 0.9 05:05:44 INFO - mozleak == 0.1 05:05:44 INFO - mozlog == 3.1 05:05:44 INFO - moznetwork == 0.27 05:05:44 INFO - mozprocess == 0.22 05:05:44 INFO - mozprofile == 0.28 05:05:44 INFO - mozrunner == 6.11 05:05:44 INFO - mozscreenshot == 0.1 05:05:44 INFO - mozsystemmonitor == 0.0 05:05:44 INFO - moztest == 0.7 05:05:44 INFO - mozversion == 1.4 05:05:44 INFO - psutil == 3.1.1 05:05:44 INFO - requests == 1.2.3 05:05:44 INFO - wsgiref == 0.1.2 05:05:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:44 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 0x7f81f445af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24613d0>, '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 0x23cced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:05:44 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 05:05:44 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 05:05:44 INFO - Using env: {'DISPLAY': ':0', 05:05:44 INFO - 'HOME': '/home/cltbld', 05:05:44 INFO - 'LANG': 'en_US.UTF-8', 05:05:44 INFO - 'LANGUAGE': 'en_US:en', 05:05:44 INFO - 'LOGNAME': 'cltbld', 05:05:44 INFO - 'MAIL': '/var/mail/cltbld', 05:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:44 INFO - 'MOZ_NO_REMOTE': '1', 05:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:44 INFO - 'NO_EM_RESTART': '1', 05:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:44 INFO - 'PWD': '/builds/slave/test', 05:05:44 INFO - 'SHELL': '/bin/bash', 05:05:44 INFO - 'SHLVL': '1', 05:05:44 INFO - 'TERM': 'linux', 05:05:44 INFO - 'TMOUT': '86400', 05:05:44 INFO - 'USER': 'cltbld', 05:05:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 05:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:44 INFO - '_': '/tools/buildbot/bin/python'} 05:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:05:44 INFO - Cleaning up... 05:05:44 INFO - Return code: 0 05:05:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:44 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 0x7f81f445af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24613d0>, '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 0x23cced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:05:44 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 05:05:44 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 05:05:44 INFO - Using env: {'DISPLAY': ':0', 05:05:44 INFO - 'HOME': '/home/cltbld', 05:05:44 INFO - 'LANG': 'en_US.UTF-8', 05:05:44 INFO - 'LANGUAGE': 'en_US:en', 05:05:44 INFO - 'LOGNAME': 'cltbld', 05:05:44 INFO - 'MAIL': '/var/mail/cltbld', 05:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:44 INFO - 'MOZ_NO_REMOTE': '1', 05:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:44 INFO - 'NO_EM_RESTART': '1', 05:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:44 INFO - 'PWD': '/builds/slave/test', 05:05:44 INFO - 'SHELL': '/bin/bash', 05:05:44 INFO - 'SHLVL': '1', 05:05:44 INFO - 'TERM': 'linux', 05:05:44 INFO - 'TMOUT': '86400', 05:05:44 INFO - 'USER': 'cltbld', 05:05:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 05:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:44 INFO - '_': '/tools/buildbot/bin/python'} 05:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:45 INFO - Downloading/unpacking jsonschema 05:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:05:46 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 05:05:46 INFO - Downloading/unpacking functools32 (from jsonschema) 05:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:47 INFO - Downloading functools32-3.2.3-2.tar.gz 05:05:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:05:47 INFO - warning: no files found matching '*.txt' 05:05:47 INFO - no previously-included directories found matching 'build' 05:05:47 INFO - no previously-included directories found matching 'dist' 05:05:47 INFO - no previously-included directories found matching '.git*' 05:05:47 INFO - Installing collected packages: jsonschema, functools32 05:05:47 INFO - Running setup.py install for functools32 05:05:47 INFO - warning: no files found matching '*.txt' 05:05:47 INFO - no previously-included directories found matching 'build' 05:05:47 INFO - no previously-included directories found matching 'dist' 05:05:47 INFO - no previously-included directories found matching '.git*' 05:05:47 INFO - Successfully installed jsonschema functools32 05:05:47 INFO - Cleaning up... 05:05:47 INFO - Return code: 0 05:05:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:47 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 0x7f81f445af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24613d0>, '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 0x23cced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd360>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:05:47 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 05:05:47 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 05:05:47 INFO - Using env: {'DISPLAY': ':0', 05:05:47 INFO - 'HOME': '/home/cltbld', 05:05:47 INFO - 'LANG': 'en_US.UTF-8', 05:05:47 INFO - 'LANGUAGE': 'en_US:en', 05:05:47 INFO - 'LOGNAME': 'cltbld', 05:05:47 INFO - 'MAIL': '/var/mail/cltbld', 05:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:47 INFO - 'MOZ_NO_REMOTE': '1', 05:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:47 INFO - 'NO_EM_RESTART': '1', 05:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:47 INFO - 'PWD': '/builds/slave/test', 05:05:47 INFO - 'SHELL': '/bin/bash', 05:05:47 INFO - 'SHLVL': '1', 05:05:47 INFO - 'TERM': 'linux', 05:05:47 INFO - 'TMOUT': '86400', 05:05:47 INFO - 'USER': 'cltbld', 05:05:47 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 05:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:47 INFO - '_': '/tools/buildbot/bin/python'} 05:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:47 INFO - Downloading/unpacking flake8 05:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:05:49 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 05:05:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:05:49 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 05:05:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:49 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 05:05:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:05:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:05:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:05:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:05:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:05:49 INFO - no previously-included directories found matching 'docs/_build' 05:05:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:05:50 INFO - Running setup.py install for pep8 05:05:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:05:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:05:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:05:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:05:50 INFO - no previously-included directories found matching 'docs/_build' 05:05:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:05:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:05:50 INFO - Cleaning up... 05:05:50 INFO - Return code: 0 05:05:50 INFO - Running post-action listener: _resource_record_post_action 05:05:50 INFO - Running post-action listener: _start_resource_monitoring 05:05:50 INFO - Starting resource monitoring. 05:05:50 INFO - ##### 05:05:50 INFO - ##### Running install step. 05:05:50 INFO - ##### 05:05:50 INFO - Running pre-action listener: _resource_record_pre_action 05:05:50 INFO - Running main action method: install 05:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:50 INFO - Reading from file tmpfile_stdout 05:05:50 INFO - Detecting whether we're running mozinstall >=1.0... 05:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:05:50 INFO - Reading from file tmpfile_stdout 05:05:50 INFO - Output received: 05:05:50 INFO - Usage: mozinstall [options] installer 05:05:50 INFO - Options: 05:05:50 INFO - -h, --help show this help message and exit 05:05:50 INFO - -d DEST, --destination=DEST 05:05:50 INFO - Directory to install application into. [default: 05:05:50 INFO - "/builds/slave/test"] 05:05:50 INFO - --app=APP Application being installed. [default: firefox] 05:05:50 INFO - mkdir: /builds/slave/test/build/application 05:05:50 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'] 05:05:50 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 05:06:06 INFO - Reading from file tmpfile_stdout 05:06:06 INFO - Output received: 05:06:06 INFO - /builds/slave/test/build/application/firefox/firefox 05:06:06 INFO - Running post-action listener: _resource_record_post_action 05:06:06 INFO - ##### 05:06:06 INFO - ##### Running run-tests step. 05:06:06 INFO - ##### 05:06:06 INFO - Running pre-action listener: _resource_record_pre_action 05:06:06 INFO - Running main action method: run_tests 05:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:06:06 INFO - Python 2.7.3 05:06:06 INFO - Return code: 0 05:06:06 INFO - grabbing minidump binary from tooltool 05:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:06 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 0x24613d0>, '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 0x23cced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:06:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:06:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:06:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:06:06 INFO - Return code: 0 05:06:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:06:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:06:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:06:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:06:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:06:07 INFO - Return code: 0 05:06:07 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/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:06:07 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/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:06:07 INFO - Using env: {'DISPLAY': ':0', 05:06:07 INFO - 'HOME': '/home/cltbld', 05:06:07 INFO - 'LANG': 'en_US.UTF-8', 05:06:07 INFO - 'LANGUAGE': 'en_US:en', 05:06:07 INFO - 'LOGNAME': 'cltbld', 05:06:07 INFO - 'MAIL': '/var/mail/cltbld', 05:06:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:06:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:07 INFO - 'MOZ_NO_REMOTE': '1', 05:06:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:07 INFO - 'NO_EM_RESTART': '1', 05:06:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:07 INFO - 'PWD': '/builds/slave/test', 05:06:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:06:07 INFO - 'SHELL': '/bin/bash', 05:06:07 INFO - 'SHLVL': '1', 05:06:07 INFO - 'TERM': 'linux', 05:06:07 INFO - 'TMOUT': '86400', 05:06:07 INFO - 'USER': 'cltbld', 05:06:07 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324', 05:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:07 INFO - '_': '/tools/buildbot/bin/python'} 05:06:07 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/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:06:07 INFO - mozversion application_buildid: 20160111032031 05:06:07 INFO - mozversion application_changeset: 121a7977bd8169f013f2a3025b01d1e1b3b60a2d 05:06:07 INFO - mozversion application_display_name: Nightly 05:06:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:06:07 INFO - mozversion application_name: Firefox 05:06:07 INFO - mozversion application_remotingname: firefox 05:06:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:06:07 INFO - mozversion application_vendor: Mozilla 05:06:07 INFO - mozversion application_version: 46.0a1 05:06:07 INFO - mozversion platform_buildid: 20160111032031 05:06:07 INFO - mozversion platform_changeset: 121a7977bd8169f013f2a3025b01d1e1b3b60a2d 05:06:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:06:07 INFO - mozversion platform_version: 46.0a1 05:06:07 INFO - using testdate: 1452517567 05:06:07 INFO - actual date: 1452517567 05:06:07 INFO - starting webserver on 'localhost:32800' 05:06:07 INFO - SUITE-START | Running 3 tests 05:06:07 INFO - TEST-START | dromaeo_css 05:06:07 INFO - operating with platform_type : linux_ 05:06:07 INFO - Initialising browser for dromaeo_css test... 05:06:07 INFO - TEST-INFO | started process 15165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZYB9Fi/profile http://localhost:32800/getInfo.html) 05:06:11 INFO - PROCESS | 15165 | 05:06:11 INFO - PROCESS | 15165 | (process:15247): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:06:11 INFO - PROCESS | 15165 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 05:06:12 INFO - PROCESS | 15165 | __metrics Screen width/height:1600/1200 05:06:12 INFO - PROCESS | 15165 | colorDepth:24 05:06:12 INFO - PROCESS | 15165 | Browser inner width/height: 1024/697 05:06:12 INFO - PROCESS | 15165 | __metrics 05:06:12 INFO - PROCESS | 15165 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:06:13 INFO - TEST-INFO | 15165: exit 0 05:06:13 INFO - Browser initialized. 05:06:13 INFO - Running cycle 1/1 for dromaeo_css test... 05:06:13 INFO - TEST-INFO | started process 15296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZYB9Fi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:14 INFO - PROCESS | 15296 | 05:06:14 INFO - PROCESS | 15296 | (process:15354): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:06:25 INFO - PROCESS | 15296 | RSS: Main: 151252992 05:06:25 INFO - PROCESS | 15296 | 05:07:15 INFO - PROCESS | 15296 | 1452517635132 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:09:27 INFO - PROCESS | 15296 | Cycle 1(1): loaded http://localhost:32800/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32800/tests/dromaeo/cssquery-ext.html) 05:09:28 INFO - PROCESS | 15296 | RSS: Main: 154255360 05:09:28 INFO - PROCESS | 15296 | 05:12:30 INFO - PROCESS | 15296 | Cycle 1(1): loaded http://localhost:32800/tests/dromaeo/cssquery-ext.html (next: http://localhost:32800/tests/dromaeo/cssquery-jquery.html) 05:12:30 INFO - PROCESS | 15296 | RSS: Main: 152838144 05:12:30 INFO - PROCESS | 15296 | 05:15:32 INFO - PROCESS | 15296 | Cycle 1(1): loaded http://localhost:32800/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32800/tests/dromaeo/cssquery-mootools.html) 05:15:33 INFO - PROCESS | 15296 | RSS: Main: 153411584 05:15:33 INFO - PROCESS | 15296 | 05:18:35 INFO - PROCESS | 15296 | Cycle 1(1): loaded http://localhost:32800/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32800/tests/dromaeo/cssquery-prototype.html) 05:18:35 INFO - PROCESS | 15296 | RSS: Main: 153010176 05:18:35 INFO - PROCESS | 15296 | 05:21:38 INFO - PROCESS | 15296 | Cycle 1(1): loaded http://localhost:32800/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32800/tests/dromaeo/cssquery-yui.html) 05:21:38 INFO - PROCESS | 15296 | RSS: Main: 152850432 05:21:38 INFO - PROCESS | 15296 | 05:24:41 INFO - PROCESS | 15296 | Cycle 1(1): loaded http://localhost:32800/tests/dromaeo/cssquery-yui.html (next: http://localhost:32800/tests/dromaeo/cssquery-dojo.html) 05:24:41 INFO - PROCESS | 15296 | RSS: Main: 155713536 05:24:41 INFO - PROCESS | 15296 | 05:24:41 INFO - PROCESS | 15296 | __start_tp_report 05:24:41 INFO - PROCESS | 15296 | _x_x_mozilla_page_load 05:24:41 INFO - PROCESS | 15296 | _x_x_mozilla_page_load_details 05:24:41 INFO - PROCESS | 15296 | |i|pagename|runs| 05:24:41 INFO - PROCESS | 15296 | |0;dojo.html;2651.8674066296685;2721.809473336867;2740;2759.365345970427;2760.5859121131834;4642.86071417858;4827.879303017422;4834.395700537433;4848.393950756151;4853.660243782932;4644;4656.650751193657;4692.601128904047;4728.40894888139;4791.257355109955;4344.913101737971;4366.257736184841;4408.691391602589;4425.269830477983;4426.136903303857;4380.34294855771;4394.143142087294;4442.2004039272915;4448.688591798559;4479.126570318789;4258.680598955075;4325.675574331937;4377.890552736207;4396.736195828261;4422.491413487458;4337.8481753138485;4373.562643735633;4387.561243875619;4393.978030109829;4423.535528769497;4224.66202703783;4360.062586543908;4369.213541562517;4390.714603550759;4409.845655402078;4516.525764794715;4527.818887244506;4584.931226031612;4628.560286772751;4630.328602352673;5115.104856650109;5130.461301563357;5131.3329267195395;5132.153194722903;5160;4962.677425967337;5085.593152547787;5153.175491921312;5165.767540460688;5220.451852555503;4635.258358662598;4682.81268749253;4689.7655117244;4703.741294228782;4750.95249047512;5219.321488206509;5220.321358223407;5226.581873450191;5228.895422091613;5263.34208223972;4871.878203044952;4919.458859525449;4965.82619608312;5013.949860501349;5060.84817455477;5151.9484805152215;5168.302279192336;5169.405518365361;5181.300524429229;5187.559057480081;5050.318207042076;5092.668976516515;5110.97444512775;5112.514311140436;5174.637775355689;4882.707037577757;4970.90058198834;5002.09962206799;5008.12357837377;5030.89938201234;4180.080382315886;4259.467566554181;4277.272863613193;4291.699581029298;4327.831485498898;3767.4913886624954;3786.450964610116;3795.981020094882;3819.7899115548357;3819.8854034379015;4320.589543993316;4402.713823601455;4424.31423129409;4429.180601588717;4477.932831007537;5004.424491183488;5067.214581739836;5068.569171620454;5090.261912022736;5108.489151084862;4400.141972315432;4413.337999300131;4425.712328698624;4470.508244093147;4481.1709833680225;4373.75944323059;4452.577005184502;4499.6400287976885;4551.112533056088;4602.217623004098;4850.975745121252;4864.756762161877;4872.025594881109;4878.902421951612;4916.655834091579;5146.408163061295;5147.639665223398;5148.562372198256;5149.176131818891;5149.304843846033;4706.835260765857;4745.217039188633;4810.230363141881;4857.635677324144;4887.60899128076;5115.64190506661;5124;5141.25451809493;5148.459411761711;5193.584513239008;5202.97398513005;5219.582433405394;5223.2948551945;5224.477552244897;5224.52979231871;4840.104580652591;4896.877578060577;4935.777889995031;4950.282209079735;4977.278294647183;4927.852164435073;4963.230699241623;4964.67729597575;4967;5014.648974571745;4693.436787585375;4860.78126484302;4869.269609558594;4876.756162191805;4888.071266459361;4933.136701077369;4973.602111830973;5016.398032236155;5031.823886163967;5089.3638295213095;4935.950640493693;4956.8760780980765;4964.578010869117;4967.9006419870675;4971.6022718183185 05:24:41 INFO - PROCESS | 15296 | |1;ext.html;461.20902651951894;472.8817795551112;491.4839418610458;494.03662857428026;500.712090547935;30778.84610576947;31429.371412571763;31700;31717;31779;32354.67645323546;32395.67604323956;32730.83634581824;32748.508772368434;32827.17932051694;7433.070866141746;7656.196099409565;7658.195889431613;7659.774436090227;7670.884936725954;7434;7639.19788422216;7641.388688904902;7644.388448924101;7655.157932627407;7605.581693006882;7700.845983080335;7705.922940770577;7712.383009359266;7725;7745.728899488519;7772.378209743207;7775.105862825734;7776.30013298803;7787.4938129022;7444.106707195117;7647.961760191163;7658.081030276402;7659.578723170223;7671;33229.50155747666;33712.49431258533;33713.15717107092;33720.15699607505;33731.32537349239;2885.653721553427;2984.328526081636;3026.5914101596222;3411.0619579615554;3682.2819550187724;26938.326541836414;27112;27214.591781123298;27468.17595472139;27731.306717332027;3132.592762940803;3265.673432656739;3272.885449009297;3318.1372843060735;3379.3410284994434;218377;219120.9999999984;219444;219867;220056;45507.31739023917;46489.5351046492;52339.73830130825;52475.47524524782;52895.735521322145;56539;57711.13433298504;58092;58202.41797582055;58277.70861145752;12569.622911312676;12717.427715752814;12739.872601273868;12745;12779.041571882146;10068.496575171212;10089.192864570818;10096.949515252376;10103.242256830767;10112.494375281207;17172.31310747581;17328.82671173272;17402.47792566225;18040.458786236435;18111.818881811276;7052.612106334201;7187.184586327069;7228.783136505913;7263.745768898063;7327.74352897646;816.8938038055015;856.2379482260793;863.2877875752529;940.971770846862;1017.862588550551;26343.604845927326;26422.207333780018;26557.468850622878;26558.46883062328;26907.596386054225;915.6749353979375;924.9213816825511;942.5758408716105;947.228009172536;960.5293406231036;13633.863661363259;13673.384697688627;14076.085054471427;14097.506587269396;14107.224102674452;251448;256418;257999;258041;258931.7053414721;45095;45333.54666453359;45388;45548.54451455509;45580.54419455763;1184.603157942099;1190.5773450424974;1191.255465334166;1216.0271782574082;1223.85925618555;25269.24192274235;25883.61174582345;25934.35164120912;26015;26402.603960940218;39823.402648960866;40093;40532.59467405288;40542.39186412147;40558.1888362237;186965;189205;189389;236720;237065;24180.879095605113;24751.886165122974;28387.574186387636;28434.28914277077;29285.121446356643;33357.33285334328;33523.653344265666;33757.493637595944;34023.48964765481;34424.31151377009;28406.715932841234;29007.41985160327;29266.268343291587;29304;29477.410451790416;30769.846150769103;30849.228769280948;31326.686733132377;31503.212419688774;31704.731810727313;31218.687813121578;31420.214494637818;31756.682433175374;31810.840945795124;31846.363072738877;27867.303317417227;29103.41793164167;29429.705702943553;30196.396072077994;31246.531302030944;22288.665670014638;22547.774522254567;22628.66057009179;22949.426264343525;23026.654600181344 05:24:41 INFO - PROCESS | 15296 | |2;jquery.html;327.55125478095016;327.80987027524037;331.7810245238143;333.7280116704885;334.2712885908718;14426.278686065694;14780.556583302505;15065.548033558984;15136.318865651045;15867.444639437623;9886.505674716253;9994.400335979828;12076.396180190999;14753.557393278219;14818.259087045659;4290.742555446684;4497.14554234696;4509.053098849229;5003.2995380646735;5227.764750586214;5081.339425874631;5126.000429916168;5127.538521533062;5131.1277082895995;5140.691558506502;5132.923006154911;6187.907181392283;6252.874942501147;6398.16823812906;6446.097546343516;6278;6439.517036222279;6443.065755465478;6492.837679058038;6528.902066469007;6269.811905642838;6270.247570291549;6272.65500397478;6276.3409841966395;6285.497160227171;19820.207191712314;20233.79766202334;20279.89860050705;20419.489512762153;20956;1765.7704498415253;1777.7688900442859;1839.2275244397385;1856.5265857206462;1865.253898440621;12574.937125314407;13342.466301348031;13626.727465450735;13646.229922108561;13698.041137120406;1826.1234607388394;1835.2934120363623;1876.6715824730754;1896.9810301896941;1899.886006839594;53169.46830531684;53548.99356898771;54944.72527637336;56296.43703562994;57405;14724.33740481681;14786.260686965608;14806.333714982851;14827.851721482863;14869.479568215276;21815.563688726455;21903.561928761337;21914.342569722932;21944.561108777736;21984.780152198593;8405.663773449116;8455.49267043967;8478.23695867375;8506.532140732319;8549.444286121383;7087.0786797717;7103.609301488468;7134.036905017756;7134.964325178341;7138.25048369924;7350.7427240046345;7358.374538164209;7391.926080739231;7433.442491813135;7495.962520187364;1736.574539237895;3060.617422822147;3101.457244982119;3128.9687103128676;3134.3887941851576;376.61208954776623;764.3770327183328;822.2640736540762;827.8509868223778;833.4749108061882;9312.72061838146;9707.9029209707;9840.16358609512;9907.356021858555;9923.40459572428;405.5538907202113;414.06421487438007;416.9992019153994;425.10091157202294;426.94663167104113;5237.6333656643665;5329.413764485904;5399.4600539945695;5477.096279113902;5503.091989821714;457092;461038;472244;476288;478535;63286.6835665828;63986;64744;65026;66231.66884165548;447.7403106198397;447.75149791865175;447.91489616973325;449.3596624809633;455.1125305653988;8792.065355884624;9028.413153145024;9175.632974680939;9189.586468609063;9307.813843723223;27657;27759.167224983285;28640.427191455638;28793.85603071971;29279.85360073186;35932.64067359293;36638.8168059158;37594.43608345932;38429.231415370974;40099.198016038936;6365.363463653597;6602;6619.304972977768;6670.9332906670315;6853.725850965906;9334;9876.061774131445;9936.403815771077;10346.32748871321;10400.27198096126;6654.334566543307;7391.556506609621;8201.22088401601;8737.475751454678;8883.37816352849;8839.381243313164;8953.537777111347;9177.678781242625;9217.308701847254;9256.398334108262;8972.820543589221;9023;9278.675246366345;9295.67465138717;9331.298377835514;6768.9661551691925;6984.720611175496;7016.087908571853;7068.858622827617;7151.4278857690215;8028.83942321162;8278.254957053654;8295.419320647738;8392.496450212762;8518.91481085206 05:24:41 INFO - PROCESS | 15296 | |3;mootools.html;1388.6250712307676;1423.9003269771113;1519.240379810095;1732.5668582854287;1740.3560682547459;6231.968840155804;6358.554901156909;7139.750108746195;7265.418766498688;7281.672324745386;7011.544249623784;7171.426285897129;7226.024486694295;7234.49358544902;7235.855282894339;2089.028601700209;2113.894305284737;2118.1315660579166;2120.4592828828627;2121.1833444124045;2010.175827910557;2023.2210598919448;2027;2090.0385822521657;2118.692789545523;2041.050911326233;2128.294084316627;2133.28534940795;2135.9679604805942;2143.9923236079017;2129.840261980358;2135.9359219223447;2142.6571748520164;2143.453419378064;2148.301801914384;1978.277928556081;2001.0695026812457;2030.4416285521452;2047.7133201351824;2050.630886440455;7288.781336559911;7331.450141239375;7385.593792341419;7389.482736208468;7393.07586551681;4287.871363859089;4384.583464570861;4401.141777353418;4402.691811573191;4403.097365040159;2767.750902418792;2837.7729781617422;2877.6978417266096;2895.3774938388347;2899.5795609636693;869.2871845087031;883.4875772052194;901.5627420700955;910.0353625157288;914.4330515080626;9973.900260997443;10090.9495452523;10115.49422528878;10124.645637402655;10163.034511721375;3971.62269584389;4006.579309172553;4061.7156799023783;4145.2952997990415;4147.543770185277;8807.867881981776;8831.337649676172;8846.46921184731;8846.690365837294;8857.37998340123;4438.045820148684;4446.62203712688;4452.910941781146;4455.933161002587;4465.173942820588;3383.6954674078956;3452.4476083826466;3929.9017524562114;4060.878173654795;4065.288574499451;3515.6835884770494;3522;3550.201204728967;3561.1809283864854;3568.125809176768;1126.7352172239516;1166.5100657723776;1173.12015988009;1173.2960223865612;1178.7288923547633;893.4192774696369;915.9175674189355;1172.8299396587447;1181.5037684172669;1191.3923898811668;6795.082663840417;6845.0759147514445;6852.554583952126;6852.623105729133;6897.068895699117;1028.321307936758;1056.6829951014665;1072.3405105859997;1075.6020272499225;1102.6251074634663;5447;5466.699331536804;5488.69812160335;5505.311836020497;5508.118701007819;8439.620217090245;8672.78318042054;8710.172533609297;8832.38173327861;8849.159329863653;8628.22345988864;8631.482111073356;8659.350548708746;8688.044315125331;8714.825703485894;6667.966660166765;6822.488313376417;6898.206706228848;6935.618540980194;7020.05229294049;6663.900041499478;6731.899021514583;6770.356816102462;6786.626735529593;6789.524733268624;7706.460547761603;7873.448858579844;7905;7909.802254943443;7949.1255961843;7858.803529911569;8186.181381861767;8208.548529830916;8223.342132629496;8394.37042221848;5472.589555783253;6245.28179259391;6384.201974753156;6454.515911306765;6522.119513865568;7002.089728335284;7011.3339232772805;7017.368436840505;7026.8756998879935;7049.224585295716;6407.199100112486;6535.705893234911;6558.213014438107;6578.440832529289;6813.3527314905;6613.074169616354;6729.125213722381;6750.45996320303;6840.2817704142335;6858.41703455192;6539.346065393423;6560.540762146604;6584.045313429621;6605.5376123670885;6609.504287178384;6078.179445774764;6271.310155882758;6277.843053923689;6292.842678933063;6325.936740632535;6033.366496517802;6066.545009124245;6073.331933487401;6080.574359794772;6107.144999700135 05:24:41 INFO - PROCESS | 15296 | |4;prototype.html;308.66047347917294;313.3404184192274;314.95748074010015;315.13652591898204;321.07690390128374;5513.917291240635;5632.662040277576;5704.885902281957;5740.368559458461;5792.391798861122;5647.519960803326;5690.9146362804595;5699.487046165844;5708.628939118955;5715.571332150084;4357.433533640638;4360.80376383062;4362.585554372329;4366.497852746935;4368.825246990116;4355.956440435587;4357.847475338363;4371.344298355256;4373.365861950016;4379.824807007716;4121.505419349683;4230.111676547913;4253.1493701259715;4272.230998420283;4276.144771045803;4238.321868501041;4280.4221430106845;4296.291111966521;4301.3117901135665;4322.243607368698;3735.8505659773577;3738.1589142443004;3738.5700644425697;3740.4576336431337;3746.3631182699005;5394.7842086316505;5403.2705584746345;5404.729763511808;5408.567314614821;5410.621256512046;4775.3286349777645;4833.830815921461;4992.6754760940785;5000.549950504435;5002.874928126789;5819.039858423355;5826.941730582725;5832.737526811261;5834.824955251349;5943.167956486095;4088.795560221977;4094.447249621293;4097.426360309559;4104.056067104582;4105.97947010266;6220.222472190976;6273.592216505913;6291.307956124822;6292.62244265341;6293.402126797947;4130.153318569686;4167.291560434734;4211.0946146578635;4211.642010429148;4228.048689045002;4243.384709217208;4250.23495770758;4257.127288905767;4264.402983582301;4269.338252570857;4959.851204463872;4961.957988822315;4963.131451995886;4968.205087186033;4981.327520784647;5941.405859414111;5990.880182396328;5996.340402555716;6006.159137720635;6011.789587364508;1462.4881291548086;1497.7304085264539;1514.447226762246;1522.3910435825537;1522.9010114342532;1002.2433063037361;1007.2596641468515;1009.9848502272472;1011.3729487717662;1018.3940555369692;5125.641205115606;5125.769340379692;5146.845594632167;5148.510891465305;5157.4584668610005;6120.785772497941;6130.356312587203;6146.4775494082605;6162.044883043135;6164.845878853064;5132.153194722903;5147.1507201312115;5186.714730689773;5190.97404512975;5200.271961925334;3274.9345013099605;3289.901302960915;3314.734821214345;3389.610324721066;3393.1347506385714;5912.46787789101;5915.733791979371;5920.881582368328;5922.733476993546;5925.081612350093;6470.352964703492;6479.6760161991715;6483.7730679425995;6497.317781632955;6500.187476565429;5739.196512488172;5885.529157667376;5898.882022359443;5901.852453688606;5906.852328691645;6280.057991301342;6300.558960872695;6303.9684801575695;6312.337204593451;6328.683565821782;6121.84695382619;6142.508599311955;6149.385061493815;6153.292371377349;6156.107364432043;5697.088465845445;5828.154917537018;5878.559108066826;5890.941090589211;5903.2325797646035;4157.771322577288;4199.265128602544;4201.075763332062;4209.200251952119;4210.81051352696;6239.78160764371;6279.874402512016;6281.59169653971;6291.370862913672;6304.842378940563;5939.881202375842;6040.818775436744;6043.758249669964;6052.394760523913;6056.152138700498;5964.194833697396;5994.370591088047;6019.819405417845;6044.365341639064;6044.84887877789;5903.822885313448;5904.439078287556;5931.9110213345975;5940.376260492759;5942.58401911862;6078.817635470943;6082.300535438481;6084.9959756639655;6086.421789929949;6103.694815259308;5760.683162426107;5921.319048309328;5928.584999050025;5935.169076329404;5935.673537955454 05:24:41 INFO - PROCESS | 15296 | |5;yui.html;773.6441237030965;777.5062835099714;777.6461709921984;788.972385966491;801.3509057663291;10404.739881502966;10478.05697487226;10495.79008419833;10528.315659482128;10543.947280263597;10158.1873450124;10277.640282590111;10289.279750417474;10291.794164116713;10300.690979270616;611.3641812514979;619.2105066040789;768.7002069193019;772.5982489105662;782.6673663692936;779.4894344204555;779.8206412525122;781.3749000799367;782.2099679323895;783.9964844998411;825.793551612097;826.4793180296435;826.7478419082178;827.0736774812189;828.888100106487;813.4062134641745;817.7301490508119;818.5907046476761;819.9057108432518;821.36344333142;612.6967151260154;612.7947137708873;613.3896772711137;614.2874265851591;615.3630991923383;9867.703968880873;9897.851532227023;9900.90099099007;9915.553800079013;9991.75020624483;11252.43737813106;11588.710282243012;11598;11752.059835213162;12131.454084566216;8791.208791208823;8805.69180078694;8864.760789412316;8936.195742383152;8937.374383793138;3157.1002264354547;3206.8236247006407;3237.838108094609;3276;3322.1694576355912;37864;37983.050423739354;38098.23803523914;38116.42825357622;38226.426603600965;8794.780130496662;8844.128318781679;9013.77465563353;9249.583768730423;9317.953410232905;16391.42630007968;16405.343786248417;16427.178641067898;16442.917785411235;16448.34206631745;5975.133605627159;6002.669853158118;6009.519238460913;6084;6294.402031806971;3485.0764547394456;3516.3919795323436;3587.802670853076;3640.4539319102346;3663.7435379523176;2558.7825034872244;2582.4447743735186;2585.4699786543715;2586.495633351516;2589.6374507568958;469.6970454057114;471.1284124369888;478.1178725251905;482.78998635593626;488.97555122243745;389.4454356303009;551.6441894977797;552.9612927095064;555.1977392667557;576.1862804304587;6756.3919247266995;6993.510454268254;7140.214576396592;7163.1404231491515;7275.236100209508;457.8969731810316;469.8613908896884;553.7120697237414;568.4968802609637;577.2985822226016;3353.5808023997;3391.7286617070577;3434.690877821008;3464.37641224582;3521.3133438979153;47093.5290647096;47125;48766.75616621894;48987.75506122447;49189.50810491921;39994.600053999086;41183.38224926629;41434.58565414367;41457.1708565827;41889.58110418918;39356;39429;39483.60516394857;39488.60511394849;39528.60471395249;6821.069769288955;6962.268961758942;6992.755253566101;7093.716251349888;7158;29759.70240297656;30508.237294067825;31340.373192536477;31580;32216.67783322137;36239;36564.81717591395;37364.813175933945;37451.250974980896;37626.81186594159;9382.061793820563;9614.95192524033;9618.663346783109;9688.5640146195;9733.415995040037;10326.225533085199;10911.454427278763;11173.106151508022;11184.440777960906;11206;9748.317617766688;9845.458499782295;9849.359791613522;9927.354721943051;9935.503224838874;9826.263030272616;9926.751831204278;9931.404115753077;9934.354266972623;9962.103410693073;8840.867386989328;9535.427874327563;9597.184239339735;9820.705378838646;9878.25913056538;8331.791705207419;8390.370722195737;8493.745187644381;8516.190961858614;8621.13788621158;8366.83266334682;8501.10738372462;8539.359548033797;8544;8801.51591662439 05:24:41 INFO - PROCESS | 15296 | __end_tp_report 05:24:41 INFO - PROCESS | 15296 | __start_cc_report 05:24:41 INFO - PROCESS | 15296 | _x_x_mozilla_cycle_collect,328 05:24:41 INFO - PROCESS | 15296 | __end_cc_report 05:24:41 INFO - PROCESS | 15296 | __startTimestamp1452518681575__endTimestamp 05:24:41 INFO - PROCESS | 15296 | 05:24:41 INFO - PROCESS | 15296 | ------- Summary: start ------- 05:24:41 INFO - PROCESS | 15296 | Number of tests: 6 05:24:41 INFO - PROCESS | 15296 | 05:24:41 INFO - PROCESS | 15296 | [#0] dojo.html Cycles:165 Average:4711.64 Median:4860.78 stddev:494.48 (10.2%) stddev-sans-first:468.85 05:24:41 INFO - PROCESS | 15296 | Values: 2651.9 2721.8 2740.0 2759.4 2760.6 4642.9 4827.9 4834.4 4848.4 4853.7 4644.0 4656.7 4692.6 4728.4 4791.3 4344.9 4366.3 4408.7 4425.3 4426.1 4380.3 4394.1 4442.2 4448.7 4479.1 4258.7 4325.7 4377.9 4396.7 4422.5 4337.8 4373.6 4387.6 4394.0 4423.5 4224.7 4360.1 4369.2 4390.7 4409.8 4516.5 4527.8 4584.9 4628.6 4630.3 5115.1 5130.5 5131.3 5132.2 5160.0 4962.7 5085.6 5153.2 5165.8 5220.5 4635.3 4682.8 4689.8 4703.7 4751.0 5219.3 5220.3 5226.6 5228.9 5263.3 4871.9 4919.5 4965.8 5013.9 5060.8 5151.9 5168.3 5169.4 5181.3 5187.6 5050.3 5092.7 5111.0 5112.5 5174.6 4882.7 4970.9 5002.1 5008.1 5030.9 4180.1 4259.5 4277.3 4291.7 4327.8 3767.5 3786.5 3796.0 3819.8 3819.9 4320.6 4402.7 4424.3 4429.2 4477.9 5004.4 5067.2 5068.6 5090.3 5108.5 4400.1 4413.3 4425.7 4470.5 4481.2 4373.8 4452.6 4499.6 4551.1 4602.2 4851.0 4864.8 4872.0 4878.9 4916.7 5146.4 5147.6 5148.6 5149.2 5149.3 4706.8 4745.2 4810.2 4857.6 4887.6 5115.6 5124.0 5141.3 5148.5 5193.6 5203.0 5219.6 5223.3 5224.5 5224.5 4840.1 4896.9 4935.8 4950.3 4977.3 4927.9 4963.2 4964.7 4967.0 5014.6 4693.4 4860.8 4869.3 4876.8 4888.1 4933.1 4973.6 5016.4 5031.8 5089.4 4936.0 4956.9 4964.6 4967.9 4971.6 05:24:41 INFO - PROCESS | 15296 | 05:24:41 INFO - PROCESS | 15296 | [#1] ext.html Cycles:180 Average:38042.52 Median:31736.84 stddev:59722.45 (188.2%) stddev-sans-first:59823.33 05:24:41 INFO - PROCESS | 15296 | Values: 461.2 472.9 491.5 494.0 500.7 30778.8 31429.4 31700.0 31717.0 31779.0 32354.7 32395.7 32730.8 32748.5 32827.2 7433.1 7656.2 7658.2 7659.8 7670.9 7434.0 7639.2 7641.4 7644.4 7655.2 7605.6 7700.8 7705.9 7712.4 7725.0 7745.7 7772.4 7775.1 7776.3 7787.5 7444.1 7648.0 7658.1 7659.6 7671.0 33229.5 33712.5 33713.2 33720.2 33731.3 2885.7 2984.3 3026.6 3411.1 3682.3 26938.3 27112.0 27214.6 27468.2 27731.3 3132.6 3265.7 3272.9 3318.1 3379.3 218377.0 219121.0 219444.0 219867.0 220056.0 45507.3 46489.5 52339.7 52475.5 52895.7 56539.0 57711.1 58092.0 58202.4 58277.7 12569.6 12717.4 12739.9 12745.0 12779.0 10068.5 10089.2 10096.9 10103.2 10112.5 17172.3 17328.8 17402.5 18040.5 18111.8 7052.6 7187.2 7228.8 7263.7 7327.7 816.9 856.2 863.3 941.0 1017.9 26343.6 26422.2 26557.5 26558.5 26907.6 915.7 924.9 942.6 947.2 960.5 13633.9 13673.4 14076.1 14097.5 14107.2 251448.0 256418.0 257999.0 258041.0 258931.7 45095.0 45333.5 45388.0 45548.5 45580.5 1184.6 1190.6 1191.3 1216.0 1223.9 25269.2 25883.6 25934.4 26015.0 26402.6 39823.4 40093.0 40532.6 40542.4 40558.2 186965.0 189205.0 189389.0 236720.0 237065.0 24180.9 24751.9 28387.6 28434.3 29285.1 33357.3 33523.7 33757.5 34023.5 34424.3 28406.7 29007.4 29266.3 29304.0 29477.4 30769.8 30849.2 31326.7 31503.2 31704.7 31218.7 31420.2 31756.7 31810.8 31846.4 27867.3 29103.4 29429.7 30196.4 31246.5 22288.7 22547.8 22628.7 22949.4 23026.7 05:24:41 INFO - PROCESS | 15296 | 05:24:41 INFO - PROCESS | 15296 | [#2] jquery.html Cycles:180 Average:24865.81 Median:29474.23 stddev:76588.85 (259.9%) stddev-sans-first:76781.54 05:24:41 INFO - PROCESS | 15296 | Values: 327.6 327.8 331.8 333.7 334.3 14426.3 14780.6 15065.5 15136.3 15867.4 9886.5 9994.4 12076.4 14753.6 14818.3 4290.7 4497.1 4509.1 5003.3 5227.8 5081.3 5126.0 5127.5 5131.1 5140.7 5132.9 6187.9 6252.9 6398.2 6446.1 6278.0 6439.5 6443.1 6492.8 6528.9 6269.8 6270.2 6272.7 6276.3 6285.5 19820.2 20233.8 20279.9 20419.5 20956.0 1765.8 1777.8 1839.2 1856.5 1865.3 12574.9 13342.5 13626.7 13646.2 13698.0 1826.1 1835.3 1876.7 1897.0 1899.9 53169.5 53549.0 54944.7 56296.4 57405.0 14724.3 14786.3 14806.3 14827.9 14869.5 21815.6 21903.6 21914.3 21944.6 21984.8 8405.7 8455.5 8478.2 8506.5 8549.4 7087.1 7103.6 7134.0 7135.0 7138.3 7350.7 7358.4 7391.9 7433.4 7496.0 1736.6 3060.6 3101.5 3129.0 3134.4 376.6 764.4 822.3 827.9 833.5 9312.7 9707.9 9840.2 9907.4 9923.4 405.6 414.1 417.0 425.1 426.9 5237.6 5329.4 5399.5 5477.1 5503.1 457092.0 461038.0 472244.0 476288.0 478535.0 63286.7 63986.0 64744.0 65026.0 66231.7 447.7 447.8 447.9 449.4 455.1 8792.1 9028.4 9175.6 9189.6 9307.8 27657.0 27759.2 28640.4 28793.9 29279.9 35932.6 36638.8 37594.4 38429.2 40099.2 6365.4 6602.0 6619.3 6670.9 6853.7 9334.0 9876.1 9936.4 10346.3 10400.3 6654.3 7391.6 8201.2 8737.5 8883.4 8839.4 8953.5 9177.7 9217.3 9256.4 8972.8 9023.0 9278.7 9295.7 9331.3 6769.0 6984.7 7016.1 7068.9 7151.4 8028.8 8278.3 8295.4 8392.5 8518.9 05:24:41 INFO - PROCESS | 15296 | 05:24:41 INFO - PROCESS | 15296 | [#3] mootools.html Cycles:180 Average:5122.99 Median:6258.30 stddev:2658.02 (42.5%) stddev-sans-first:2650.66 05:24:41 INFO - PROCESS | 15296 | Values: 1388.6 1423.9 1519.2 1732.6 1740.4 6232.0 6358.6 7139.8 7265.4 7281.7 7011.5 7171.4 7226.0 7234.5 7235.9 2089.0 2113.9 2118.1 2120.5 2121.2 2010.2 2023.2 2027.0 2090.0 2118.7 2041.1 2128.3 2133.3 2136.0 2144.0 2129.8 2135.9 2142.7 2143.5 2148.3 1978.3 2001.1 2030.4 2047.7 2050.6 7288.8 7331.5 7385.6 7389.5 7393.1 4287.9 4384.6 4401.1 4402.7 4403.1 2767.8 2837.8 2877.7 2895.4 2899.6 869.3 883.5 901.6 910.0 914.4 9973.9 10090.9 10115.5 10124.6 10163.0 3971.6 4006.6 4061.7 4145.3 4147.5 8807.9 8831.3 8846.5 8846.7 8857.4 4438.0 4446.6 4452.9 4455.9 4465.2 3383.7 3452.4 3929.9 4060.9 4065.3 3515.7 3522.0 3550.2 3561.2 3568.1 1126.7 1166.5 1173.1 1173.3 1178.7 893.4 915.9 1172.8 1181.5 1191.4 6795.1 6845.1 6852.6 6852.6 6897.1 1028.3 1056.7 1072.3 1075.6 1102.6 5447.0 5466.7 5488.7 5505.3 5508.1 8439.6 8672.8 8710.2 8832.4 8849.2 8628.2 8631.5 8659.4 8688.0 8714.8 6668.0 6822.5 6898.2 6935.6 7020.1 6663.9 6731.9 6770.4 6786.6 6789.5 7706.5 7873.4 7905.0 7909.8 7949.1 7858.8 8186.2 8208.5 8223.3 8394.4 5472.6 6245.3 6384.2 6454.5 6522.1 7002.1 7011.3 7017.4 7026.9 7049.2 6407.2 6535.7 6558.2 6578.4 6813.4 6613.1 6729.1 6750.5 6840.3 6858.4 6539.3 6560.5 6584.0 6605.5 6609.5 6078.2 6271.3 6277.8 6292.8 6325.9 6033.4 6066.5 6073.3 6080.6 6107.1 05:24:41 INFO - PROCESS | 15296 | 05:24:41 INFO - PROCESS | 15296 | [#4] prototype.html Cycles:180 Average:4942.04 Median:5573.29 stddev:1484.06 (26.6%) stddev-sans-first:1446.90 05:24:41 INFO - PROCESS | 15296 | Values: 308.7 313.3 315.0 315.1 321.1 5513.9 5632.7 5704.9 5740.4 5792.4 5647.5 5690.9 5699.5 5708.6 5715.6 4357.4 4360.8 4362.6 4366.5 4368.8 4356.0 4357.8 4371.3 4373.4 4379.8 4121.5 4230.1 4253.1 4272.2 4276.1 4238.3 4280.4 4296.3 4301.3 4322.2 3735.9 3738.2 3738.6 3740.5 3746.4 5394.8 5403.3 5404.7 5408.6 5410.6 4775.3 4833.8 4992.7 5000.5 5002.9 5819.0 5826.9 5832.7 5834.8 5943.2 4088.8 4094.4 4097.4 4104.1 4106.0 6220.2 6273.6 6291.3 6292.6 6293.4 4130.2 4167.3 4211.1 4211.6 4228.0 4243.4 4250.2 4257.1 4264.4 4269.3 4959.9 4962.0 4963.1 4968.2 4981.3 5941.4 5990.9 5996.3 6006.2 6011.8 1462.5 1497.7 1514.4 1522.4 1522.9 1002.2 1007.3 1010.0 1011.4 1018.4 5125.6 5125.8 5146.8 5148.5 5157.5 6120.8 6130.4 6146.5 6162.0 6164.8 5132.2 5147.2 5186.7 5191.0 5200.3 3274.9 3289.9 3314.7 3389.6 3393.1 5912.5 5915.7 5920.9 5922.7 5925.1 6470.4 6479.7 6483.8 6497.3 6500.2 5739.2 5885.5 5898.9 5901.9 5906.9 6280.1 6300.6 6304.0 6312.3 6328.7 6121.8 6142.5 6149.4 6153.3 6156.1 5697.1 5828.2 5878.6 5890.9 5903.2 4157.8 4199.3 4201.1 4209.2 4210.8 6239.8 6279.9 6281.6 6291.4 6304.8 5939.9 6040.8 6043.8 6052.4 6056.2 5964.2 5994.4 6019.8 6044.4 6044.8 5903.8 5904.4 5931.9 5940.4 5942.6 6078.8 6082.3 6085.0 6086.4 6103.7 5760.7 5921.3 5928.6 5935.2 5935.7 05:24:41 INFO - PROCESS | 15296 | 05:24:41 INFO - PROCESS | 15296 | [#5] yui.html Cycles:180 Average:11602.17 Median:5988.90 stddev:13191.21 (220.3%) stddev-sans-first:13203.15 05:24:41 INFO - PROCESS | 15296 | Values: 773.6 777.5 777.6 789.0 801.4 10404.7 10478.1 10495.8 10528.3 10543.9 10158.2 10277.6 10289.3 10291.8 10300.7 611.4 619.2 768.7 772.6 782.7 779.5 779.8 781.4 782.2 784.0 825.8 826.5 826.7 827.1 828.9 813.4 817.7 818.6 819.9 821.4 612.7 612.8 613.4 614.3 615.4 9867.7 9897.9 9900.9 9915.6 9991.8 11252.4 11588.7 11598.0 11752.1 12131.5 8791.2 8805.7 8864.8 8936.2 8937.4 3157.1 3206.8 3237.8 3276.0 3322.2 37864.0 37983.1 38098.2 38116.4 38226.4 8794.8 8844.1 9013.8 9249.6 9318.0 16391.4 16405.3 16427.2 16442.9 16448.3 5975.1 6002.7 6009.5 6084.0 6294.4 3485.1 3516.4 3587.8 3640.5 3663.7 2558.8 2582.4 2585.5 2586.5 2589.6 469.7 471.1 478.1 482.8 489.0 389.4 551.6 553.0 555.2 576.2 6756.4 6993.5 7140.2 7163.1 7275.2 457.9 469.9 553.7 568.5 577.3 3353.6 3391.7 3434.7 3464.4 3521.3 47093.5 47125.0 48766.8 48987.8 49189.5 39994.6 41183.4 41434.6 41457.2 41889.6 39356.0 39429.0 39483.6 39488.6 39528.6 6821.1 6962.3 6992.8 7093.7 7158.0 29759.7 30508.2 31340.4 31580.0 32216.7 36239.0 36564.8 37364.8 37451.3 37626.8 9382.1 9615.0 9618.7 9688.6 9733.4 10326.2 10911.5 11173.1 11184.4 11206.0 9748.3 9845.5 9849.4 9927.4 9935.5 9826.3 9926.8 9931.4 9934.4 9962.1 8840.9 9535.4 9597.2 9820.7 9878.3 8331.8 8390.4 8493.7 8516.2 8621.1 8366.8 8501.1 8539.4 8544.0 8801.5 05:24:41 INFO - PROCESS | 15296 | -------- Summary: end -------- 05:24:41 INFO - PROCESS | 15296 | 05:24:42 INFO - TEST-INFO | 15296: exit 0 05:24:42 INFO - TEST-OK | dromaeo_css | took 1114974ms 05:24:42 INFO - TEST-START | kraken 05:24:42 INFO - operating with platform_type : linux_ 05:24:42 INFO - Initialising browser for kraken test... 05:24:42 INFO - TEST-INFO | started process 15537 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKdGCrw/profile http://localhost:32800/getInfo.html) 05:24:46 INFO - PROCESS | 15537 | 05:24:46 INFO - PROCESS | 15537 | (process:15607): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:24:46 INFO - PROCESS | 15537 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 05:24:46 INFO - PROCESS | 15537 | __metrics Screen width/height:1600/1200 05:24:46 INFO - PROCESS | 15537 | colorDepth:24 05:24:46 INFO - PROCESS | 15537 | Browser inner width/height: 1024/697 05:24:46 INFO - PROCESS | 15537 | __metrics 05:24:46 INFO - PROCESS | 15537 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:24:47 INFO - TEST-INFO | 15537: exit 0 05:24:47 INFO - Browser initialized. 05:24:47 INFO - Running cycle 1/1 for kraken test... 05:24:47 INFO - TEST-INFO | started process 15656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKdGCrw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:49 INFO - PROCESS | 15656 | 05:24:49 INFO - PROCESS | 15656 | (process:15712): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:24:59 INFO - PROCESS | 15656 | RSS: Main: 150532096 05:24:59 INFO - PROCESS | 15656 | 05:25:02 INFO - PROCESS | 15656 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32800/tests/kraken/driver.html?testName=audio-beat-detection) 05:25:03 INFO - PROCESS | 15656 | RSS: Main: 150614016 05:25:03 INFO - PROCESS | 15656 | 05:25:05 INFO - PROCESS | 15656 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32800/tests/kraken/driver.html?testName=audio-dft) 05:25:06 INFO - PROCESS | 15656 | RSS: Main: 151089152 05:25:06 INFO - PROCESS | 15656 | 05:25:09 INFO - PROCESS | 15656 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32800/tests/kraken/driver.html?testName=audio-fft) 05:25:09 INFO - PROCESS | 15656 | RSS: Main: 146223104 05:25:09 INFO - PROCESS | 15656 | 05:25:12 INFO - PROCESS | 15656 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32800/tests/kraken/driver.html?testName=audio-oscillator) 05:25:12 INFO - PROCESS | 15656 | RSS: Main: 146419712 05:25:12 INFO - PROCESS | 15656 | 05:25:14 INFO - PROCESS | 15656 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32800/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:25:15 INFO - PROCESS | 15656 | RSS: Main: 147419136 05:25:15 INFO - PROCESS | 15656 | 05:25:18 INFO - PROCESS | 15656 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32800/tests/kraken/driver.html?testName=imaging-darkroom) 05:25:19 INFO - PROCESS | 15656 | RSS: Main: 147107840 05:25:19 INFO - PROCESS | 15656 | 05:25:22 INFO - PROCESS | 15656 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32800/tests/kraken/driver.html?testName=imaging-desaturate) 05:25:23 INFO - PROCESS | 15656 | RSS: Main: 148262912 05:25:23 INFO - PROCESS | 15656 | 05:25:26 INFO - PROCESS | 15656 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32800/tests/kraken/driver.html?testName=json-parse-financial) 05:25:26 INFO - PROCESS | 15656 | RSS: Main: 147734528 05:25:26 INFO - PROCESS | 15656 | 05:25:28 INFO - PROCESS | 15656 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32800/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:25:29 INFO - PROCESS | 15656 | RSS: Main: 149073920 05:25:29 INFO - PROCESS | 15656 | 05:25:30 INFO - PROCESS | 15656 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:25:31 INFO - PROCESS | 15656 | RSS: Main: 149340160 05:25:31 INFO - PROCESS | 15656 | 05:25:33 INFO - PROCESS | 15656 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:25:34 INFO - PROCESS | 15656 | RSS: Main: 149889024 05:25:34 INFO - PROCESS | 15656 | 05:25:36 INFO - PROCESS | 15656 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:25:37 INFO - PROCESS | 15656 | RSS: Main: 147918848 05:25:37 INFO - PROCESS | 15656 | 05:25:40 INFO - PROCESS | 15656 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:25:40 INFO - PROCESS | 15656 | RSS: Main: 149590016 05:25:40 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32800/tests/kraken/driver.html?testName=ai-astar) 05:25:42 INFO - PROCESS | 15656 | RSS: Main: 149913600 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | __start_tp_report 05:25:42 INFO - PROCESS | 15656 | _x_x_mozilla_page_load 05:25:42 INFO - PROCESS | 15656 | _x_x_mozilla_page_load_details 05:25:42 INFO - PROCESS | 15656 | |i|pagename|runs| 05:25:42 INFO - PROCESS | 15656 | |0;ai-astar;116;110;114;113;115;125;116;115;114;113 05:25:42 INFO - PROCESS | 15656 | |1;audio-beat-detection;169;139;159;178;143;158;162;141;170;135 05:25:42 INFO - PROCESS | 15656 | |2;audio-dft;163;162;165;164;162;165;171;162;165;164 05:25:42 INFO - PROCESS | 15656 | |3;audio-fft;74;74;73;75;151;73;72;73;72;154 05:25:42 INFO - PROCESS | 15656 | |4;audio-oscillator;97;97;137;101;100;99;138;98;98;133 05:25:42 INFO - PROCESS | 15656 | |5;imaging-gaussian-blur;110;110;110;110;110;110;109;109;111;111 05:25:42 INFO - PROCESS | 15656 | |6;imaging-darkroom;149;149;149;149;148;148;147;148;150;147 05:25:42 INFO - PROCESS | 15656 | |7;imaging-desaturate;96;96;98;97;96;96;96;96;96;96 05:25:42 INFO - PROCESS | 15656 | |8;json-parse-financial;71;69;69;72;70;69;70;83;70;68 05:25:42 INFO - PROCESS | 15656 | |9;json-stringify-tinderbox;68;68;68;68;68;67;68;74;67;68 05:25:42 INFO - PROCESS | 15656 | |10;stanford-crypto-aes;83;84;83;85;83;83;91;85;84;83 05:25:42 INFO - PROCESS | 15656 | |11;stanford-crypto-ccm;120;129;126;129;126;130;130;124;125;127 05:25:42 INFO - PROCESS | 15656 | |12;stanford-crypto-pbkdf2;136;148;139;166;150;148;153;152;155;150 05:25:42 INFO - PROCESS | 15656 | |13;stanford-crypto-sha256-iterative;72;71;72;69;71;70;71;70;70;70 05:25:42 INFO - PROCESS | 15656 | __end_tp_report 05:25:42 INFO - PROCESS | 15656 | __start_cc_report 05:25:42 INFO - PROCESS | 15656 | _x_x_mozilla_cycle_collect,801 05:25:42 INFO - PROCESS | 15656 | __end_cc_report 05:25:42 INFO - PROCESS | 15656 | __startTimestamp1452518742741__endTimestamp 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | ------- Summary: start ------- 05:25:42 INFO - PROCESS | 15656 | Number of tests: 14 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.00 stddev:3.90 (3.4%) stddev-sans-first:4.12 05:25:42 INFO - PROCESS | 15656 | Values: 116.0 110.0 114.0 113.0 115.0 125.0 116.0 115.0 114.0 113.0 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:160.50 stddev:14.98 (9.3%) stddev-sans-first:15.05 05:25:42 INFO - PROCESS | 15656 | Values: 169.0 139.0 159.0 178.0 143.0 158.0 162.0 141.0 170.0 135.0 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:2.67 (1.6%) stddev-sans-first:2.79 05:25:42 INFO - PROCESS | 15656 | Values: 163.0 162.0 165.0 164.0 162.0 165.0 171.0 162.0 165.0 164.0 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | [#3] audio-fft Cycles:10 Average:89.10 Median:73.00 stddev:33.43 (45.8%) stddev-sans-first:35.01 05:25:42 INFO - PROCESS | 15656 | Values: 74.0 74.0 73.0 75.0 151.0 73.0 72.0 73.0 72.0 154.0 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:97.00 stddev:18.16 (18.7%) stddev-sans-first:18.67 05:25:42 INFO - PROCESS | 15656 | Values: 97.0 97.0 137.0 101.0 100.0 99.0 138.0 98.0 98.0 133.0 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:25:42 INFO - PROCESS | 15656 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0 111.0 111.0 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 05:25:42 INFO - PROCESS | 15656 | Values: 149.0 149.0 149.0 149.0 148.0 148.0 147.0 148.0 150.0 147.0 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:25:42 INFO - PROCESS | 15656 | Values: 96.0 96.0 98.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | [#8] json-parse-financial Cycles:10 Average:71.10 Median:70.00 stddev:4.33 (6.2%) stddev-sans-first:4.59 05:25:42 INFO - PROCESS | 15656 | Values: 71.0 69.0 69.0 72.0 70.0 69.0 70.0 83.0 70.0 68.0 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.00 stddev:2.01 (3.0%) stddev-sans-first:2.13 05:25:42 INFO - PROCESS | 15656 | Values: 68.0 68.0 68.0 68.0 68.0 67.0 68.0 74.0 67.0 68.0 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.46 (2.9%) stddev-sans-first:2.55 05:25:42 INFO - PROCESS | 15656 | Values: 83.0 84.0 83.0 85.0 83.0 83.0 91.0 85.0 84.0 83.0 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:128.00 stddev:3.13 (2.4%) stddev-sans-first:2.24 05:25:42 INFO - PROCESS | 15656 | Values: 120.0 129.0 126.0 129.0 126.0 130.0 130.0 124.0 125.0 127.0 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.70 Median:151.00 stddev:8.29 (5.5%) stddev-sans-first:7.16 05:25:42 INFO - PROCESS | 15656 | Values: 136.0 148.0 139.0 166.0 150.0 148.0 153.0 152.0 155.0 150.0 05:25:42 INFO - PROCESS | 15656 | 05:25:42 INFO - PROCESS | 15656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:0.97 (1.4%) stddev-sans-first:0.88 05:25:42 INFO - PROCESS | 15656 | Values: 72.0 71.0 72.0 69.0 71.0 70.0 71.0 70.0 70.0 70.0 05:25:42 INFO - PROCESS | 15656 | -------- Summary: end -------- 05:25:42 INFO - PROCESS | 15656 | 05:25:43 INFO - TEST-INFO | 15656: exit 0 05:25:43 INFO - TEST-OK | kraken | took 61452ms 05:25:43 INFO - TEST-START | v8_7 05:25:43 INFO - operating with platform_type : linux_ 05:25:43 INFO - Initialising browser for v8_7 test... 05:25:43 INFO - TEST-INFO | started process 15940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprkNLGe/profile http://localhost:32800/getInfo.html) 05:25:47 INFO - PROCESS | 15940 | 05:25:47 INFO - PROCESS | 15940 | (process:16013): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:25:47 INFO - PROCESS | 15940 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 05:25:48 INFO - PROCESS | 15940 | __metrics Screen width/height:1600/1200 05:25:48 INFO - PROCESS | 15940 | colorDepth:24 05:25:48 INFO - PROCESS | 15940 | Browser inner width/height: 1024/697 05:25:48 INFO - PROCESS | 15940 | __metrics 05:25:48 INFO - PROCESS | 15940 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:25:49 INFO - TEST-INFO | 15940: exit 0 05:25:49 INFO - Browser initialized. 05:25:49 INFO - Running cycle 1/1 for v8_7 test... 05:25:49 INFO - TEST-INFO | started process 16062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprkNLGe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:50 INFO - PROCESS | 16062 | 05:25:50 INFO - PROCESS | 16062 | (process:16122): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:26:01 INFO - PROCESS | 16062 | RSS: Main: 150609920 05:26:01 INFO - PROCESS | 16062 | 05:26:23 INFO - PROCESS | 16062 | Cycle 1(1): loaded http://localhost:32800/tests/v8_7/run.html (next: http://localhost:32800/tests/v8_7/run.html) 05:26:24 INFO - PROCESS | 16062 | RSS: Main: 145997824 05:26:24 INFO - PROCESS | 16062 | 05:26:24 INFO - PROCESS | 16062 | __start_tp_report 05:26:24 INFO - PROCESS | 16062 | _x_x_mozilla_page_load 05:26:24 INFO - PROCESS | 16062 | _x_x_mozilla_page_load_details 05:26:24 INFO - PROCESS | 16062 | |i|pagename|runs| 05:26:24 INFO - PROCESS | 16062 | |0;Richards;170.38677798602828 05:26:24 INFO - PROCESS | 16062 | |1;DeltaBlue;186.67164457718872 05:26:24 INFO - PROCESS | 16062 | |2;Encrypt;278.31895352073474 05:26:24 INFO - PROCESS | 16062 | |3;Decrypt;5256.544502617801 05:26:24 INFO - PROCESS | 16062 | |4;RayTrace;1077.5862068965516 05:26:24 INFO - PROCESS | 16062 | |5;Earley;711.7437722419929 05:26:24 INFO - PROCESS | 16062 | |6;Boyer;12370.37037037037 05:26:24 INFO - PROCESS | 16062 | |7;RegExp;43829.78723404255 05:26:24 INFO - PROCESS | 16062 | |8;Splay;603.5003017501509 05:26:24 INFO - PROCESS | 16062 | |9;NavierStokes;4835.748792270531 05:26:24 INFO - PROCESS | 16062 | __end_tp_report 05:26:24 INFO - PROCESS | 16062 | __startTimestamp1452518784012__endTimestamp 05:26:24 INFO - PROCESS | 16062 | 05:26:24 INFO - PROCESS | 16062 | ------- Summary: start ------- 05:26:24 INFO - PROCESS | 16062 | Number of tests: 10 05:26:24 INFO - PROCESS | 16062 | 05:26:24 INFO - PROCESS | 16062 | [#0] Richards Cycles:1 Average:170.39 Median:170.39 stddev:0.00 (0.0%) 05:26:24 INFO - PROCESS | 16062 | Values: 170.4 05:26:24 INFO - PROCESS | 16062 | 05:26:24 INFO - PROCESS | 16062 | [#1] DeltaBlue Cycles:1 Average:186.67 Median:186.67 stddev:0.00 (0.0%) 05:26:24 INFO - PROCESS | 16062 | Values: 186.7 05:26:24 INFO - PROCESS | 16062 | 05:26:24 INFO - PROCESS | 16062 | [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 05:26:24 INFO - PROCESS | 16062 | Values: 278.3 05:26:24 INFO - PROCESS | 16062 | 05:26:24 INFO - PROCESS | 16062 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 05:26:24 INFO - PROCESS | 16062 | Values: 5256.5 05:26:24 INFO - PROCESS | 16062 | 05:26:24 INFO - PROCESS | 16062 | [#4] RayTrace Cycles:1 Average:1077.59 Median:1077.59 stddev:0.00 (0.0%) 05:26:24 INFO - PROCESS | 16062 | Values: 1077.6 05:26:24 INFO - PROCESS | 16062 | 05:26:24 INFO - PROCESS | 16062 | [#5] Earley Cycles:1 Average:711.74 Median:711.74 stddev:0.00 (0.0%) 05:26:24 INFO - PROCESS | 16062 | Values: 711.7 05:26:24 INFO - PROCESS | 16062 | 05:26:24 INFO - PROCESS | 16062 | [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 05:26:24 INFO - PROCESS | 16062 | Values: 12370.4 05:26:24 INFO - PROCESS | 16062 | 05:26:24 INFO - PROCESS | 16062 | [#7] RegExp Cycles:1 Average:43829.79 Median:43829.79 stddev:0.00 (0.0%) 05:26:24 INFO - PROCESS | 16062 | Values: 43829.8 05:26:24 INFO - PROCESS | 16062 | 05:26:24 INFO - PROCESS | 16062 | [#8] Splay Cycles:1 Average:603.50 Median:603.50 stddev:0.00 (0.0%) 05:26:24 INFO - PROCESS | 16062 | Values: 603.5 05:26:24 INFO - PROCESS | 16062 | 05:26:24 INFO - PROCESS | 16062 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 05:26:24 INFO - PROCESS | 16062 | Values: 4835.7 05:26:24 INFO - PROCESS | 16062 | -------- Summary: end -------- 05:26:24 INFO - PROCESS | 16062 | 05:26:24 INFO - TEST-INFO | 16062: exit 0 05:26:24 INFO - TEST-OK | v8_7 | took 41150ms 05:26:24 INFO - SUITE-END | took 1217s 05:26:25 INFO - Completed test suite (00:20:17) 05:26:25 INFO - Working with test: dromaeo_css 05:26:25 INFO - Generating results file: dromaeo_css 05:26:25 INFO - Working with test: kraken 05:26:25 INFO - Generating results file: kraken 05:26:25 INFO - javascript benchmark 05:26:25 INFO - Working with test: v8_7 05:26:25 INFO - Generating results file: v8_7 05:26:25 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:26:25 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 05:26:25 INFO - process_Request line: dromaeo_css 6216.93 graph.html#tests=[[72,132,43]] 05:26:25 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:26:25 INFO - process_Request line: kraken 1559.20 graph.html#tests=[[232,132,43]] 05:26:25 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:26:25 INFO - process_Request line: v8_7 20185.46 graph.html#tests=[[230,132,43]] 05:26:25 INFO - RETURN: dromaeo_css: 6216.93 05:26:25 INFO - RETURN: kraken: 1559.20 05:26:25 INFO - RETURN: v8_7: 20185.46 05:26:25 INFO - javascript benchmark 05:26:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2651.8674066296685, 2721.809473336867, 2740.0, 2759.365345970427, 2760.5859121131834, 4642.86071417858, 4827.879303017422, 4834.395700537433, 4848.393950756151, 4853.660243782932, 4644.0, 4656.650751193657, 4692.601128904047, 4728.40894888139, 4791.257355109955, 4344.913101737971, 4366.257736184841, 4408.691391602589, 4425.269830477983, 4426.136903303857, 4380.34294855771, 4394.143142087294, 4442.2004039272915, 4448.688591798559, 4479.126570318789, 4258.680598955075, 4325.675574331937, 4377.890552736207, 4396.736195828261, 4422.491413487458, 4337.8481753138485, 4373.562643735633, 4387.561243875619, 4393.978030109829, 4423.535528769497, 4224.66202703783, 4360.062586543908, 4369.213541562517, 4390.714603550759, 4409.845655402078, 4516.525764794715, 4527.818887244506, 4584.931226031612, 4628.560286772751, 4630.328602352673, 5115.104856650109, 5130.461301563357, 5131.3329267195395, 5132.153194722903, 5160.0, 4962.677425967337, 5085.593152547787, 5153.175491921312, 5165.767540460688, 5220.451852555503, 4635.258358662598, 4682.81268749253, 4689.7655117244, 4703.741294228782, 4750.95249047512, 5219.321488206509, 5220.321358223407, 5226.581873450191, 5228.895422091613, 5263.34208223972, 4871.878203044952, 4919.458859525449, 4965.82619608312, 5013.949860501349, 5060.84817455477, 5151.9484805152215, 5168.302279192336, 5169.405518365361, 5181.300524429229, 5187.559057480081, 5050.318207042076, 5092.668976516515, 5110.97444512775, 5112.514311140436, 5174.637775355689, 4882.707037577757, 4970.90058198834, 5002.09962206799, 5008.12357837377, 5030.89938201234, 4180.080382315886, 4259.467566554181, 4277.272863613193, 4291.699581029298, 4327.831485498898, 3767.4913886624954, 3786.450964610116, 3795.981020094882, 3819.7899115548357, 3819.8854034379015, 4320.589543993316, 4402.713823601455, 4424.31423129409, 4429.180601588717, 4477.932831007537, 5004.424491183488, 5067.214581739836, 5068.569171620454, 5090.261912022736, 5108.489151084862, 4400.141972315432, 4413.337999300131, 4425.712328698624, 4470.508244093147, 4481.1709833680225, 4373.75944323059, 4452.577005184502, 4499.6400287976885, 4551.112533056088, 4602.217623004098, 4850.975745121252, 4864.756762161877, 4872.025594881109, 4878.902421951612, 4916.655834091579, 5146.408163061295, 5147.639665223398, 5148.562372198256, 5149.176131818891, 5149.304843846033, 4706.835260765857, 4745.217039188633, 4810.230363141881, 4857.635677324144, 4887.60899128076, 5115.64190506661, 5124.0, 5141.25451809493, 5148.459411761711, 5193.584513239008, 5202.97398513005, 5219.582433405394, 5223.2948551945, 5224.477552244897, 5224.52979231871, 4840.104580652591, 4896.877578060577, 4935.777889995031, 4950.282209079735, 4977.278294647183, 4927.852164435073, 4963.230699241623, 4964.67729597575, 4967.0, 5014.648974571745, 4693.436787585375, 4860.78126484302, 4869.269609558594, 4876.756162191805, 4888.071266459361, 4933.136701077369, 4973.602111830973, 5016.398032236155, 5031.823886163967, 5089.3638295213095, 4935.950640493693, 4956.8760780980765, 4964.578010869117, 4967.9006419870675, 4971.6022718183185], "unit": "score", "name": "dojo.html", "value": 4680.743270502523}, {"lowerIsBetter": false, "replicates": [461.20902651951894, 472.8817795551112, 491.4839418610458, 494.03662857428026, 500.712090547935, 30778.84610576947, 31429.371412571763, 31700.0, 31717.0, 31779.0, 32354.67645323546, 32395.67604323956, 32730.83634581824, 32748.508772368434, 32827.17932051694, 7433.070866141746, 7656.196099409565, 7658.195889431613, 7659.774436090227, 7670.884936725954, 7434.0, 7639.19788422216, 7641.388688904902, 7644.388448924101, 7655.157932627407, 7605.581693006882, 7700.845983080335, 7705.922940770577, 7712.383009359266, 7725.0, 7745.728899488519, 7772.378209743207, 7775.105862825734, 7776.30013298803, 7787.4938129022, 7444.106707195117, 7647.961760191163, 7658.081030276402, 7659.578723170223, 7671.0, 33229.50155747666, 33712.49431258533, 33713.15717107092, 33720.15699607505, 33731.32537349239, 2885.653721553427, 2984.328526081636, 3026.5914101596222, 3411.0619579615554, 3682.2819550187724, 26938.326541836414, 27112.0, 27214.591781123298, 27468.17595472139, 27731.306717332027, 3132.592762940803, 3265.673432656739, 3272.885449009297, 3318.1372843060735, 3379.3410284994434, 218377.0, 219120.9999999984, 219444.0, 219867.0, 220056.0, 45507.31739023917, 46489.5351046492, 52339.73830130825, 52475.47524524782, 52895.735521322145, 56539.0, 57711.13433298504, 58092.0, 58202.41797582055, 58277.70861145752, 12569.622911312676, 12717.427715752814, 12739.872601273868, 12745.0, 12779.041571882146, 10068.496575171212, 10089.192864570818, 10096.949515252376, 10103.242256830767, 10112.494375281207, 17172.31310747581, 17328.82671173272, 17402.47792566225, 18040.458786236435, 18111.818881811276, 7052.612106334201, 7187.184586327069, 7228.783136505913, 7263.745768898063, 7327.74352897646, 816.8938038055015, 856.2379482260793, 863.2877875752529, 940.971770846862, 1017.862588550551, 26343.604845927326, 26422.207333780018, 26557.468850622878, 26558.46883062328, 26907.596386054225, 915.6749353979375, 924.9213816825511, 942.5758408716105, 947.228009172536, 960.5293406231036, 13633.863661363259, 13673.384697688627, 14076.085054471427, 14097.506587269396, 14107.224102674452, 251448.0, 256418.0, 257999.0, 258041.0, 258931.7053414721, 45095.0, 45333.54666453359, 45388.0, 45548.54451455509, 45580.54419455763, 1184.603157942099, 1190.5773450424974, 1191.255465334166, 1216.0271782574082, 1223.85925618555, 25269.24192274235, 25883.61174582345, 25934.35164120912, 26015.0, 26402.603960940218, 39823.402648960866, 40093.0, 40532.59467405288, 40542.39186412147, 40558.1888362237, 186965.0, 189205.0, 189389.0, 236720.0, 237065.0, 24180.879095605113, 24751.886165122974, 28387.574186387636, 28434.28914277077, 29285.121446356643, 33357.33285334328, 33523.653344265666, 33757.493637595944, 34023.48964765481, 34424.31151377009, 28406.715932841234, 29007.41985160327, 29266.268343291587, 29304.0, 29477.410451790416, 30769.846150769103, 30849.228769280948, 31326.686733132377, 31503.212419688774, 31704.731810727313, 31218.687813121578, 31420.214494637818, 31756.682433175374, 31810.840945795124, 31846.363072738877, 27867.303317417227, 29103.41793164167, 29429.705702943553, 30196.396072077994, 31246.531302030944, 22288.665670014638, 22547.774522254567, 22628.66057009179, 22949.426264343525, 23026.654600181344], "unit": "score", "name": "ext.html", "value": 15988.331572030269}, {"lowerIsBetter": false, "replicates": [327.55125478095016, 327.80987027524037, 331.7810245238143, 333.7280116704885, 334.2712885908718, 14426.278686065694, 14780.556583302505, 15065.548033558984, 15136.318865651045, 15867.444639437623, 9886.505674716253, 9994.400335979828, 12076.396180190999, 14753.557393278219, 14818.259087045659, 4290.742555446684, 4497.14554234696, 4509.053098849229, 5003.2995380646735, 5227.764750586214, 5081.339425874631, 5126.000429916168, 5127.538521533062, 5131.1277082895995, 5140.691558506502, 5132.923006154911, 6187.907181392283, 6252.874942501147, 6398.16823812906, 6446.097546343516, 6278.0, 6439.517036222279, 6443.065755465478, 6492.837679058038, 6528.902066469007, 6269.811905642838, 6270.247570291549, 6272.65500397478, 6276.3409841966395, 6285.497160227171, 19820.207191712314, 20233.79766202334, 20279.89860050705, 20419.489512762153, 20956.0, 1765.7704498415253, 1777.7688900442859, 1839.2275244397385, 1856.5265857206462, 1865.253898440621, 12574.937125314407, 13342.466301348031, 13626.727465450735, 13646.229922108561, 13698.041137120406, 1826.1234607388394, 1835.2934120363623, 1876.6715824730754, 1896.9810301896941, 1899.886006839594, 53169.46830531684, 53548.99356898771, 54944.72527637336, 56296.43703562994, 57405.0, 14724.33740481681, 14786.260686965608, 14806.333714982851, 14827.851721482863, 14869.479568215276, 21815.563688726455, 21903.561928761337, 21914.342569722932, 21944.561108777736, 21984.780152198593, 8405.663773449116, 8455.49267043967, 8478.23695867375, 8506.532140732319, 8549.444286121383, 7087.0786797717, 7103.609301488468, 7134.036905017756, 7134.964325178341, 7138.25048369924, 7350.7427240046345, 7358.374538164209, 7391.926080739231, 7433.442491813135, 7495.962520187364, 1736.574539237895, 3060.617422822147, 3101.457244982119, 3128.9687103128676, 3134.3887941851576, 376.61208954776623, 764.3770327183328, 822.2640736540762, 827.8509868223778, 833.4749108061882, 9312.72061838146, 9707.9029209707, 9840.16358609512, 9907.356021858555, 9923.40459572428, 405.5538907202113, 414.06421487438007, 416.9992019153994, 425.10091157202294, 426.94663167104113, 5237.6333656643665, 5329.413764485904, 5399.4600539945695, 5477.096279113902, 5503.091989821714, 457092.0, 461038.0, 472244.0, 476288.0, 478535.0, 63286.6835665828, 63986.0, 64744.0, 65026.0, 66231.66884165548, 447.7403106198397, 447.75149791865175, 447.91489616973325, 449.3596624809633, 455.1125305653988, 8792.065355884624, 9028.413153145024, 9175.632974680939, 9189.586468609063, 9307.813843723223, 27657.0, 27759.167224983285, 28640.427191455638, 28793.85603071971, 29279.85360073186, 35932.64067359293, 36638.8168059158, 37594.43608345932, 38429.231415370974, 40099.198016038936, 6365.363463653597, 6602.0, 6619.304972977768, 6670.9332906670315, 6853.725850965906, 9334.0, 9876.061774131445, 9936.403815771077, 10346.32748871321, 10400.27198096126, 6654.334566543307, 7391.556506609621, 8201.22088401601, 8737.475751454678, 8883.37816352849, 8839.381243313164, 8953.537777111347, 9177.678781242625, 9217.308701847254, 9256.398334108262, 8972.820543589221, 9023.0, 9278.675246366345, 9295.67465138717, 9331.298377835514, 6768.9661551691925, 6984.720611175496, 7016.087908571853, 7068.858622827617, 7151.4278857690215, 8028.83942321162, 8278.254957053654, 8295.419320647738, 8392.496450212762, 8518.91481085206], "unit": "score", "name": "jquery.html", "value": 7555.357592037317}, {"lowerIsBetter": false, "replicates": [1388.6250712307676, 1423.9003269771113, 1519.240379810095, 1732.5668582854287, 1740.3560682547459, 6231.968840155804, 6358.554901156909, 7139.750108746195, 7265.418766498688, 7281.672324745386, 7011.544249623784, 7171.426285897129, 7226.024486694295, 7234.49358544902, 7235.855282894339, 2089.028601700209, 2113.894305284737, 2118.1315660579166, 2120.4592828828627, 2121.1833444124045, 2010.175827910557, 2023.2210598919448, 2027.0, 2090.0385822521657, 2118.692789545523, 2041.050911326233, 2128.294084316627, 2133.28534940795, 2135.9679604805942, 2143.9923236079017, 2129.840261980358, 2135.9359219223447, 2142.6571748520164, 2143.453419378064, 2148.301801914384, 1978.277928556081, 2001.0695026812457, 2030.4416285521452, 2047.7133201351824, 2050.630886440455, 7288.781336559911, 7331.450141239375, 7385.593792341419, 7389.482736208468, 7393.07586551681, 4287.871363859089, 4384.583464570861, 4401.141777353418, 4402.691811573191, 4403.097365040159, 2767.750902418792, 2837.7729781617422, 2877.6978417266096, 2895.3774938388347, 2899.5795609636693, 869.2871845087031, 883.4875772052194, 901.5627420700955, 910.0353625157288, 914.4330515080626, 9973.900260997443, 10090.9495452523, 10115.49422528878, 10124.645637402655, 10163.034511721375, 3971.62269584389, 4006.579309172553, 4061.7156799023783, 4145.2952997990415, 4147.543770185277, 8807.867881981776, 8831.337649676172, 8846.46921184731, 8846.690365837294, 8857.37998340123, 4438.045820148684, 4446.62203712688, 4452.910941781146, 4455.933161002587, 4465.173942820588, 3383.6954674078956, 3452.4476083826466, 3929.9017524562114, 4060.878173654795, 4065.288574499451, 3515.6835884770494, 3522.0, 3550.201204728967, 3561.1809283864854, 3568.125809176768, 1126.7352172239516, 1166.5100657723776, 1173.12015988009, 1173.2960223865612, 1178.7288923547633, 893.4192774696369, 915.9175674189355, 1172.8299396587447, 1181.5037684172669, 1191.3923898811668, 6795.082663840417, 6845.0759147514445, 6852.554583952126, 6852.623105729133, 6897.068895699117, 1028.321307936758, 1056.6829951014665, 1072.3405105859997, 1075.6020272499225, 1102.6251074634663, 5447.0, 5466.699331536804, 5488.69812160335, 5505.311836020497, 5508.118701007819, 8439.620217090245, 8672.78318042054, 8710.172533609297, 8832.38173327861, 8849.159329863653, 8628.22345988864, 8631.482111073356, 8659.350548708746, 8688.044315125331, 8714.825703485894, 6667.966660166765, 6822.488313376417, 6898.206706228848, 6935.618540980194, 7020.05229294049, 6663.900041499478, 6731.899021514583, 6770.356816102462, 6786.626735529593, 6789.524733268624, 7706.460547761603, 7873.448858579844, 7905.0, 7909.802254943443, 7949.1255961843, 7858.803529911569, 8186.181381861767, 8208.548529830916, 8223.342132629496, 8394.37042221848, 5472.589555783253, 6245.28179259391, 6384.201974753156, 6454.515911306765, 6522.119513865568, 7002.089728335284, 7011.3339232772805, 7017.368436840505, 7026.8756998879935, 7049.224585295716, 6407.199100112486, 6535.705893234911, 6558.213014438107, 6578.440832529289, 6813.3527314905, 6613.074169616354, 6729.125213722381, 6750.45996320303, 6840.2817704142335, 6858.41703455192, 6539.346065393423, 6560.540762146604, 6584.045313429621, 6605.5376123670885, 6609.504287178384, 6078.179445774764, 6271.310155882758, 6277.843053923689, 6292.842678933063, 6325.936740632535, 6033.366496517802, 6066.545009124245, 6073.331933487401, 6080.574359794772, 6107.144999700135], "unit": "score", "name": "mootools.html", "value": 4209.329578617459}, {"lowerIsBetter": false, "replicates": [308.66047347917294, 313.3404184192274, 314.95748074010015, 315.13652591898204, 321.07690390128374, 5513.917291240635, 5632.662040277576, 5704.885902281957, 5740.368559458461, 5792.391798861122, 5647.519960803326, 5690.9146362804595, 5699.487046165844, 5708.628939118955, 5715.571332150084, 4357.433533640638, 4360.80376383062, 4362.585554372329, 4366.497852746935, 4368.825246990116, 4355.956440435587, 4357.847475338363, 4371.344298355256, 4373.365861950016, 4379.824807007716, 4121.505419349683, 4230.111676547913, 4253.1493701259715, 4272.230998420283, 4276.144771045803, 4238.321868501041, 4280.4221430106845, 4296.291111966521, 4301.3117901135665, 4322.243607368698, 3735.8505659773577, 3738.1589142443004, 3738.5700644425697, 3740.4576336431337, 3746.3631182699005, 5394.7842086316505, 5403.2705584746345, 5404.729763511808, 5408.567314614821, 5410.621256512046, 4775.3286349777645, 4833.830815921461, 4992.6754760940785, 5000.549950504435, 5002.874928126789, 5819.039858423355, 5826.941730582725, 5832.737526811261, 5834.824955251349, 5943.167956486095, 4088.795560221977, 4094.447249621293, 4097.426360309559, 4104.056067104582, 4105.97947010266, 6220.222472190976, 6273.592216505913, 6291.307956124822, 6292.62244265341, 6293.402126797947, 4130.153318569686, 4167.291560434734, 4211.0946146578635, 4211.642010429148, 4228.048689045002, 4243.384709217208, 4250.23495770758, 4257.127288905767, 4264.402983582301, 4269.338252570857, 4959.851204463872, 4961.957988822315, 4963.131451995886, 4968.205087186033, 4981.327520784647, 5941.405859414111, 5990.880182396328, 5996.340402555716, 6006.159137720635, 6011.789587364508, 1462.4881291548086, 1497.7304085264539, 1514.447226762246, 1522.3910435825537, 1522.9010114342532, 1002.2433063037361, 1007.2596641468515, 1009.9848502272472, 1011.3729487717662, 1018.3940555369692, 5125.641205115606, 5125.769340379692, 5146.845594632167, 5148.510891465305, 5157.4584668610005, 6120.785772497941, 6130.356312587203, 6146.4775494082605, 6162.044883043135, 6164.845878853064, 5132.153194722903, 5147.1507201312115, 5186.714730689773, 5190.97404512975, 5200.271961925334, 3274.9345013099605, 3289.901302960915, 3314.734821214345, 3389.610324721066, 3393.1347506385714, 5912.46787789101, 5915.733791979371, 5920.881582368328, 5922.733476993546, 5925.081612350093, 6470.352964703492, 6479.6760161991715, 6483.7730679425995, 6497.317781632955, 6500.187476565429, 5739.196512488172, 5885.529157667376, 5898.882022359443, 5901.852453688606, 5906.852328691645, 6280.057991301342, 6300.558960872695, 6303.9684801575695, 6312.337204593451, 6328.683565821782, 6121.84695382619, 6142.508599311955, 6149.385061493815, 6153.292371377349, 6156.107364432043, 5697.088465845445, 5828.154917537018, 5878.559108066826, 5890.941090589211, 5903.2325797646035, 4157.771322577288, 4199.265128602544, 4201.075763332062, 4209.200251952119, 4210.81051352696, 6239.78160764371, 6279.874402512016, 6281.59169653971, 6291.370862913672, 6304.842378940563, 5939.881202375842, 6040.818775436744, 6043.758249669964, 6052.394760523913, 6056.152138700498, 5964.194833697396, 5994.370591088047, 6019.819405417845, 6044.365341639064, 6044.84887877789, 5903.822885313448, 5904.439078287556, 5931.9110213345975, 5940.376260492759, 5942.58401911862, 6078.817635470943, 6082.300535438481, 6084.9959756639655, 6086.421789929949, 6103.694815259308, 5760.683162426107, 5921.319048309328, 5928.584999050025, 5935.169076329404, 5935.673537955454], "unit": "score", "name": "prototype.html", "value": 4460.928466539758}, {"lowerIsBetter": false, "replicates": [773.6441237030965, 777.5062835099714, 777.6461709921984, 788.972385966491, 801.3509057663291, 10404.739881502966, 10478.05697487226, 10495.79008419833, 10528.315659482128, 10543.947280263597, 10158.1873450124, 10277.640282590111, 10289.279750417474, 10291.794164116713, 10300.690979270616, 611.3641812514979, 619.2105066040789, 768.7002069193019, 772.5982489105662, 782.6673663692936, 779.4894344204555, 779.8206412525122, 781.3749000799367, 782.2099679323895, 783.9964844998411, 825.793551612097, 826.4793180296435, 826.7478419082178, 827.0736774812189, 828.888100106487, 813.4062134641745, 817.7301490508119, 818.5907046476761, 819.9057108432518, 821.36344333142, 612.6967151260154, 612.7947137708873, 613.3896772711137, 614.2874265851591, 615.3630991923383, 9867.703968880873, 9897.851532227023, 9900.90099099007, 9915.553800079013, 9991.75020624483, 11252.43737813106, 11588.710282243012, 11598.0, 11752.059835213162, 12131.454084566216, 8791.208791208823, 8805.69180078694, 8864.760789412316, 8936.195742383152, 8937.374383793138, 3157.1002264354547, 3206.8236247006407, 3237.838108094609, 3276.0, 3322.1694576355912, 37864.0, 37983.050423739354, 38098.23803523914, 38116.42825357622, 38226.426603600965, 8794.780130496662, 8844.128318781679, 9013.77465563353, 9249.583768730423, 9317.953410232905, 16391.42630007968, 16405.343786248417, 16427.178641067898, 16442.917785411235, 16448.34206631745, 5975.133605627159, 6002.669853158118, 6009.519238460913, 6084.0, 6294.402031806971, 3485.0764547394456, 3516.3919795323436, 3587.802670853076, 3640.4539319102346, 3663.7435379523176, 2558.7825034872244, 2582.4447743735186, 2585.4699786543715, 2586.495633351516, 2589.6374507568958, 469.6970454057114, 471.1284124369888, 478.1178725251905, 482.78998635593626, 488.97555122243745, 389.4454356303009, 551.6441894977797, 552.9612927095064, 555.1977392667557, 576.1862804304587, 6756.3919247266995, 6993.510454268254, 7140.214576396592, 7163.1404231491515, 7275.236100209508, 457.8969731810316, 469.8613908896884, 553.7120697237414, 568.4968802609637, 577.2985822226016, 3353.5808023997, 3391.7286617070577, 3434.690877821008, 3464.37641224582, 3521.3133438979153, 47093.5290647096, 47125.0, 48766.75616621894, 48987.75506122447, 49189.50810491921, 39994.600053999086, 41183.38224926629, 41434.58565414367, 41457.1708565827, 41889.58110418918, 39356.0, 39429.0, 39483.60516394857, 39488.60511394849, 39528.60471395249, 6821.069769288955, 6962.268961758942, 6992.755253566101, 7093.716251349888, 7158.0, 29759.70240297656, 30508.237294067825, 31340.373192536477, 31580.0, 32216.67783322137, 36239.0, 36564.81717591395, 37364.813175933945, 37451.250974980896, 37626.81186594159, 9382.061793820563, 9614.95192524033, 9618.663346783109, 9688.5640146195, 9733.415995040037, 10326.225533085199, 10911.454427278763, 11173.106151508022, 11184.440777960906, 11206.0, 9748.317617766688, 9845.458499782295, 9849.359791613522, 9927.354721943051, 9935.503224838874, 9826.263030272616, 9926.751831204278, 9931.404115753077, 9934.354266972623, 9962.103410693073, 8840.867386989328, 9535.427874327563, 9597.184239339735, 9820.705378838646, 9878.25913056538, 8331.791705207419, 8390.370722195737, 8493.745187644381, 8516.190961858614, 8621.13788621158, 8366.83266334682, 8501.10738372462, 8539.359548033797, 8544.0, 8801.51591662439], "unit": "score", "name": "yui.html", "value": 5437.559267698654}], "name": "dromaeo_css", "value": 6216.925219102914}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 110.0, 114.0, 113.0, 115.0, 125.0, 116.0, 115.0, 114.0, 113.0], "unit": "score", "name": "ai-astar", "value": 115.1}, {"lowerIsBetter": true, "replicates": [169.0, 139.0, 159.0, 178.0, 143.0, 158.0, 162.0, 141.0, 170.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 155.4}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 165.0, 164.0, 162.0, 165.0, 171.0, 162.0, 165.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 73.0, 75.0, 151.0, 73.0, 72.0, 73.0, 72.0, 154.0], "unit": "score", "name": "audio-fft", "value": 89.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 137.0, 101.0, 100.0, 99.0, 138.0, 98.0, 98.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 111.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [149.0, 149.0, 149.0, 149.0, 148.0, 148.0, 147.0, 148.0, 150.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 98.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 69.0, 72.0, 70.0, 69.0, 70.0, 83.0, 70.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 71.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 74.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 85.0, 83.0, 83.0, 91.0, 85.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [120.0, 129.0, 126.0, 129.0, 126.0, 130.0, 130.0, 124.0, 125.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [136.0, 148.0, 139.0, 166.0, 150.0, 148.0, 153.0, 152.0, 155.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.7}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 69.0, 71.0, 70.0, 71.0, 70.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1559.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.38677798602828], "unit": "score", "name": "Richards", "value": 207.18743799999993}, {"lowerIsBetter": false, "replicates": [186.67164457718872], "unit": "score", "name": "DeltaBlue", "value": 354.19412600000015}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1077.5862068965516], "unit": "score", "name": "RayTrace", "value": 686.7097920000001}, {"lowerIsBetter": false, "replicates": [711.7437722419929], "unit": "score", "name": "Earley", "value": 936.3805150000001}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [43829.78723404255], "unit": "score", "name": "RegExp", "value": 20.784609223300983}, {"lowerIsBetter": false, "replicates": [603.5003017501509], "unit": "score", "name": "Splay", "value": 135.030587}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20185.46190583998}]} 05:26:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20185.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1559.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6216.93"}}} 05:26:25 INFO - Return code: 0 05:26:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:26:25 INFO - # TBPL SUCCESS # 05:26:25 INFO - Running post-action listener: _resource_record_post_action 05:26:25 INFO - Running post-run listener: _resource_record_post_run 05:26:26 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 535789568; Read time: 0; Write time: 408756 05:26:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 119476224; Read time: 0; Write time: 104292 05:26:26 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 318889984; Read time: 0; Write time: 222216 05:26:26 INFO - Running post-run listener: _upload_blobber_files 05:26:26 INFO - Blob upload gear active. 05:26:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:26:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:26:26 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'] 05:26:26 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 05:26:26 INFO - (blobuploader) - INFO - Open directory for files ... 05:26:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:26:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:26:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:27 INFO - (blobuploader) - INFO - Done attempting. 05:26:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:26:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:26:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:28 INFO - (blobuploader) - INFO - Done attempting. 05:26:28 INFO - (blobuploader) - INFO - Iteration through files over. 05:26:28 INFO - Return code: 0 05:26:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:26:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:26:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/065bcb8fc432c417bb9e93b6447700a094f1394c953c49636dc5b806d613ad8cf42746f1264c80f76cb5c72da9aa29221dcd515c0821d3e588c8f64574890b35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29b08a2777a3663a508de5e386f4b91c199193d765d6de7d4041b7166969212eddb635d60b7f1f4cb4f91e7c6d114fb244d9e23d47fbc1382092a8a66e27bbce"} 05:26:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:26:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:26:28 INFO - Contents: 05:26:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/065bcb8fc432c417bb9e93b6447700a094f1394c953c49636dc5b806d613ad8cf42746f1264c80f76cb5c72da9aa29221dcd515c0821d3e588c8f64574890b35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29b08a2777a3663a508de5e386f4b91c199193d765d6de7d4041b7166969212eddb635d60b7f1f4cb4f91e7c6d114fb244d9e23d47fbc1382092a8a66e27bbce"} 05:26:28 INFO - Copying logs to upload dir... 05:26:28 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.579625 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-11 05:26:28.440523) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 05:26:28.444229) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324 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/065bcb8fc432c417bb9e93b6447700a094f1394c953c49636dc5b806d613ad8cf42746f1264c80f76cb5c72da9aa29221dcd515c0821d3e588c8f64574890b35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29b08a2777a3663a508de5e386f4b91c199193d765d6de7d4041b7166969212eddb635d60b7f1f4cb4f91e7c6d114fb244d9e23d47fbc1382092a8a66e27bbce"} build_url:https://queue.taskcluster.net/v1/task/DeCfVW7tQz6RQWVb2PoM3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/DeCfVW7tQz6RQWVb2PoM3w/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/065bcb8fc432c417bb9e93b6447700a094f1394c953c49636dc5b806d613ad8cf42746f1264c80f76cb5c72da9aa29221dcd515c0821d3e588c8f64574890b35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29b08a2777a3663a508de5e386f4b91c199193d765d6de7d4041b7166969212eddb635d60b7f1f4cb4f91e7c6d114fb244d9e23d47fbc1382092a8a66e27bbce"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 05:26:28.468808) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:26:28.469133) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452517502.905202-1667128324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 05:26:28.551659) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 05:26:28.551980) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 05:26:28.552333) ========= ========= Total master_lag: 0.22 =========